{"level":"warn","ts":"2026-06-24T10:57:43.138759Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T10:57:43.138851Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-24T10:57:43.13892Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-24T10:57:43.138936Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-06-24T10:57:43.138952Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T10:57:43.139551Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-06-24T10:57:43.139616Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-24T10:57:43.145205Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.377365ms"} {"level":"info","ts":"2026-06-24T10:57:43.157229Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-06-24T10:57:43.157319Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T10:57:43.157346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-06-24T10:57:43.15737Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T10:57:43.157402Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-06-24T10:57:43.157457Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-06-24T10:57:43.167988Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T10:57:43.171038Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T10:57:43.172707Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-24T10:57:43.176623Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T10:57:43.176964Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T10:57:43.177199Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T10:57:43.177286Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T10:57:43.17731Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-24T10:57:43.17799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-06-24T10:57:43.178274Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-06-24T10:57:43.179273Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-24T10:57:43.179442Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T10:57:43.179473Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T10:57:43.179615Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-24T10:57:43.179633Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-06-24T10:57:43.85897Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T10:57:43.859026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T10:57:43.859064Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-06-24T10:57:43.859083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-06-24T10:57:43.859098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-24T10:57:43.859124Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-06-24T10:57:43.859141Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-06-24T10:57:43.859988Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:57:43.860531Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T10:57:43.860686Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T10:57:43.860756Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T10:57:43.860899Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:57:43.860994Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:57:43.861022Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T10:57:43.862685Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T10:57:43.862708Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T10:57:43.863489Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-06-24T10:57:43.865741Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T10:57:55.949423Z","caller":"traceutil/trace.go:171","msg":"trace[1442965635] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:408; }","duration":"482.538825ms","start":"2026-06-24T10:57:55.466843Z","end":"2026-06-24T10:57:55.949382Z","steps":["trace[1442965635] 'read index received' (duration: 482.348611ms)","trace[1442965635] 'applied index is now lower than readState.Index' (duration: 188.404µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:57:55.949495Z","caller":"traceutil/trace.go:171","msg":"trace[696904195] transaction","detail":"{read_only:false; response_revision:396; number_of_response:1; }","duration":"523.607449ms","start":"2026-06-24T10:57:55.42583Z","end":"2026-06-24T10:57:55.949438Z","steps":["trace[696904195] 'process raft request' (duration: 523.382964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:57:55.949639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.78041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-proxy-w5lq6\" ","response":"range_response_count:1 size:4458"} {"level":"info","ts":"2026-06-24T10:57:55.949723Z","caller":"traceutil/trace.go:171","msg":"trace[696890316] range","detail":"{range_begin:/registry/pods/kube-system/kube-proxy-w5lq6; range_end:; response_count:1; response_revision:396; }","duration":"482.908244ms","start":"2026-06-24T10:57:55.466802Z","end":"2026-06-24T10:57:55.94971Z","steps":["trace[696890316] 'agreement among raft nodes before linearized reading' (duration: 482.777741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:57:55.949901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:57:55.466781Z","time spent":"483.105728ms","remote":"127.0.0.1:56186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":4481,"request content":"key:\"/registry/pods/kube-system/kube-proxy-w5lq6\" "} {"level":"warn","ts":"2026-06-24T10:57:55.950606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:57:55.425798Z","time spent":"523.814274ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:57:55.959613Z","caller":"traceutil/trace.go:171","msg":"trace[1960812772] transaction","detail":"{read_only:false; response_revision:397; number_of_response:1; }","duration":"384.443246ms","start":"2026-06-24T10:57:55.57514Z","end":"2026-06-24T10:57:55.959583Z","steps":["trace[1960812772] 'process raft request' (duration: 384.265962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:57:55.959663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.912537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T10:57:55.959768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:57:55.575115Z","time spent":"384.557118ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:57:55.959828Z","caller":"traceutil/trace.go:171","msg":"trace[514481730] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:397; }","duration":"278.024549ms","start":"2026-06-24T10:57:55.681712Z","end":"2026-06-24T10:57:55.959737Z","steps":["trace[514481730] 'agreement among raft nodes before linearized reading' (duration: 277.847375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:57:55.960025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.416766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:57:55.96013Z","caller":"traceutil/trace.go:171","msg":"trace[965781277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:397; }","duration":"208.584432ms","start":"2026-06-24T10:57:55.751523Z","end":"2026-06-24T10:57:55.960107Z","steps":["trace[965781277] 'agreement among raft nodes before linearized reading' (duration: 208.141551ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:04.089624Z","caller":"traceutil/trace.go:171","msg":"trace[728606190] transaction","detail":"{read_only:false; response_revision:424; number_of_response:1; }","duration":"104.259313ms","start":"2026-06-24T10:58:03.985342Z","end":"2026-06-24T10:58:04.089601Z","steps":["trace[728606190] 'process raft request' (duration: 103.94299ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:07.848953Z","caller":"traceutil/trace.go:171","msg":"trace[615448643] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"339.402474ms","start":"2026-06-24T10:58:07.509525Z","end":"2026-06-24T10:58:07.848928Z","steps":["trace[615448643] 'process raft request' (duration: 339.215762ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:07.84911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:07.509493Z","time spent":"339.538706ms","remote":"127.0.0.1:56454","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4180,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:08.003831Z","caller":"traceutil/trace.go:171","msg":"trace[1743741465] transaction","detail":"{read_only:false; response_revision:439; number_of_response:1; }","duration":"126.999032ms","start":"2026-06-24T10:58:07.876809Z","end":"2026-06-24T10:58:08.003808Z","steps":["trace[1743741465] 'process raft request' (duration: 126.929681ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:08.00393Z","caller":"traceutil/trace.go:171","msg":"trace[738434213] transaction","detail":"{read_only:false; response_revision:438; number_of_response:1; }","duration":"130.327323ms","start":"2026-06-24T10:58:07.873565Z","end":"2026-06-24T10:58:08.003893Z","steps":["trace[738434213] 'process raft request' (duration: 60.057169ms)","trace[738434213] 'compare' (duration: 69.95867ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:21.225369Z","caller":"traceutil/trace.go:171","msg":"trace[1582654599] transaction","detail":"{read_only:false; number_of_response:1; response_revision:537; }","duration":"168.610062ms","start":"2026-06-24T10:58:21.056736Z","end":"2026-06-24T10:58:21.225346Z","steps":["trace[1582654599] 'process raft request' (duration: 168.439419ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.225524Z","caller":"traceutil/trace.go:171","msg":"trace[2059950823] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"168.892166ms","start":"2026-06-24T10:58:21.056627Z","end":"2026-06-24T10:58:21.225519Z","steps":["trace[2059950823] 'process raft request' (duration: 162.683039ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.225699Z","caller":"traceutil/trace.go:171","msg":"trace[1130751689] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"152.930195ms","start":"2026-06-24T10:58:21.072763Z","end":"2026-06-24T10:58:21.225693Z","steps":["trace[1130751689] 'process raft request' (duration: 152.58444ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.225766Z","caller":"traceutil/trace.go:171","msg":"trace[623474351] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"167.309514ms","start":"2026-06-24T10:58:21.058452Z","end":"2026-06-24T10:58:21.225762Z","steps":["trace[623474351] 'process raft request' (duration: 166.793196ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.227331Z","caller":"traceutil/trace.go:171","msg":"trace[1594226871] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"165.621631ms","start":"2026-06-24T10:58:21.061658Z","end":"2026-06-24T10:58:21.227279Z","steps":["trace[1594226871] 'process raft request' (duration: 163.656674ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.227799Z","caller":"traceutil/trace.go:171","msg":"trace[1041542795] transaction","detail":"{read_only:false; response_revision:544; number_of_response:1; }","duration":"145.597794ms","start":"2026-06-24T10:58:21.082185Z","end":"2026-06-24T10:58:21.227783Z","steps":["trace[1041542795] 'process raft request' (duration: 143.394374ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.227996Z","caller":"traceutil/trace.go:171","msg":"trace[1854132324] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"154.681399ms","start":"2026-06-24T10:58:21.073207Z","end":"2026-06-24T10:58:21.227888Z","steps":["trace[1854132324] 'process raft request' (duration: 152.175856ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.228156Z","caller":"traceutil/trace.go:171","msg":"trace[1990466044] transaction","detail":"{read_only:false; response_revision:542; number_of_response:1; }","duration":"154.442767ms","start":"2026-06-24T10:58:21.073699Z","end":"2026-06-24T10:58:21.228142Z","steps":["trace[1990466044] 'process raft request' (duration: 151.730189ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.228368Z","caller":"traceutil/trace.go:171","msg":"trace[320712891] transaction","detail":"{read_only:false; response_revision:543; number_of_response:1; }","duration":"147.606972ms","start":"2026-06-24T10:58:21.080729Z","end":"2026-06-24T10:58:21.228336Z","steps":["trace[320712891] 'process raft request' (duration: 144.793124ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.229564Z","caller":"traceutil/trace.go:171","msg":"trace[1391565452] transaction","detail":"{read_only:false; response_revision:545; number_of_response:1; }","duration":"144.267938ms","start":"2026-06-24T10:58:21.085247Z","end":"2026-06-24T10:58:21.229515Z","steps":["trace[1391565452] 'process raft request' (duration: 140.378784ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.229692Z","caller":"traceutil/trace.go:171","msg":"trace[1684908171] transaction","detail":"{read_only:false; response_revision:547; number_of_response:1; }","duration":"142.601174ms","start":"2026-06-24T10:58:21.087076Z","end":"2026-06-24T10:58:21.229677Z","steps":["trace[1684908171] 'process raft request' (duration: 139.646743ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.229812Z","caller":"traceutil/trace.go:171","msg":"trace[709419003] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"130.653269ms","start":"2026-06-24T10:58:21.099149Z","end":"2026-06-24T10:58:21.229802Z","steps":["trace[709419003] 'process raft request' (duration: 128.708262ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.229932Z","caller":"traceutil/trace.go:171","msg":"trace[257569700] transaction","detail":"{read_only:false; response_revision:546; number_of_response:1; }","duration":"144.146695ms","start":"2026-06-24T10:58:21.085768Z","end":"2026-06-24T10:58:21.229915Z","steps":["trace[257569700] 'process raft request' (duration: 139.922257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:21.230328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.380253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T10:58:21.230382Z","caller":"traceutil/trace.go:171","msg":"trace[463304822] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:548; }","duration":"148.465203ms","start":"2026-06-24T10:58:21.081885Z","end":"2026-06-24T10:58:21.23035Z","steps":["trace[463304822] 'agreement among raft nodes before linearized reading' (duration: 148.308891ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.236187Z","caller":"traceutil/trace.go:171","msg":"trace[114328871] transaction","detail":"{read_only:false; number_of_response:1; response_revision:549; }","duration":"106.605378ms","start":"2026-06-24T10:58:21.129565Z","end":"2026-06-24T10:58:21.23617Z","steps":["trace[114328871] 'process raft request' (duration: 101.235133ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.237813Z","caller":"traceutil/trace.go:171","msg":"trace[870162154] transaction","detail":"{read_only:false; response_revision:549; number_of_response:1; }","duration":"111.1807ms","start":"2026-06-24T10:58:21.126599Z","end":"2026-06-24T10:58:21.237779Z","steps":["trace[870162154] 'process raft request' (duration: 103.820259ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:21.238123Z","caller":"traceutil/trace.go:171","msg":"trace[2087545400] linearizableReadLoop","detail":"{readStateIndex:563; appliedIndex:554; }","duration":"156.13408ms","start":"2026-06-24T10:58:21.081932Z","end":"2026-06-24T10:58:21.238067Z","steps":["trace[2087545400] 'read index received' (duration: 28.775707ms)","trace[2087545400] 'applied index is now lower than readState.Index' (duration: 118.212007ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:22.076701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.967871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T10:58:22.077281Z","caller":"traceutil/trace.go:171","msg":"trace[1539490623] transaction","detail":"{read_only:false; response_revision:562; number_of_response:1; }","duration":"718.61259ms","start":"2026-06-24T10:58:21.35862Z","end":"2026-06-24T10:58:22.077233Z","steps":["trace[1539490623] 'process raft request' (duration: 291.816777ms)","trace[1539490623] 'compare' (duration: 425.558756ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:22.077412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:21.358601Z","time spent":"718.767132ms","remote":"127.0.0.1:56510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T10:58:22.077483Z","caller":"traceutil/trace.go:171","msg":"trace[1065260301] transaction","detail":"{read_only:false; response_revision:563; number_of_response:1; }","duration":"717.325053ms","start":"2026-06-24T10:58:21.36004Z","end":"2026-06-24T10:58:22.077365Z","steps":["trace[1065260301] 'process raft request' (duration: 716.787276ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:22.077599Z","caller":"traceutil/trace.go:171","msg":"trace[1276077620] transaction","detail":"{read_only:false; response_revision:564; number_of_response:1; }","duration":"710.961056ms","start":"2026-06-24T10:58:21.366609Z","end":"2026-06-24T10:58:22.07757Z","steps":["trace[1276077620] 'process raft request' (duration: 710.454829ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:22.077654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:21.360025Z","time spent":"717.536826ms","remote":"127.0.0.1:56020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T10:58:22.077753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:21.3666Z","time spent":"711.068897ms","remote":"127.0.0.1:56020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:22.077853Z","caller":"traceutil/trace.go:171","msg":"trace[1320440031] transaction","detail":"{read_only:false; response_revision:565; number_of_response:1; }","duration":"710.521409ms","start":"2026-06-24T10:58:21.367317Z","end":"2026-06-24T10:58:22.077839Z","steps":["trace[1320440031] 'process raft request' (duration: 710.041743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:22.077959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:21.367305Z","time spent":"710.59576ms","remote":"127.0.0.1:56020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:22.078091Z","caller":"traceutil/trace.go:171","msg":"trace[273860524] linearizableReadLoop","detail":"{readStateIndex:588; appliedIndex:583; }","duration":"325.56021ms","start":"2026-06-24T10:58:21.752517Z","end":"2026-06-24T10:58:22.078077Z","steps":["trace[273860524] 'read index received' (duration: 323.871476ms)","trace[273860524] 'applied index is now lower than readState.Index' (duration: 1.687884ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:22.078131Z","caller":"traceutil/trace.go:171","msg":"trace[958155733] transaction","detail":"{read_only:false; response_revision:566; number_of_response:1; }","duration":"659.00585ms","start":"2026-06-24T10:58:21.419115Z","end":"2026-06-24T10:58:22.078121Z","steps":["trace[958155733] 'process raft request' (duration: 658.830957ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:22.078178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:21.419097Z","time spent":"659.056741ms","remote":"127.0.0.1:56020","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T10:58:22.078193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.678832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:22.078222Z","caller":"traceutil/trace.go:171","msg":"trace[1023009755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:566; }","duration":"325.744672ms","start":"2026-06-24T10:58:21.752469Z","end":"2026-06-24T10:58:22.078213Z","steps":["trace[1023009755] 'agreement among raft nodes before linearized reading' (duration: 325.671491ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:22.078264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:21.752424Z","time spent":"325.826444ms","remote":"127.0.0.1:55964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T10:58:24.420362Z","caller":"traceutil/trace.go:171","msg":"trace[1222837750] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"104.504517ms","start":"2026-06-24T10:58:24.315836Z","end":"2026-06-24T10:58:24.42034Z","steps":["trace[1222837750] 'process raft request' (duration: 28.428819ms)","trace[1222837750] 'compare' (duration: 75.941096ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:26.616072Z","caller":"traceutil/trace.go:171","msg":"trace[1207834714] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"297.295668ms","start":"2026-06-24T10:58:26.318756Z","end":"2026-06-24T10:58:26.616052Z","steps":["trace[1207834714] 'process raft request' (duration: 297.131055ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:26.630061Z","caller":"traceutil/trace.go:171","msg":"trace[2055772701] linearizableReadLoop","detail":"{readStateIndex:646; appliedIndex:644; }","duration":"202.49706ms","start":"2026-06-24T10:58:26.42754Z","end":"2026-06-24T10:58:26.630037Z","steps":["trace[2055772701] 'read index received' (duration: 188.284998ms)","trace[2055772701] 'applied index is now lower than readState.Index' (duration: 14.211352ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:26.630253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.692202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T10:58:26.630291Z","caller":"traceutil/trace.go:171","msg":"trace[2071183092] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:623; }","duration":"202.767814ms","start":"2026-06-24T10:58:26.427509Z","end":"2026-06-24T10:58:26.630277Z","steps":["trace[2071183092] 'agreement among raft nodes before linearized reading' (duration: 202.686523ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:26.630324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.606348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T10:58:26.63033Z","caller":"traceutil/trace.go:171","msg":"trace[25010134] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"245.612163ms","start":"2026-06-24T10:58:26.38469Z","end":"2026-06-24T10:58:26.630302Z","steps":["trace[25010134] 'process raft request' (duration: 244.059441ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:26.630417Z","caller":"traceutil/trace.go:171","msg":"trace[1244976273] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:623; }","duration":"168.733579ms","start":"2026-06-24T10:58:26.461664Z","end":"2026-06-24T10:58:26.630398Z","steps":["trace[1244976273] 'agreement among raft nodes before linearized reading' (duration: 168.577287ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:28.506436Z","caller":"traceutil/trace.go:171","msg":"trace[1963614241] transaction","detail":"{read_only:false; response_revision:637; number_of_response:1; }","duration":"414.007388ms","start":"2026-06-24T10:58:28.0924Z","end":"2026-06-24T10:58:28.506408Z","steps":["trace[1963614241] 'process raft request' (duration: 413.48729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:28.506619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:28.092382Z","time spent":"414.15825ms","remote":"127.0.0.1:56082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036285,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:28.813193Z","caller":"traceutil/trace.go:171","msg":"trace[2037588719] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"245.002485ms","start":"2026-06-24T10:58:28.568164Z","end":"2026-06-24T10:58:28.813166Z","steps":["trace[2037588719] 'process raft request' (duration: 244.850143ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:29.744885Z","caller":"traceutil/trace.go:171","msg":"trace[1640993994] linearizableReadLoop","detail":"{readStateIndex:663; appliedIndex:661; }","duration":"1.125187413s","start":"2026-06-24T10:58:28.619662Z","end":"2026-06-24T10:58:29.744849Z","steps":["trace[1640993994] 'read index received' (duration: 193.328742ms)","trace[1640993994] 'applied index is now lower than readState.Index' (duration: 931.856341ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:29.744897Z","caller":"traceutil/trace.go:171","msg":"trace[1741123041] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"499.312386ms","start":"2026-06-24T10:58:29.245546Z","end":"2026-06-24T10:58:29.744858Z","steps":["trace[1741123041] 'process raft request' (duration: 499.219034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:29.745092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:29.245523Z","time spent":"499.455778ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T10:58:29.745147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125462357s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T10:58:29.745195Z","caller":"traceutil/trace.go:171","msg":"trace[1319084989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:640; }","duration":"1.125551318s","start":"2026-06-24T10:58:28.619631Z","end":"2026-06-24T10:58:29.745182Z","steps":["trace[1319084989] 'agreement among raft nodes before linearized reading' (duration: 1.125353924s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:29.745232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:28.619619Z","time spent":"1.12560445s","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T10:58:29.745366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106617237s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T10:58:29.7454Z","caller":"traceutil/trace.go:171","msg":"trace[1481442094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:640; }","duration":"1.106668107s","start":"2026-06-24T10:58:28.638724Z","end":"2026-06-24T10:58:29.745392Z","steps":["trace[1481442094] 'agreement among raft nodes before linearized reading' (duration: 1.106612556s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:29.745431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:28.638713Z","time spent":"1.106711087s","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T10:58:29.74551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"921.550493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:29.745539Z","caller":"traceutil/trace.go:171","msg":"trace[173545143] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:640; }","duration":"921.613554ms","start":"2026-06-24T10:58:28.823916Z","end":"2026-06-24T10:58:29.74553Z","steps":["trace[173545143] 'agreement among raft nodes before linearized reading' (duration: 921.573453ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:29.745566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:28.823893Z","time spent":"921.667904ms","remote":"127.0.0.1:56242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-24T10:58:29.745677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"470.362018ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T10:58:29.746573Z","caller":"traceutil/trace.go:171","msg":"trace[1777722895] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:640; }","duration":"471.334272ms","start":"2026-06-24T10:58:29.275215Z","end":"2026-06-24T10:58:29.74655Z","steps":["trace[1777722895] 'agreement among raft nodes before linearized reading' (duration: 470.195215ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:29.745648Z","caller":"traceutil/trace.go:171","msg":"trace[1287206735] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"1.132055022s","start":"2026-06-24T10:58:28.612836Z","end":"2026-06-24T10:58:29.744891Z","steps":["trace[1287206735] 'process raft request' (duration: 1.0856413s)","trace[1287206735] 'compare' (duration: 45.647272ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:29.746662Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:29.275193Z","time spent":"471.436533ms","remote":"127.0.0.1:56260","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-06-24T10:58:29.746723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:28.612817Z","time spent":"1.133847148s","remote":"127.0.0.1:56186","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17126,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T10:58:29.74579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.106979211s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T10:58:29.746947Z","caller":"traceutil/trace.go:171","msg":"trace[1885657870] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:640; }","duration":"1.108160869s","start":"2026-06-24T10:58:28.638767Z","end":"2026-06-24T10:58:29.746927Z","steps":["trace[1885657870] 'agreement among raft nodes before linearized reading' (duration: 1.106987492s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:29.747003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:28.638746Z","time spent":"1.10823991s","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T10:58:31.755063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000875303s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-24T10:58:31.755183Z","caller":"traceutil/trace.go:171","msg":"trace[1741979328] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.001051085s","start":"2026-06-24T10:58:29.754108Z","end":"2026-06-24T10:58:31.755159Z","steps":["trace[1741979328] 'agreement among raft nodes before linearized reading' (duration: 2.000887363s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:31.755239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:29.754076Z","time spent":"2.001150456s","remote":"127.0.0.1:55964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/24 10:58:31 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T10:58:31.842034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.902966619s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T10:58:31.842303Z","caller":"traceutil/trace.go:171","msg":"trace[1011635317] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:664; }","duration":"2.088108169s","start":"2026-06-24T10:58:29.754133Z","end":"2026-06-24T10:58:31.842241Z","steps":["trace[1011635317] 'read index received' (duration: 12.174127ms)","trace[1011635317] 'applied index is now lower than readState.Index' (duration: 2.075933072s)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:31.842404Z","caller":"traceutil/trace.go:171","msg":"trace[2079043707] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"2.090481214s","start":"2026-06-24T10:58:29.75191Z","end":"2026-06-24T10:58:31.842391Z","steps":["trace[2079043707] 'process raft request' (duration: 187.081278ms)","trace[2079043707] 'compare' (duration: 1.902713996s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:31.84247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:29.751889Z","time spent":"2.090548795s","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:31.842542Z","caller":"traceutil/trace.go:171","msg":"trace[1631738444] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"2.090034647s","start":"2026-06-24T10:58:29.75248Z","end":"2026-06-24T10:58:31.842515Z","steps":["trace[1631738444] 'process raft request' (duration: 2.089645321s)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:31.842657Z","caller":"traceutil/trace.go:171","msg":"trace[280504603] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"2.089905416s","start":"2026-06-24T10:58:29.752739Z","end":"2026-06-24T10:58:31.842644Z","steps":["trace[280504603] 'process raft request' (duration: 2.089465969s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:31.842689Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:29.752467Z","time spent":"2.0901445s","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T10:58:31.842724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:29.752719Z","time spent":"2.089973007s","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T10:58:31.851513Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.704418966s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T10:58:31.852936Z","caller":"traceutil/trace.go:171","msg":"trace[349376628] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.716442821s","start":"2026-06-24T10:58:30.136437Z","end":"2026-06-24T10:58:31.852879Z","steps":["trace[349376628] 'process raft request' (duration: 1.715627468s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:31.853131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:30.136416Z","time spent":"1.716612794s","remote":"127.0.0.1:56082","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:32.747266Z","caller":"traceutil/trace.go:171","msg":"trace[1670675505] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"182.796491ms","start":"2026-06-24T10:58:32.564436Z","end":"2026-06-24T10:58:32.747233Z","steps":["trace[1670675505] 'process raft request' (duration: 179.659744ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:33.703408Z","caller":"traceutil/trace.go:171","msg":"trace[1153102225] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"120.633026ms","start":"2026-06-24T10:58:33.582752Z","end":"2026-06-24T10:58:33.703385Z","steps":["trace[1153102225] 'process raft request' (duration: 120.476443ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:33.987197Z","caller":"traceutil/trace.go:171","msg":"trace[1188187512] linearizableReadLoop","detail":"{readStateIndex:686; appliedIndex:683; }","duration":"114.608566ms","start":"2026-06-24T10:58:33.872565Z","end":"2026-06-24T10:58:33.987173Z","steps":["trace[1188187512] 'read index received' (duration: 3.461652ms)","trace[1188187512] 'applied index is now lower than readState.Index' (duration: 111.145874ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:33.987328Z","caller":"traceutil/trace.go:171","msg":"trace[620036052] transaction","detail":"{read_only:false; response_revision:660; number_of_response:1; }","duration":"135.152589ms","start":"2026-06-24T10:58:33.852153Z","end":"2026-06-24T10:58:33.987306Z","steps":["trace[620036052] 'process raft request' (duration: 134.416138ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:33.98737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.784168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T10:58:33.987407Z","caller":"traceutil/trace.go:171","msg":"trace[806474736] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:661; }","duration":"114.855529ms","start":"2026-06-24T10:58:33.872541Z","end":"2026-06-24T10:58:33.987396Z","steps":["trace[806474736] 'agreement among raft nodes before linearized reading' (duration: 114.722717ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:33.987516Z","caller":"traceutil/trace.go:171","msg":"trace[1302640074] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"135.279842ms","start":"2026-06-24T10:58:33.852227Z","end":"2026-06-24T10:58:33.987506Z","steps":["trace[1302640074] 'process raft request' (duration: 134.842254ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:34.930639Z","caller":"traceutil/trace.go:171","msg":"trace[1291891926] transaction","detail":"{read_only:false; response_revision:665; number_of_response:1; }","duration":"229.696235ms","start":"2026-06-24T10:58:34.700919Z","end":"2026-06-24T10:58:34.930616Z","steps":["trace[1291891926] 'process raft request' (duration: 192.3851ms)","trace[1291891926] 'compare' (duration: 36.761508ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:34.930742Z","caller":"traceutil/trace.go:171","msg":"trace[1312026306] linearizableReadLoop","detail":"{readStateIndex:690; appliedIndex:689; }","duration":"179.425748ms","start":"2026-06-24T10:58:34.751276Z","end":"2026-06-24T10:58:34.930702Z","steps":["trace[1312026306] 'read index received' (duration: 141.9679ms)","trace[1312026306] 'applied index is now lower than readState.Index' (duration: 37.453038ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:34.930878Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.589621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:34.930929Z","caller":"traceutil/trace.go:171","msg":"trace[737379266] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:665; }","duration":"179.684072ms","start":"2026-06-24T10:58:34.751232Z","end":"2026-06-24T10:58:34.930916Z","steps":["trace[737379266] 'agreement among raft nodes before linearized reading' (duration: 179.56105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:35.918289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.768959ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T10:58:35.918433Z","caller":"traceutil/trace.go:171","msg":"trace[818916825] linearizableReadLoop","detail":"{readStateIndex:692; appliedIndex:691; }","duration":"345.23123ms","start":"2026-06-24T10:58:35.57318Z","end":"2026-06-24T10:58:35.918411Z","steps":["trace[818916825] 'read index received' (duration: 120.203937ms)","trace[818916825] 'applied index is now lower than readState.Index' (duration: 225.025103ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:35.918528Z","caller":"traceutil/trace.go:171","msg":"trace[1113655892] transaction","detail":"{read_only:false; response_revision:667; number_of_response:1; }","duration":"751.351711ms","start":"2026-06-24T10:58:35.167162Z","end":"2026-06-24T10:58:35.918514Z","steps":["trace[1113655892] 'process raft request' (duration: 526.244386ms)","trace[1113655892] 'compare' (duration: 224.632647ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:35.918678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:35.167138Z","time spent":"751.422562ms","remote":"127.0.0.1:56060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":722,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T10:58:35.91868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.815284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:35.918749Z","caller":"traceutil/trace.go:171","msg":"trace[522084342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:667; }","duration":"166.936725ms","start":"2026-06-24T10:58:35.751794Z","end":"2026-06-24T10:58:35.918731Z","steps":["trace[522084342] 'agreement among raft nodes before linearized reading' (duration: 166.755842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:35.918768Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.580176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jdhfg\" ","response":"range_response_count:1 size:17516"} {"level":"info","ts":"2026-06-24T10:58:35.918854Z","caller":"traceutil/trace.go:171","msg":"trace[204907898] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jdhfg; range_end:; response_count:1; response_revision:667; }","duration":"345.701647ms","start":"2026-06-24T10:58:35.573121Z","end":"2026-06-24T10:58:35.918822Z","steps":["trace[204907898] 'agreement among raft nodes before linearized reading' (duration: 345.432913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:35.918897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:35.573087Z","time spent":"345.800629ms","remote":"127.0.0.1:56186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17539,"request content":"key:\"/registry/pods/kube-system/cilium-jdhfg\" "} {"level":"info","ts":"2026-06-24T10:58:36.169469Z","caller":"traceutil/trace.go:171","msg":"trace[259720700] linearizableReadLoop","detail":"{readStateIndex:694; appliedIndex:693; }","duration":"177.346304ms","start":"2026-06-24T10:58:35.992096Z","end":"2026-06-24T10:58:36.169443Z","steps":["trace[259720700] 'read index received' (duration: 177.050869ms)","trace[259720700] 'applied index is now lower than readState.Index' (duration: 294.514µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:36.169563Z","caller":"traceutil/trace.go:171","msg":"trace[1438767534] transaction","detail":"{read_only:false; response_revision:669; number_of_response:1; }","duration":"237.300149ms","start":"2026-06-24T10:58:35.932243Z","end":"2026-06-24T10:58:36.169543Z","steps":["trace[1438767534] 'process raft request' (duration: 236.982454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:36.169697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.580817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T10:58:36.169749Z","caller":"traceutil/trace.go:171","msg":"trace[866594846] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:669; }","duration":"177.670999ms","start":"2026-06-24T10:58:35.992058Z","end":"2026-06-24T10:58:36.169729Z","steps":["trace[866594846] 'agreement among raft nodes before linearized reading' (duration: 177.516586ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:36.169918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.494525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T10:58:36.169946Z","caller":"traceutil/trace.go:171","msg":"trace[962063277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:669; }","duration":"167.543907ms","start":"2026-06-24T10:58:36.002394Z","end":"2026-06-24T10:58:36.169938Z","steps":["trace[962063277] 'agreement among raft nodes before linearized reading' (duration: 167.465715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:36.170074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.676578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T10:58:36.170164Z","caller":"traceutil/trace.go:171","msg":"trace[1177361233] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:669; }","duration":"177.820281ms","start":"2026-06-24T10:58:35.992322Z","end":"2026-06-24T10:58:36.170143Z","steps":["trace[1177361233] 'agreement among raft nodes before linearized reading' (duration: 177.480146ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:36.274555Z","caller":"traceutil/trace.go:171","msg":"trace[1502521754] transaction","detail":"{read_only:false; response_revision:670; number_of_response:1; }","duration":"100.270797ms","start":"2026-06-24T10:58:36.174254Z","end":"2026-06-24T10:58:36.274525Z","steps":["trace[1502521754] 'process raft request' (duration: 62.347647ms)","trace[1502521754] 'compare' (duration: 37.577305ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:36.688696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.547637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-24T10:58:36.688779Z","caller":"traceutil/trace.go:171","msg":"trace[369759846] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:673; }","duration":"185.680559ms","start":"2026-06-24T10:58:36.503076Z","end":"2026-06-24T10:58:36.688757Z","steps":["trace[369759846] 'range keys from in-memory index tree' (duration: 185.436845ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:36.912042Z","caller":"traceutil/trace.go:171","msg":"trace[2022431353] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"181.033329ms","start":"2026-06-24T10:58:36.730983Z","end":"2026-06-24T10:58:36.912016Z","steps":["trace[2022431353] 'process raft request' (duration: 180.622233ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:36.958058Z","caller":"traceutil/trace.go:171","msg":"trace[1153546224] transaction","detail":"{read_only:false; response_revision:676; number_of_response:1; }","duration":"225.752511ms","start":"2026-06-24T10:58:36.732273Z","end":"2026-06-24T10:58:36.958025Z","steps":["trace[1153546224] 'process raft request' (duration: 225.439997ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:36.958056Z","caller":"traceutil/trace.go:171","msg":"trace[1415911853] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:699; }","duration":"207.05498ms","start":"2026-06-24T10:58:36.75098Z","end":"2026-06-24T10:58:36.958035Z","steps":["trace[1415911853] 'read index received' (duration: 160.757035ms)","trace[1415911853] 'applied index is now lower than readState.Index' (duration: 46.296875ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:36.958182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.190962ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:36.958232Z","caller":"traceutil/trace.go:171","msg":"trace[1855088672] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:678; }","duration":"207.284214ms","start":"2026-06-24T10:58:36.750937Z","end":"2026-06-24T10:58:36.958221Z","steps":["trace[1855088672] 'agreement among raft nodes before linearized reading' (duration: 207.175692ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:36.958355Z","caller":"traceutil/trace.go:171","msg":"trace[705085769] transaction","detail":"{read_only:false; response_revision:678; number_of_response:1; }","duration":"205.865952ms","start":"2026-06-24T10:58:36.752442Z","end":"2026-06-24T10:58:36.958308Z","steps":["trace[705085769] 'process raft request' (duration: 205.545197ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:36.958748Z","caller":"traceutil/trace.go:171","msg":"trace[1581159056] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"217.410797ms","start":"2026-06-24T10:58:36.741304Z","end":"2026-06-24T10:58:36.958714Z","steps":["trace[1581159056] 'process raft request' (duration: 216.568284ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:37.039895Z","caller":"traceutil/trace.go:171","msg":"trace[1977482836] transaction","detail":"{read_only:false; response_revision:679; number_of_response:1; }","duration":"124.098247ms","start":"2026-06-24T10:58:36.915755Z","end":"2026-06-24T10:58:37.039853Z","steps":["trace[1977482836] 'process raft request' (duration: 103.488186ms)","trace[1977482836] 'compare' (duration: 20.461798ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:37.039946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.837688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.3\" ","response":"range_response_count:1 size:131"} {"level":"info","ts":"2026-06-24T10:58:37.040002Z","caller":"traceutil/trace.go:171","msg":"trace[1173436891] range","detail":"{range_begin:/registry/masterleases/199.204.45.3; range_end:; response_count:1; response_revision:679; }","duration":"124.95274ms","start":"2026-06-24T10:58:36.915037Z","end":"2026-06-24T10:58:37.039989Z","steps":["trace[1173436891] 'agreement among raft nodes before linearized reading' (duration: 124.824008ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:38.936126Z","caller":"traceutil/trace.go:171","msg":"trace[1085284742] transaction","detail":"{read_only:false; response_revision:725; number_of_response:1; }","duration":"130.886755ms","start":"2026-06-24T10:58:38.805218Z","end":"2026-06-24T10:58:38.936105Z","steps":["trace[1085284742] 'process raft request' (duration: 130.736703ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:39.85111Z","caller":"traceutil/trace.go:171","msg":"trace[1776130159] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"106.147047ms","start":"2026-06-24T10:58:39.74494Z","end":"2026-06-24T10:58:39.851087Z","steps":["trace[1776130159] 'process raft request' (duration: 85.746047ms)","trace[1776130159] 'compare' (duration: 20.123926ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:39.851223Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.871088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:39.851323Z","caller":"traceutil/trace.go:171","msg":"trace[2147174937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:737; }","duration":"103.00577ms","start":"2026-06-24T10:58:39.748298Z","end":"2026-06-24T10:58:39.851303Z","steps":["trace[2147174937] 'agreement among raft nodes before linearized reading' (duration: 102.870308ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:39.851556Z","caller":"traceutil/trace.go:171","msg":"trace[1352359385] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:762; }","duration":"102.651104ms","start":"2026-06-24T10:58:39.748331Z","end":"2026-06-24T10:58:39.850982Z","steps":["trace[1352359385] 'read index received' (duration: 82.330665ms)","trace[1352359385] 'applied index is now lower than readState.Index' (duration: 20.318719ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:40.793321Z","caller":"traceutil/trace.go:171","msg":"trace[739439869] linearizableReadLoop","detail":"{readStateIndex:772; appliedIndex:770; }","duration":"118.092867ms","start":"2026-06-24T10:58:40.675208Z","end":"2026-06-24T10:58:40.793301Z","steps":["trace[739439869] 'read index received' (duration: 39.911402ms)","trace[739439869] 'applied index is now lower than readState.Index' (duration: 78.180445ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:40.793387Z","caller":"traceutil/trace.go:171","msg":"trace[993625612] transaction","detail":"{read_only:false; response_revision:746; number_of_response:1; }","duration":"159.774556ms","start":"2026-06-24T10:58:40.633576Z","end":"2026-06-24T10:58:40.793351Z","steps":["trace[993625612] 'process raft request' (duration: 143.976275ms)","trace[993625612] 'compare' (duration: 15.571318ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:40.793459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.232049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T10:58:40.793525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.961787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:40.79356Z","caller":"traceutil/trace.go:171","msg":"trace[1616772804] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:746; }","duration":"118.007267ms","start":"2026-06-24T10:58:40.675544Z","end":"2026-06-24T10:58:40.793551Z","steps":["trace[1616772804] 'agreement among raft nodes before linearized reading' (duration: 117.965166ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:40.793525Z","caller":"traceutil/trace.go:171","msg":"trace[1762341324] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:746; }","duration":"118.335772ms","start":"2026-06-24T10:58:40.675171Z","end":"2026-06-24T10:58:40.793507Z","steps":["trace[1762341324] 'agreement among raft nodes before linearized reading' (duration: 118.2307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:40.793759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.235661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-jdhfg\" ","response":"range_response_count:1 size:18508"} {"level":"info","ts":"2026-06-24T10:58:40.793813Z","caller":"traceutil/trace.go:171","msg":"trace[72088310] range","detail":"{range_begin:/registry/pods/kube-system/cilium-jdhfg; range_end:; response_count:1; response_revision:746; }","duration":"105.318662ms","start":"2026-06-24T10:58:40.68848Z","end":"2026-06-24T10:58:40.793799Z","steps":["trace[72088310] 'agreement among raft nodes before linearized reading' (duration: 105.136079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:40.793476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.24701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:40.794022Z","caller":"traceutil/trace.go:171","msg":"trace[1650058900] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:746; }","duration":"118.741038ms","start":"2026-06-24T10:58:40.675201Z","end":"2026-06-24T10:58:40.793942Z","steps":["trace[1650058900] 'agreement among raft nodes before linearized reading' (duration: 118.221299ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:40.99274Z","caller":"traceutil/trace.go:171","msg":"trace[2139525582] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"183.082693ms","start":"2026-06-24T10:58:40.809261Z","end":"2026-06-24T10:58:40.992344Z","steps":["trace[2139525582] 'process raft request' (duration: 182.89411ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:41.167173Z","caller":"traceutil/trace.go:171","msg":"trace[340498123] transaction","detail":"{read_only:false; response_revision:749; number_of_response:1; }","duration":"274.200318ms","start":"2026-06-24T10:58:40.892954Z","end":"2026-06-24T10:58:41.167154Z","steps":["trace[340498123] 'process raft request' (duration: 273.346746ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:41.167202Z","caller":"traceutil/trace.go:171","msg":"trace[1501691888] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"273.877083ms","start":"2026-06-24T10:58:40.893299Z","end":"2026-06-24T10:58:41.167176Z","steps":["trace[1501691888] 'process raft request' (duration: 273.65379ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:41.167099Z","caller":"traceutil/trace.go:171","msg":"trace[446850969] linearizableReadLoop","detail":"{readStateIndex:776; appliedIndex:773; }","duration":"200.640883ms","start":"2026-06-24T10:58:40.966427Z","end":"2026-06-24T10:58:41.167068Z","steps":["trace[446850969] 'read index received' (duration: 25.772794ms)","trace[446850969] 'applied index is now lower than readState.Index' (duration: 174.866899ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:41.16777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.324314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:1 size:24244"} {"level":"info","ts":"2026-06-24T10:58:41.167891Z","caller":"traceutil/trace.go:171","msg":"trace[7902309] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:1; response_revision:750; }","duration":"201.515787ms","start":"2026-06-24T10:58:40.966357Z","end":"2026-06-24T10:58:41.167873Z","steps":["trace[7902309] 'agreement among raft nodes before linearized reading' (duration: 201.265443ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:41.358312Z","caller":"traceutil/trace.go:171","msg":"trace[732649879] transaction","detail":"{read_only:false; response_revision:752; number_of_response:1; }","duration":"182.69991ms","start":"2026-06-24T10:58:41.175596Z","end":"2026-06-24T10:58:41.358296Z","steps":["trace[732649879] 'process raft request' (duration: 156.871572ms)","trace[732649879] 'compare' (duration: 25.668186ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:41.358624Z","caller":"traceutil/trace.go:171","msg":"trace[1870098576] transaction","detail":"{read_only:false; response_revision:754; number_of_response:1; }","duration":"126.358053ms","start":"2026-06-24T10:58:41.232257Z","end":"2026-06-24T10:58:41.358615Z","steps":["trace[1870098576] 'process raft request' (duration: 126.234161ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:41.358737Z","caller":"traceutil/trace.go:171","msg":"trace[592598181] transaction","detail":"{read_only:false; response_revision:753; number_of_response:1; }","duration":"180.070359ms","start":"2026-06-24T10:58:41.178636Z","end":"2026-06-24T10:58:41.358706Z","steps":["trace[592598181] 'process raft request' (duration: 179.619373ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:41.469107Z","caller":"traceutil/trace.go:171","msg":"trace[1511504453] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"102.255623ms","start":"2026-06-24T10:58:41.366825Z","end":"2026-06-24T10:58:41.469081Z","steps":["trace[1511504453] 'process raft request' (duration: 95.931716ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:42.269086Z","caller":"traceutil/trace.go:171","msg":"trace[618230747] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"243.898617ms","start":"2026-06-24T10:58:42.025162Z","end":"2026-06-24T10:58:42.269061Z","steps":["trace[618230747] 'process raft request' (duration: 243.759255ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:42.475113Z","caller":"traceutil/trace.go:171","msg":"trace[828218660] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"438.134857ms","start":"2026-06-24T10:58:42.036948Z","end":"2026-06-24T10:58:42.475083Z","steps":["trace[828218660] 'process raft request' (duration: 437.958583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.475268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.036929Z","time spent":"438.261259ms","remote":"127.0.0.1:56174","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4315,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:42.500063Z","caller":"traceutil/trace.go:171","msg":"trace[1075322369] linearizableReadLoop","detail":"{readStateIndex:784; appliedIndex:782; }","duration":"443.205225ms","start":"2026-06-24T10:58:42.056828Z","end":"2026-06-24T10:58:42.500033Z","steps":["trace[1075322369] 'read index received' (duration: 212.076636ms)","trace[1075322369] 'applied index is now lower than readState.Index' (duration: 231.127089ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:42.500199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.336837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500266Z","caller":"traceutil/trace.go:171","msg":"trace[208005615] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:758; }","duration":"443.45163ms","start":"2026-06-24T10:58:42.056803Z","end":"2026-06-24T10:58:42.500255Z","steps":["trace[208005615] 'agreement among raft nodes before linearized reading' (duration: 443.292776ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.056795Z","time spent":"443.50302ms","remote":"127.0.0.1:47144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":113,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-24T10:58:42.500331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.119156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500392Z","caller":"traceutil/trace.go:171","msg":"trace[184271229] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:758; }","duration":"267.208007ms","start":"2026-06-24T10:58:42.23317Z","end":"2026-06-24T10:58:42.500378Z","steps":["trace[184271229] 'agreement among raft nodes before linearized reading' (duration: 267.113936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.195987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500474Z","caller":"traceutil/trace.go:171","msg":"trace[808754650] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:758; }","duration":"412.264628ms","start":"2026-06-24T10:58:42.088184Z","end":"2026-06-24T10:58:42.500448Z","steps":["trace[808754650] 'agreement among raft nodes before linearized reading' (duration: 412.202237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.340444ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T10:58:42.500515Z","caller":"traceutil/trace.go:171","msg":"trace[1623332612] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:758; }","duration":"174.395784ms","start":"2026-06-24T10:58:42.326109Z","end":"2026-06-24T10:58:42.500505Z","steps":["trace[1623332612] 'agreement among raft nodes before linearized reading' (duration: 174.337113ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.088168Z","time spent":"412.340389ms","remote":"127.0.0.1:47148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":91,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-24T10:58:42.500528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.072558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500564Z","caller":"traceutil/trace.go:171","msg":"trace[725312417] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:758; }","duration":"251.1509ms","start":"2026-06-24T10:58:42.249401Z","end":"2026-06-24T10:58:42.500552Z","steps":["trace[725312417] 'agreement among raft nodes before linearized reading' (duration: 251.087669ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.765229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500669Z","caller":"traceutil/trace.go:171","msg":"trace[817276000] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:758; }","duration":"251.8723ms","start":"2026-06-24T10:58:42.248774Z","end":"2026-06-24T10:58:42.500647Z","steps":["trace[817276000] 'agreement among raft nodes before linearized reading' (duration: 251.726968ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.770462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-24T10:58:42.500672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.465626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T10:58:42.500736Z","caller":"traceutil/trace.go:171","msg":"trace[1378238508] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:758; }","duration":"190.110307ms","start":"2026-06-24T10:58:42.310618Z","end":"2026-06-24T10:58:42.500729Z","steps":["trace[1378238508] 'agreement among raft nodes before linearized reading' (duration: 189.69582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.50074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.041533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500772Z","caller":"traceutil/trace.go:171","msg":"trace[1972839690] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:758; }","duration":"252.105844ms","start":"2026-06-24T10:58:42.248658Z","end":"2026-06-24T10:58:42.500764Z","steps":["trace[1972839690] 'agreement among raft nodes before linearized reading' (duration: 252.049973ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.38401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500782Z","caller":"traceutil/trace.go:171","msg":"trace[1677155020] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:758; }","duration":"174.647518ms","start":"2026-06-24T10:58:42.326109Z","end":"2026-06-24T10:58:42.500757Z","steps":["trace[1677155020] 'agreement among raft nodes before linearized reading' (duration: 174.294573ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:42.500818Z","caller":"traceutil/trace.go:171","msg":"trace[155253519] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:758; }","duration":"412.487542ms","start":"2026-06-24T10:58:42.088324Z","end":"2026-06-24T10:58:42.500811Z","steps":["trace[155253519] 'agreement among raft nodes before linearized reading' (duration: 412.36728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.412259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T10:58:42.500847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.088307Z","time spent":"412.529202ms","remote":"127.0.0.1:47148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" count_only:true "} {"level":"info","ts":"2026-06-24T10:58:42.500854Z","caller":"traceutil/trace.go:171","msg":"trace[763640632] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:758; }","duration":"443.462259ms","start":"2026-06-24T10:58:42.057381Z","end":"2026-06-24T10:58:42.500843Z","steps":["trace[763640632] 'agreement among raft nodes before linearized reading' (duration: 443.404898ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.5009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.057376Z","time spent":"443.51465ms","remote":"127.0.0.1:47144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" limit:10 "} {"level":"warn","ts":"2026-06-24T10:58:42.500954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.943663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.500972Z","caller":"traceutil/trace.go:171","msg":"trace[905070517] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:758; }","duration":"389.978103ms","start":"2026-06-24T10:58:42.110989Z","end":"2026-06-24T10:58:42.500967Z","steps":["trace[905070517] 'agreement among raft nodes before linearized reading' (duration: 389.949703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.500988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.110982Z","time spent":"390.002603ms","remote":"127.0.0.1:47112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"warn","ts":"2026-06-24T10:58:42.501062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.265668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/instance\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T10:58:42.501086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.892388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.501122Z","caller":"traceutil/trace.go:171","msg":"trace[1997988567] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/instance; range_end:; response_count:0; response_revision:758; }","duration":"390.365049ms","start":"2026-06-24T10:58:42.110744Z","end":"2026-06-24T10:58:42.501109Z","steps":["trace[1997988567] 'agreement among raft nodes before linearized reading' (duration: 390.270718ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:42.501125Z","caller":"traceutil/trace.go:171","msg":"trace[2020746864] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:758; }","duration":"267.970678ms","start":"2026-06-24T10:58:42.233143Z","end":"2026-06-24T10:58:42.501113Z","steps":["trace[2020746864] 'agreement among raft nodes before linearized reading' (duration: 267.911267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.501156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.110724Z","time spent":"390.424281ms","remote":"127.0.0.1:47112","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodes/instance\" "} {"level":"warn","ts":"2026-06-24T10:58:42.500334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.371108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T10:58:42.50143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.45732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:42.501491Z","caller":"traceutil/trace.go:171","msg":"trace[603849156] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:758; }","duration":"444.586927ms","start":"2026-06-24T10:58:42.056891Z","end":"2026-06-24T10:58:42.501477Z","steps":["trace[603849156] 'agreement among raft nodes before linearized reading' (duration: 443.364849ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:42.501507Z","caller":"traceutil/trace.go:171","msg":"trace[956308232] range","detail":"{range_begin:/registry/cilium.io/ciliumnetworkpolicies/; range_end:/registry/cilium.io/ciliumnetworkpolicies0; response_count:0; response_revision:758; }","duration":"412.537621ms","start":"2026-06-24T10:58:42.088952Z","end":"2026-06-24T10:58:42.50149Z","steps":["trace[956308232] 'agreement among raft nodes before linearized reading' (duration: 411.412784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:42.501533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.056867Z","time spent":"444.651377ms","remote":"127.0.0.1:47144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T10:58:42.501558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:42.088901Z","time spent":"412.645463ms","remote":"127.0.0.1:47148","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumnetworkpolicies0\" limit:10 "} {"level":"info","ts":"2026-06-24T10:58:47.332121Z","caller":"traceutil/trace.go:171","msg":"trace[1500289745] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"194.881544ms","start":"2026-06-24T10:58:47.137215Z","end":"2026-06-24T10:58:47.332096Z","steps":["trace[1500289745] 'process raft request' (duration: 194.717071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:50.654043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"902.638085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T10:58:50.654069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"934.242806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ddcqg\" ","response":"range_response_count:1 size:3963"} {"level":"info","ts":"2026-06-24T10:58:50.654117Z","caller":"traceutil/trace.go:171","msg":"trace[1103182652] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"902.751846ms","start":"2026-06-24T10:58:49.751347Z","end":"2026-06-24T10:58:50.654099Z","steps":["trace[1103182652] 'range keys from in-memory index tree' (duration: 902.572024ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:50.654149Z","caller":"traceutil/trace.go:171","msg":"trace[160833248] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ddcqg; range_end:; response_count:1; response_revision:814; }","duration":"934.337867ms","start":"2026-06-24T10:58:49.71979Z","end":"2026-06-24T10:58:50.654128Z","steps":["trace[160833248] 'range keys from in-memory index tree' (duration: 934.062983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:50.654184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:49.751334Z","time spent":"902.842207ms","remote":"127.0.0.1:55964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T10:58:50.654196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:49.719733Z","time spent":"934.453549ms","remote":"127.0.0.1:56186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3986,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ddcqg\" "} {"level":"info","ts":"2026-06-24T10:58:50.733146Z","caller":"traceutil/trace.go:171","msg":"trace[1782103230] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"840.296218ms","start":"2026-06-24T10:58:49.892821Z","end":"2026-06-24T10:58:50.733117Z","steps":["trace[1782103230] 'process raft request' (duration: 840.114004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:50.733363Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:49.892791Z","time spent":"840.495412ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T10:58:50.733958Z","caller":"traceutil/trace.go:171","msg":"trace[2110679458] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:845; }","duration":"439.201106ms","start":"2026-06-24T10:58:50.294743Z","end":"2026-06-24T10:58:50.733944Z","steps":["trace[2110679458] 'read index received' (duration: 439.195726ms)","trace[2110679458] 'applied index is now lower than readState.Index' (duration: 4.38µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:50.734169Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.405169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T10:58:50.734229Z","caller":"traceutil/trace.go:171","msg":"trace[506372926] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:815; }","duration":"439.514931ms","start":"2026-06-24T10:58:50.294698Z","end":"2026-06-24T10:58:50.734213Z","steps":["trace[506372926] 'agreement among raft nodes before linearized reading' (duration: 439.331868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:50.734263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T10:58:50.294678Z","time spent":"439.577133ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T10:58:50.748109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.687581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T10:58:50.748149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.063681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T10:58:50.748188Z","caller":"traceutil/trace.go:171","msg":"trace[411226897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:816; }","duration":"200.815432ms","start":"2026-06-24T10:58:50.547355Z","end":"2026-06-24T10:58:50.74817Z","steps":["trace[411226897] 'agreement among raft nodes before linearized reading' (duration: 200.517518ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:50.748234Z","caller":"traceutil/trace.go:171","msg":"trace[1122266844] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:816; }","duration":"195.156232ms","start":"2026-06-24T10:58:50.553059Z","end":"2026-06-24T10:58:50.748215Z","steps":["trace[1122266844] 'agreement among raft nodes before linearized reading' (duration: 194.952039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:50.748383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.366086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T10:58:50.748442Z","caller":"traceutil/trace.go:171","msg":"trace[132868732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:816; }","duration":"195.449748ms","start":"2026-06-24T10:58:50.552977Z","end":"2026-06-24T10:58:50.748427Z","steps":["trace[132868732] 'agreement among raft nodes before linearized reading' (duration: 195.256044ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:55.05988Z","caller":"traceutil/trace.go:171","msg":"trace[371379615] transaction","detail":"{read_only:false; response_revision:832; number_of_response:1; }","duration":"204.377161ms","start":"2026-06-24T10:58:54.855482Z","end":"2026-06-24T10:58:55.059859Z","steps":["trace[371379615] 'process raft request' (duration: 156.88724ms)","trace[371379615] 'compare' (duration: 47.38191ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:55.060275Z","caller":"traceutil/trace.go:171","msg":"trace[153988799] transaction","detail":"{read_only:false; response_revision:833; number_of_response:1; }","duration":"204.605734ms","start":"2026-06-24T10:58:54.855649Z","end":"2026-06-24T10:58:55.060255Z","steps":["trace[153988799] 'process raft request' (duration: 204.175388ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:55.060322Z","caller":"traceutil/trace.go:171","msg":"trace[1474311612] linearizableReadLoop","detail":"{readStateIndex:866; appliedIndex:861; }","duration":"174.877603ms","start":"2026-06-24T10:58:54.885421Z","end":"2026-06-24T10:58:55.060298Z","steps":["trace[1474311612] 'read index received' (duration: 15.554311ms)","trace[1474311612] 'applied index is now lower than readState.Index' (duration: 159.322372ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:55.060509Z","caller":"traceutil/trace.go:171","msg":"trace[309836566] transaction","detail":"{read_only:false; response_revision:835; number_of_response:1; }","duration":"200.709472ms","start":"2026-06-24T10:58:54.859751Z","end":"2026-06-24T10:58:55.060461Z","steps":["trace[309836566] 'process raft request' (duration: 200.480408ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:58:55.060818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.273719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T10:58:55.060869Z","caller":"traceutil/trace.go:171","msg":"trace[1278852013] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:835; }","duration":"175.469344ms","start":"2026-06-24T10:58:54.885387Z","end":"2026-06-24T10:58:55.060856Z","steps":["trace[1278852013] 'agreement among raft nodes before linearized reading' (duration: 175.108467ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:55.060923Z","caller":"traceutil/trace.go:171","msg":"trace[1091699506] transaction","detail":"{read_only:false; response_revision:834; number_of_response:1; }","duration":"204.964482ms","start":"2026-06-24T10:58:54.85594Z","end":"2026-06-24T10:58:55.060905Z","steps":["trace[1091699506] 'process raft request' (duration: 204.172908ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:58:55.225965Z","caller":"traceutil/trace.go:171","msg":"trace[439158965] transaction","detail":"{read_only:false; response_revision:836; number_of_response:1; }","duration":"158.184029ms","start":"2026-06-24T10:58:55.067753Z","end":"2026-06-24T10:58:55.225937Z","steps":["trace[439158965] 'process raft request' (duration: 115.378204ms)","trace[439158965] 'compare' (duration: 42.660502ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:55.555965Z","caller":"traceutil/trace.go:171","msg":"trace[844691558] linearizableReadLoop","detail":"{readStateIndex:870; appliedIndex:869; }","duration":"130.361427ms","start":"2026-06-24T10:58:55.425573Z","end":"2026-06-24T10:58:55.555935Z","steps":["trace[844691558] 'read index received' (duration: 61.595551ms)","trace[844691558] 'applied index is now lower than readState.Index' (duration: 68.764676ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:58:55.556129Z","caller":"traceutil/trace.go:171","msg":"trace[1147615024] transaction","detail":"{read_only:false; response_revision:839; number_of_response:1; }","duration":"210.891244ms","start":"2026-06-24T10:58:55.345205Z","end":"2026-06-24T10:58:55.556097Z","steps":["trace[1147615024] 'process raft request' (duration: 142.049636ms)","trace[1147615024] 'compare' (duration: 68.526873ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T10:58:55.556409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.819654ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T10:58:55.556461Z","caller":"traceutil/trace.go:171","msg":"trace[905067982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:839; }","duration":"130.942267ms","start":"2026-06-24T10:58:55.425508Z","end":"2026-06-24T10:58:55.55645Z","steps":["trace[905067982] 'agreement among raft nodes before linearized reading' (duration: 130.54153ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:59:09.244937Z","caller":"traceutil/trace.go:171","msg":"trace[1065432012] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"102.585127ms","start":"2026-06-24T10:59:09.142322Z","end":"2026-06-24T10:59:09.244907Z","steps":["trace[1065432012] 'process raft request' (duration: 52.363496ms)","trace[1065432012] 'compare' (duration: 50.048058ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:59:12.876616Z","caller":"traceutil/trace.go:171","msg":"trace[1838354099] transaction","detail":"{read_only:false; response_revision:1018; number_of_response:1; }","duration":"116.430196ms","start":"2026-06-24T10:59:12.760162Z","end":"2026-06-24T10:59:12.876592Z","steps":["trace[1838354099] 'process raft request' (duration: 116.283454ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T10:59:31.2661Z","caller":"traceutil/trace.go:171","msg":"trace[1443720926] linearizableReadLoop","detail":"{readStateIndex:1120; appliedIndex:1119; }","duration":"137.093253ms","start":"2026-06-24T10:59:31.128986Z","end":"2026-06-24T10:59:31.266079Z","steps":["trace[1443720926] 'read index received' (duration: 136.882019ms)","trace[1443720926] 'applied index is now lower than readState.Index' (duration: 210.324µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T10:59:31.2662Z","caller":"traceutil/trace.go:171","msg":"trace[2049730021] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"230.081763ms","start":"2026-06-24T10:59:31.036088Z","end":"2026-06-24T10:59:31.26617Z","steps":["trace[2049730021] 'process raft request' (duration: 229.86894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T10:59:31.266244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.248036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T10:59:31.266277Z","caller":"traceutil/trace.go:171","msg":"trace[36364042] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1082; }","duration":"137.334227ms","start":"2026-06-24T10:59:31.128934Z","end":"2026-06-24T10:59:31.266268Z","steps":["trace[36364042] 'agreement among raft nodes before linearized reading' (duration: 137.256776ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:13.792105Z","caller":"traceutil/trace.go:171","msg":"trace[1823406197] linearizableReadLoop","detail":"{readStateIndex:1269; appliedIndex:1268; }","duration":"106.164266ms","start":"2026-06-24T11:00:13.685912Z","end":"2026-06-24T11:00:13.792076Z","steps":["trace[1823406197] 'read index received' (duration: 105.85365ms)","trace[1823406197] 'applied index is now lower than readState.Index' (duration: 309.466µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:13.792182Z","caller":"traceutil/trace.go:171","msg":"trace[2127757876] transaction","detail":"{read_only:false; response_revision:1222; number_of_response:1; }","duration":"150.900623ms","start":"2026-06-24T11:00:13.641241Z","end":"2026-06-24T11:00:13.792142Z","steps":["trace[2127757876] 'process raft request' (duration: 150.653958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:13.792545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.607604ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T11:00:13.792615Z","caller":"traceutil/trace.go:171","msg":"trace[328065682] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1222; }","duration":"106.693456ms","start":"2026-06-24T11:00:13.685877Z","end":"2026-06-24T11:00:13.79257Z","steps":["trace[328065682] 'agreement among raft nodes before linearized reading' (duration: 106.333339ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:14.046217Z","caller":"traceutil/trace.go:171","msg":"trace[1300887566] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"248.58411ms","start":"2026-06-24T11:00:13.797599Z","end":"2026-06-24T11:00:14.046183Z","steps":["trace[1300887566] 'process raft request' (duration: 152.742377ms)","trace[1300887566] 'compare' (duration: 95.518087ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:14.046257Z","caller":"traceutil/trace.go:171","msg":"trace[280435786] transaction","detail":"{read_only:false; response_revision:1224; number_of_response:1; }","duration":"248.457738ms","start":"2026-06-24T11:00:13.79776Z","end":"2026-06-24T11:00:14.046217Z","steps":["trace[280435786] 'process raft request' (duration: 248.320775ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:14.04627Z","caller":"traceutil/trace.go:171","msg":"trace[1010545283] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"247.600622ms","start":"2026-06-24T11:00:13.798608Z","end":"2026-06-24T11:00:14.046208Z","steps":["trace[1010545283] 'process raft request' (duration: 247.539921ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:23.713272Z","caller":"traceutil/trace.go:171","msg":"trace[1667578396] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"129.252358ms","start":"2026-06-24T11:00:23.583986Z","end":"2026-06-24T11:00:23.713239Z","steps":["trace[1667578396] 'process raft request' (duration: 128.998073ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:24.438895Z","caller":"traceutil/trace.go:171","msg":"trace[2030858589] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"258.219971ms","start":"2026-06-24T11:00:24.180647Z","end":"2026-06-24T11:00:24.438867Z","steps":["trace[2030858589] 'process raft request' (duration: 245.579603ms)","trace[2030858589] 'compare' (duration: 12.507666ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:24.476159Z","caller":"traceutil/trace.go:171","msg":"trace[1170213665] linearizableReadLoop","detail":"{readStateIndex:1307; appliedIndex:1305; }","duration":"188.11217ms","start":"2026-06-24T11:00:24.288016Z","end":"2026-06-24T11:00:24.476129Z","steps":["trace[1170213665] 'read index received' (duration: 138.224488ms)","trace[1170213665] 'applied index is now lower than readState.Index' (duration: 49.886422ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:24.476264Z","caller":"traceutil/trace.go:171","msg":"trace[442371232] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"294.945295ms","start":"2026-06-24T11:00:24.18129Z","end":"2026-06-24T11:00:24.476235Z","steps":["trace[442371232] 'process raft request' (duration: 294.664199ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:24.476428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.376655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T11:00:24.476469Z","caller":"traceutil/trace.go:171","msg":"trace[339750216] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1258; }","duration":"188.498687ms","start":"2026-06-24T11:00:24.287961Z","end":"2026-06-24T11:00:24.47646Z","steps":["trace[339750216] 'agreement among raft nodes before linearized reading' (duration: 188.287663ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:26.795143Z","caller":"traceutil/trace.go:171","msg":"trace[1192233198] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1311; }","duration":"314.233568ms","start":"2026-06-24T11:00:26.480888Z","end":"2026-06-24T11:00:26.795121Z","steps":["trace[1192233198] 'read index received' (duration: 314.017954ms)","trace[1192233198] 'applied index is now lower than readState.Index' (duration: 214.374µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:26.795322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.425191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T11:00:26.795348Z","caller":"traceutil/trace.go:171","msg":"trace[154063973] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1263; }","duration":"314.512143ms","start":"2026-06-24T11:00:26.480825Z","end":"2026-06-24T11:00:26.795337Z","steps":["trace[154063973] 'agreement among raft nodes before linearized reading' (duration: 314.409031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:26.795374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:26.480804Z","time spent":"314.564834ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T11:00:26.79533Z","caller":"traceutil/trace.go:171","msg":"trace[1565803162] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"346.892914ms","start":"2026-06-24T11:00:26.44836Z","end":"2026-06-24T11:00:26.795253Z","steps":["trace[1565803162] 'process raft request' (duration: 346.64597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:26.795483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.665675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T11:00:26.7955Z","caller":"traceutil/trace.go:171","msg":"trace[1143676403] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1263; }","duration":"296.723757ms","start":"2026-06-24T11:00:26.498772Z","end":"2026-06-24T11:00:26.795496Z","steps":["trace[1143676403] 'agreement among raft nodes before linearized reading' (duration: 296.677216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:26.795648Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:26.448335Z","time spent":"347.125929ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:28.043652Z","caller":"traceutil/trace.go:171","msg":"trace[1652592400] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"143.395173ms","start":"2026-06-24T11:00:27.900226Z","end":"2026-06-24T11:00:28.043621Z","steps":["trace[1652592400] 'process raft request' (duration: 82.167034ms)","trace[1652592400] 'compare' (duration: 60.758959ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:29.896767Z","caller":"traceutil/trace.go:171","msg":"trace[1347357170] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"188.545109ms","start":"2026-06-24T11:00:29.708151Z","end":"2026-06-24T11:00:29.896696Z","steps":["trace[1347357170] 'process raft request' (duration: 188.297405ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:30.380496Z","caller":"traceutil/trace.go:171","msg":"trace[338608051] linearizableReadLoop","detail":"{readStateIndex:1336; appliedIndex:1335; }","duration":"326.938705ms","start":"2026-06-24T11:00:30.053534Z","end":"2026-06-24T11:00:30.380473Z","steps":["trace[338608051] 'read index received' (duration: 326.73641ms)","trace[338608051] 'applied index is now lower than readState.Index' (duration: 200.805µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:30.380802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.209509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8a6e37c6-249b-45ba-b072-5fa9445d91f5\" ","response":"range_response_count:1 size:3577"} {"level":"info","ts":"2026-06-24T11:00:30.380849Z","caller":"traceutil/trace.go:171","msg":"trace[173803781] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8a6e37c6-249b-45ba-b072-5fa9445d91f5; range_end:; response_count:1; response_revision:1285; }","duration":"327.362152ms","start":"2026-06-24T11:00:30.053474Z","end":"2026-06-24T11:00:30.380836Z","steps":["trace[173803781] 'agreement among raft nodes before linearized reading' (duration: 327.123168ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:30.380891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:30.053431Z","time spent":"327.430603ms","remote":"127.0.0.1:56186","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3600,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8a6e37c6-249b-45ba-b072-5fa9445d91f5\" "} {"level":"warn","ts":"2026-06-24T11:00:30.380996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.259815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-24T11:00:30.381103Z","caller":"traceutil/trace.go:171","msg":"trace[1359352990] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1285; }","duration":"247.427008ms","start":"2026-06-24T11:00:30.133657Z","end":"2026-06-24T11:00:30.381084Z","steps":["trace[1359352990] 'agreement among raft nodes before linearized reading' (duration: 247.056531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:30.381122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.897903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T11:00:30.381271Z","caller":"traceutil/trace.go:171","msg":"trace[1622915854] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1285; }","duration":"118.120907ms","start":"2026-06-24T11:00:30.263118Z","end":"2026-06-24T11:00:30.381239Z","steps":["trace[1622915854] 'agreement among raft nodes before linearized reading' (duration: 117.651158ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:30.381139Z","caller":"traceutil/trace.go:171","msg":"trace[165004540] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"337.336171ms","start":"2026-06-24T11:00:30.043214Z","end":"2026-06-24T11:00:30.38055Z","steps":["trace[165004540] 'process raft request' (duration: 337.125267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:30.381461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:30.04319Z","time spent":"338.171916ms","remote":"127.0.0.1:47136","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2225,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T11:00:30.606416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.109195ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:00:30.606614Z","caller":"traceutil/trace.go:171","msg":"trace[108148066] transaction","detail":"{read_only:false; response_revision:1287; number_of_response:1; }","duration":"220.043798ms","start":"2026-06-24T11:00:30.38654Z","end":"2026-06-24T11:00:30.606584Z","steps":["trace[108148066] 'process raft request' (duration: 108.556516ms)","trace[108148066] 'compare' (duration: 110.33111ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:31.143691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.810798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:00:31.143764Z","caller":"traceutil/trace.go:171","msg":"trace[1146177025] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1288; }","duration":"161.92283ms","start":"2026-06-24T11:00:30.981825Z","end":"2026-06-24T11:00:31.143748Z","steps":["trace[1146177025] 'range keys from in-memory index tree' (duration: 161.644766ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:31.1441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.553152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T11:00:31.144174Z","caller":"traceutil/trace.go:171","msg":"trace[1389784281] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1288; }","duration":"161.655425ms","start":"2026-06-24T11:00:30.9825Z","end":"2026-06-24T11:00:31.144155Z","steps":["trace[1389784281] 'range keys from in-memory index tree' (duration: 161.368009ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:31.298666Z","caller":"traceutil/trace.go:171","msg":"trace[1296688142] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"149.213338ms","start":"2026-06-24T11:00:31.14942Z","end":"2026-06-24T11:00:31.298633Z","steps":["trace[1296688142] 'process raft request' (duration: 149.045465ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:31.324808Z","caller":"traceutil/trace.go:171","msg":"trace[1930777299] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"175.278804ms","start":"2026-06-24T11:00:31.149511Z","end":"2026-06-24T11:00:31.32479Z","steps":["trace[1930777299] 'process raft request' (duration: 175.157592ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:31.324958Z","caller":"traceutil/trace.go:171","msg":"trace[987600614] transaction","detail":"{read_only:false; response_revision:1291; number_of_response:1; }","duration":"169.27302ms","start":"2026-06-24T11:00:31.155676Z","end":"2026-06-24T11:00:31.324949Z","steps":["trace[987600614] 'process raft request' (duration: 169.077396ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:32.517818Z","caller":"traceutil/trace.go:171","msg":"trace[1893269881] linearizableReadLoop","detail":"{readStateIndex:1344; appliedIndex:1343; }","duration":"126.805646ms","start":"2026-06-24T11:00:32.39098Z","end":"2026-06-24T11:00:32.517785Z","steps":["trace[1893269881] 'read index received' (duration: 48.509209ms)","trace[1893269881] 'applied index is now lower than readState.Index' (duration: 78.293237ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:32.51827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.45399ms","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-06-24T11:00:32.518325Z","caller":"traceutil/trace.go:171","msg":"trace[274306351] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1292; }","duration":"106.531581ms","start":"2026-06-24T11:00:32.411779Z","end":"2026-06-24T11:00:32.51831Z","steps":["trace[274306351] 'agreement among raft nodes before linearized reading' (duration: 106.181275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:32.518599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.53025ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8a6e37c6-249b-45ba-b072-5fa9445d91f5\" ","response":"range_response_count:1 size:3577"} {"level":"info","ts":"2026-06-24T11:00:32.518714Z","caller":"traceutil/trace.go:171","msg":"trace[368972875] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8a6e37c6-249b-45ba-b072-5fa9445d91f5; range_end:; response_count:1; response_revision:1292; }","duration":"127.792695ms","start":"2026-06-24T11:00:32.390899Z","end":"2026-06-24T11:00:32.518691Z","steps":["trace[368972875] 'agreement among raft nodes before linearized reading' (duration: 127.049411ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:32.788134Z","caller":"traceutil/trace.go:171","msg":"trace[1859629599] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"173.168096ms","start":"2026-06-24T11:00:32.614942Z","end":"2026-06-24T11:00:32.78811Z","steps":["trace[1859629599] 'process raft request' (duration: 173.032503ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:34.227363Z","caller":"traceutil/trace.go:171","msg":"trace[51577694] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"154.613746ms","start":"2026-06-24T11:00:34.072723Z","end":"2026-06-24T11:00:34.227336Z","steps":["trace[51577694] 'process raft request' (duration: 154.465233ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:34.950942Z","caller":"traceutil/trace.go:171","msg":"trace[2055416034] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"154.937294ms","start":"2026-06-24T11:00:34.795979Z","end":"2026-06-24T11:00:34.950916Z","steps":["trace[2055416034] 'process raft request' (duration: 154.806831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:41.689158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.242671ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:00:41.689322Z","caller":"traceutil/trace.go:171","msg":"trace[1449374027] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"180.473621ms","start":"2026-06-24T11:00:41.508821Z","end":"2026-06-24T11:00:41.689295Z","steps":["trace[1449374027] 'read index received' (duration: 35.909544ms)","trace[1449374027] 'applied index is now lower than readState.Index' (duration: 144.562157ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:41.689353Z","caller":"traceutil/trace.go:171","msg":"trace[1783245127] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"251.372284ms","start":"2026-06-24T11:00:41.437951Z","end":"2026-06-24T11:00:41.689324Z","steps":["trace[1783245127] 'process raft request' (duration: 106.815176ms)","trace[1783245127] 'compare' (duration: 143.617699ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:41.689481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.648895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T11:00:41.689544Z","caller":"traceutil/trace.go:171","msg":"trace[1806008090] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:1344; }","duration":"180.762846ms","start":"2026-06-24T11:00:41.508765Z","end":"2026-06-24T11:00:41.689528Z","steps":["trace[1806008090] 'agreement among raft nodes before linearized reading' (duration: 180.600814ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:42.19614Z","caller":"traceutil/trace.go:171","msg":"trace[301767640] transaction","detail":"{read_only:false; response_revision:1345; number_of_response:1; }","duration":"242.039868ms","start":"2026-06-24T11:00:41.954063Z","end":"2026-06-24T11:00:42.196103Z","steps":["trace[301767640] 'process raft request' (duration: 241.808133ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:47.861753Z","caller":"traceutil/trace.go:171","msg":"trace[1011772919] linearizableReadLoop","detail":"{readStateIndex:1424; appliedIndex:1423; }","duration":"111.109763ms","start":"2026-06-24T11:00:47.750514Z","end":"2026-06-24T11:00:47.861623Z","steps":["trace[1011772919] 'read index received' (duration: 110.836448ms)","trace[1011772919] 'applied index is now lower than readState.Index' (duration: 271.375µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:47.861789Z","caller":"traceutil/trace.go:171","msg":"trace[23763295] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"121.613185ms","start":"2026-06-24T11:00:47.740136Z","end":"2026-06-24T11:00:47.86175Z","steps":["trace[23763295] 'process raft request' (duration: 121.248128ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:47.862264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.388708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:47.86232Z","caller":"traceutil/trace.go:171","msg":"trace[1573626040] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1368; }","duration":"111.825977ms","start":"2026-06-24T11:00:47.750479Z","end":"2026-06-24T11:00:47.862305Z","steps":["trace[1573626040] 'agreement among raft nodes before linearized reading' (duration: 111.382049ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:49.355101Z","caller":"traceutil/trace.go:171","msg":"trace[1245050363] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"139.687725ms","start":"2026-06-24T11:00:49.215386Z","end":"2026-06-24T11:00:49.355074Z","steps":["trace[1245050363] 'process raft request' (duration: 126.280148ms)","trace[1245050363] 'compare' (duration: 13.07356ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:49.895168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.622918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:49.895235Z","caller":"traceutil/trace.go:171","msg":"trace[1937918342] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1375; }","duration":"145.737651ms","start":"2026-06-24T11:00:49.749484Z","end":"2026-06-24T11:00:49.895221Z","steps":["trace[1937918342] 'range keys from in-memory index tree' (duration: 145.442375ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:50.033258Z","caller":"traceutil/trace.go:171","msg":"trace[199695496] transaction","detail":"{read_only:false; response_revision:1376; number_of_response:1; }","duration":"133.828073ms","start":"2026-06-24T11:00:49.899411Z","end":"2026-06-24T11:00:50.033239Z","steps":["trace[199695496] 'process raft request' (duration: 133.67052ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:50.481359Z","caller":"traceutil/trace.go:171","msg":"trace[138772952] linearizableReadLoop","detail":"{readStateIndex:1434; appliedIndex:1433; }","duration":"119.807705ms","start":"2026-06-24T11:00:50.361527Z","end":"2026-06-24T11:00:50.481335Z","steps":["trace[138772952] 'read index received' (duration: 59.171804ms)","trace[138772952] 'applied index is now lower than readState.Index' (duration: 60.634471ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:50.481439Z","caller":"traceutil/trace.go:171","msg":"trace[1016429392] transaction","detail":"{read_only:false; response_revision:1378; number_of_response:1; }","duration":"180.56959ms","start":"2026-06-24T11:00:50.300831Z","end":"2026-06-24T11:00:50.481401Z","steps":["trace[1016429392] 'process raft request' (duration: 119.931238ms)","trace[1016429392] 'compare' (duration: 60.433038ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:50.481608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.040151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:50.482398Z","caller":"traceutil/trace.go:171","msg":"trace[282426486] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1378; }","duration":"120.865256ms","start":"2026-06-24T11:00:50.361479Z","end":"2026-06-24T11:00:50.482344Z","steps":["trace[282426486] 'agreement among raft nodes before linearized reading' (duration: 120.016089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:51.772716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.159567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T11:00:51.772806Z","caller":"traceutil/trace.go:171","msg":"trace[1029310710] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1379; }","duration":"557.282339ms","start":"2026-06-24T11:00:51.215494Z","end":"2026-06-24T11:00:51.772776Z","steps":["trace[1029310710] 'range keys from in-memory index tree' (duration: 556.997533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:51.772859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:51.215471Z","time spent":"557.37124ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T11:00:51.77302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.143649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-24T11:00:51.773076Z","caller":"traceutil/trace.go:171","msg":"trace[1316373345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1379; }","duration":"413.23927ms","start":"2026-06-24T11:00:51.359824Z","end":"2026-06-24T11:00:51.773064Z","steps":["trace[1316373345] 'range keys from in-memory index tree' (duration: 413.014854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:51.773106Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:51.359803Z","time spent":"413.297592ms","remote":"127.0.0.1:56260","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-06-24T11:00:51.773088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.116072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:00:51.773284Z","caller":"traceutil/trace.go:171","msg":"trace[606912367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1379; }","duration":"181.394837ms","start":"2026-06-24T11:00:51.591867Z","end":"2026-06-24T11:00:51.773262Z","steps":["trace[606912367] 'range keys from in-memory index tree' (duration: 180.850836ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:52.031898Z","caller":"traceutil/trace.go:171","msg":"trace[310452108] transaction","detail":"{read_only:false; response_revision:1382; number_of_response:1; }","duration":"254.321744ms","start":"2026-06-24T11:00:51.777548Z","end":"2026-06-24T11:00:52.03187Z","steps":["trace[310452108] 'process raft request' (duration: 254.270853ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:52.032319Z","caller":"traceutil/trace.go:171","msg":"trace[566790495] transaction","detail":"{read_only:false; response_revision:1381; number_of_response:1; }","duration":"255.291104ms","start":"2026-06-24T11:00:51.776995Z","end":"2026-06-24T11:00:52.032286Z","steps":["trace[566790495] 'process raft request' (duration: 254.688542ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:52.551598Z","caller":"traceutil/trace.go:171","msg":"trace[468106364] transaction","detail":"{read_only:false; response_revision:1386; number_of_response:1; }","duration":"107.548642ms","start":"2026-06-24T11:00:52.444022Z","end":"2026-06-24T11:00:52.55157Z","steps":["trace[468106364] 'process raft request' (duration: 107.378988ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:52.596287Z","caller":"traceutil/trace.go:171","msg":"trace[557350179] transaction","detail":"{read_only:false; response_revision:1387; number_of_response:1; }","duration":"109.396839ms","start":"2026-06-24T11:00:52.486869Z","end":"2026-06-24T11:00:52.596265Z","steps":["trace[557350179] 'process raft request' (duration: 109.303356ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:53.698982Z","caller":"traceutil/trace.go:171","msg":"trace[1097162282] transaction","detail":"{read_only:false; response_revision:1391; number_of_response:1; }","duration":"101.855674ms","start":"2026-06-24T11:00:53.597102Z","end":"2026-06-24T11:00:53.698958Z","steps":["trace[1097162282] 'process raft request' (duration: 101.721871ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:06.238786Z","caller":"traceutil/trace.go:171","msg":"trace[26847483] linearizableReadLoop","detail":"{readStateIndex:1492; appliedIndex:1491; }","duration":"141.794794ms","start":"2026-06-24T11:01:06.096967Z","end":"2026-06-24T11:01:06.238762Z","steps":["trace[26847483] 'read index received' (duration: 141.591691ms)","trace[26847483] 'applied index is now lower than readState.Index' (duration: 202.203µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:06.238898Z","caller":"traceutil/trace.go:171","msg":"trace[2034932592] transaction","detail":"{read_only:false; response_revision:1432; number_of_response:1; }","duration":"145.817941ms","start":"2026-06-24T11:01:06.093051Z","end":"2026-06-24T11:01:06.238868Z","steps":["trace[2034932592] 'process raft request' (duration: 145.568457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:06.238992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.83268ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:node-bootstrapper\" ","response":"range_response_count:1 size:635"} {"level":"warn","ts":"2026-06-24T11:01:06.239029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.049119ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-24T11:01:06.239072Z","caller":"traceutil/trace.go:171","msg":"trace[585223894] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1432; }","duration":"142.10825ms","start":"2026-06-24T11:01:06.096951Z","end":"2026-06-24T11:01:06.23906Z","steps":["trace[585223894] 'agreement among raft nodes before linearized reading' (duration: 141.933697ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:06.239071Z","caller":"traceutil/trace.go:171","msg":"trace[48407374] range","detail":"{range_begin:/registry/clusterroles/system:node-bootstrapper; range_end:; response_count:1; response_revision:1432; }","duration":"105.955753ms","start":"2026-06-24T11:01:06.133094Z","end":"2026-06-24T11:01:06.23905Z","steps":["trace[48407374] 'agreement among raft nodes before linearized reading' (duration: 105.82022ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:06.348317Z","caller":"traceutil/trace.go:171","msg":"trace[625151382] transaction","detail":"{read_only:false; response_revision:1434; number_of_response:1; }","duration":"104.84053ms","start":"2026-06-24T11:01:06.24346Z","end":"2026-06-24T11:01:06.3483Z","steps":["trace[625151382] 'process raft request' (duration: 104.766659ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:06.348372Z","caller":"traceutil/trace.go:171","msg":"trace[1119024995] transaction","detail":"{read_only:false; response_revision:1433; number_of_response:1; }","duration":"105.214199ms","start":"2026-06-24T11:01:06.243144Z","end":"2026-06-24T11:01:06.348358Z","steps":["trace[1119024995] 'process raft request' (duration: 58.105001ms)","trace[1119024995] 'compare' (duration: 46.852583ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:08.048513Z","caller":"traceutil/trace.go:171","msg":"trace[1023682878] transaction","detail":"{read_only:false; response_revision:1438; number_of_response:1; }","duration":"132.854373ms","start":"2026-06-24T11:01:07.91563Z","end":"2026-06-24T11:01:08.048484Z","steps":["trace[1023682878] 'process raft request' (duration: 132.613148ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:08.508099Z","caller":"traceutil/trace.go:171","msg":"trace[1057113139] linearizableReadLoop","detail":"{readStateIndex:1502; appliedIndex:1500; }","duration":"118.544758ms","start":"2026-06-24T11:01:08.389534Z","end":"2026-06-24T11:01:08.508079Z","steps":["trace[1057113139] 'read index received' (duration: 30.373886ms)","trace[1057113139] 'applied index is now lower than readState.Index' (duration: 88.169842ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:08.508221Z","caller":"traceutil/trace.go:171","msg":"trace[1480655423] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"154.167605ms","start":"2026-06-24T11:01:08.35404Z","end":"2026-06-24T11:01:08.508208Z","steps":["trace[1480655423] 'process raft request' (duration: 65.856891ms)","trace[1480655423] 'compare' (duration: 88.009738ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:08.50829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.741952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/default\" ","response":"range_response_count:1 size:339"} {"level":"info","ts":"2026-06-24T11:01:08.508359Z","caller":"traceutil/trace.go:171","msg":"trace[585748638] range","detail":"{range_begin:/registry/namespaces/default; range_end:; response_count:1; response_revision:1441; }","duration":"118.847343ms","start":"2026-06-24T11:01:08.389494Z","end":"2026-06-24T11:01:08.508342Z","steps":["trace[585748638] 'agreement among raft nodes before linearized reading' (duration: 118.731591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:08.508464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.061681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/envoy-gateway-system\" ","response":"range_response_count:1 size:412"} {"level":"info","ts":"2026-06-24T11:01:08.508501Z","caller":"traceutil/trace.go:171","msg":"trace[345608518] range","detail":"{range_begin:/registry/namespaces/envoy-gateway-system; range_end:; response_count:1; response_revision:1441; }","duration":"113.132813ms","start":"2026-06-24T11:01:08.395356Z","end":"2026-06-24T11:01:08.508489Z","steps":["trace[345608518] 'agreement among raft nodes before linearized reading' (duration: 113.054002ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:08.508574Z","caller":"traceutil/trace.go:171","msg":"trace[1682409162] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"154.350109ms","start":"2026-06-24T11:01:08.354212Z","end":"2026-06-24T11:01:08.508562Z","steps":["trace[1682409162] 'process raft request' (duration: 153.824689ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:08.750749Z","caller":"traceutil/trace.go:171","msg":"trace[1696268721] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"102.664311ms","start":"2026-06-24T11:01:08.648057Z","end":"2026-06-24T11:01:08.750721Z","steps":["trace[1696268721] 'process raft request' (duration: 95.159506ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:10.347833Z","caller":"traceutil/trace.go:171","msg":"trace[1687282797] linearizableReadLoop","detail":"{readStateIndex:1505; appliedIndex:1504; }","duration":"287.533903ms","start":"2026-06-24T11:01:10.060286Z","end":"2026-06-24T11:01:10.34782Z","steps":["trace[1687282797] 'read index received' (duration: 287.41328ms)","trace[1687282797] 'applied index is now lower than readState.Index' (duration: 120.013µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:10.3479Z","caller":"traceutil/trace.go:171","msg":"trace[1942622632] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"290.720564ms","start":"2026-06-24T11:01:10.057172Z","end":"2026-06-24T11:01:10.347893Z","steps":["trace[1942622632] 'process raft request' (duration: 290.563401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:10.348109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.816428ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/default/\" range_end:\"/registry/deployments/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:01:10.348134Z","caller":"traceutil/trace.go:171","msg":"trace[1737420626] range","detail":"{range_begin:/registry/deployments/default/; range_end:/registry/deployments/default0; response_count:0; response_revision:1444; }","duration":"287.867758ms","start":"2026-06-24T11:01:10.060259Z","end":"2026-06-24T11:01:10.348127Z","steps":["trace[1737420626] 'agreement among raft nodes before linearized reading' (duration: 287.818747ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:10.348177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.283084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"info","ts":"2026-06-24T11:01:10.348277Z","caller":"traceutil/trace.go:171","msg":"trace[1929735851] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1444; }","duration":"264.422207ms","start":"2026-06-24T11:01:10.083837Z","end":"2026-06-24T11:01:10.348259Z","steps":["trace[1929735851] 'agreement among raft nodes before linearized reading' (duration: 264.171442ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:10.348281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.231485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/\" range_end:\"/registry/deployments/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:5641"} {"level":"info","ts":"2026-06-24T11:01:10.348439Z","caller":"traceutil/trace.go:171","msg":"trace[349151746] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/; range_end:/registry/deployments/envoy-gateway-system0; response_count:1; response_revision:1444; }","duration":"231.432879ms","start":"2026-06-24T11:01:10.116985Z","end":"2026-06-24T11:01:10.348418Z","steps":["trace[349151746] 'agreement among raft nodes before linearized reading' (duration: 231.104033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:10.576639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.712546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/envoy-gateway-system/kube-root-ca.crt\" ","response":"range_response_count:1 size:1764"} {"level":"info","ts":"2026-06-24T11:01:10.576719Z","caller":"traceutil/trace.go:171","msg":"trace[722796735] range","detail":"{range_begin:/registry/configmaps/envoy-gateway-system/kube-root-ca.crt; range_end:; response_count:1; response_revision:1445; }","duration":"156.837189ms","start":"2026-06-24T11:01:10.419864Z","end":"2026-06-24T11:01:10.576701Z","steps":["trace[722796735] 'range keys from in-memory index tree' (duration: 156.568024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:10.576894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.848068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/envoy-gateway-system/\" range_end:\"/registry/services/endpoints/envoy-gateway-system0\" limit:500 ","response":"range_response_count:1 size:1119"} {"level":"info","ts":"2026-06-24T11:01:10.577006Z","caller":"traceutil/trace.go:171","msg":"trace[910987879] range","detail":"{range_begin:/registry/services/endpoints/envoy-gateway-system/; range_end:/registry/services/endpoints/envoy-gateway-system0; response_count:1; response_revision:1445; }","duration":"145.00639ms","start":"2026-06-24T11:01:10.431982Z","end":"2026-06-24T11:01:10.576989Z","steps":["trace[910987879] 'range keys from in-memory index tree' (duration: 144.668314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:10.577356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.843012ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:5641"} {"level":"info","ts":"2026-06-24T11:01:10.577527Z","caller":"traceutil/trace.go:171","msg":"trace[1572498590] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1445; }","duration":"123.056187ms","start":"2026-06-24T11:01:10.454448Z","end":"2026-06-24T11:01:10.577505Z","steps":["trace[1572498590] 'range keys from in-memory index tree' (duration: 122.608298ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:10.637731Z","caller":"traceutil/trace.go:171","msg":"trace[1052787111] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"112.988722ms","start":"2026-06-24T11:01:10.524716Z","end":"2026-06-24T11:01:10.637705Z","steps":["trace[1052787111] 'process raft request' (duration: 112.84207ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:10.828078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.355611ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:01:10.828259Z","caller":"traceutil/trace.go:171","msg":"trace[182887713] linearizableReadLoop","detail":"{readStateIndex:1509; appliedIndex:1507; }","duration":"187.532752ms","start":"2026-06-24T11:01:10.64071Z","end":"2026-06-24T11:01:10.828243Z","steps":["trace[182887713] 'read index received' (duration: 61.975727ms)","trace[182887713] 'applied index is now lower than readState.Index' (duration: 125.556185ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:10.828365Z","caller":"traceutil/trace.go:171","msg":"trace[1095019631] transaction","detail":"{read_only:false; response_revision:1448; number_of_response:1; }","duration":"247.01097ms","start":"2026-06-24T11:01:10.581343Z","end":"2026-06-24T11:01:10.828354Z","steps":["trace[1095019631] 'process raft request' (duration: 246.828516ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:10.828499Z","caller":"traceutil/trace.go:171","msg":"trace[1355713941] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"247.153482ms","start":"2026-06-24T11:01:10.581315Z","end":"2026-06-24T11:01:10.828469Z","steps":["trace[1355713941] 'process raft request' (duration: 121.325802ms)","trace[1355713941] 'compare' (duration: 125.206938ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:10.828741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.024191ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/envoy-gateway-system/\" range_end:\"/registry/events/envoy-gateway-system0\" limit:500 ","response":"range_response_count:15 size:12285"} {"level":"info","ts":"2026-06-24T11:01:10.828804Z","caller":"traceutil/trace.go:171","msg":"trace[1029824207] range","detail":"{range_begin:/registry/events/envoy-gateway-system/; range_end:/registry/events/envoy-gateway-system0; response_count:15; response_revision:1448; }","duration":"188.169014ms","start":"2026-06-24T11:01:10.640617Z","end":"2026-06-24T11:01:10.828786Z","steps":["trace[1029824207] 'agreement among raft nodes before linearized reading' (duration: 187.815777ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:11.105662Z","caller":"traceutil/trace.go:171","msg":"trace[730752319] linearizableReadLoop","detail":"{readStateIndex:1510; appliedIndex:1509; }","duration":"277.308026ms","start":"2026-06-24T11:01:10.82832Z","end":"2026-06-24T11:01:11.105628Z","steps":["trace[730752319] 'read index received' (duration: 230.131865ms)","trace[730752319] 'applied index is now lower than readState.Index' (duration: 47.174451ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:11.105739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.609988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:01:11.105811Z","caller":"traceutil/trace.go:171","msg":"trace[1173766563] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1449; }","duration":"354.70862ms","start":"2026-06-24T11:01:10.751085Z","end":"2026-06-24T11:01:11.105794Z","steps":["trace[1173766563] 'agreement among raft nodes before linearized reading' (duration: 354.583907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:11.105811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.13099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:5641"} {"level":"warn","ts":"2026-06-24T11:01:11.105846Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.806714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/envoy-gateway-system/\" range_end:\"/registry/ingress/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T11:01:11.105865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:10.751077Z","time spent":"354.779551ms","remote":"127.0.0.1:55964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T11:01:11.105878Z","caller":"traceutil/trace.go:171","msg":"trace[1979641098] range","detail":"{range_begin:/registry/deployments/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1449; }","duration":"441.230161ms","start":"2026-06-24T11:01:10.664632Z","end":"2026-06-24T11:01:11.105862Z","steps":["trace[1979641098] 'agreement among raft nodes before linearized reading' (duration: 441.043098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:11.105921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.432813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/default/\" range_end:\"/registry/jobs/default0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T11:01:11.105929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:10.664621Z","time spent":"441.299142ms","remote":"127.0.0.1:56454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":5664,"request content":"key:\"/registry/deployments/envoy-gateway-system/envoy-gateway\" "} {"level":"info","ts":"2026-06-24T11:01:11.105953Z","caller":"traceutil/trace.go:171","msg":"trace[1760847614] range","detail":"{range_begin:/registry/jobs/default/; range_end:/registry/jobs/default0; response_count:0; response_revision:1449; }","duration":"458.476324ms","start":"2026-06-24T11:01:10.64747Z","end":"2026-06-24T11:01:11.105946Z","steps":["trace[1760847614] 'agreement among raft nodes before linearized reading' (duration: 458.433223ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:11.105995Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:10.647458Z","time spent":"458.527564ms","remote":"127.0.0.1:56242","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/default/\" range_end:\"/registry/jobs/default0\" limit:500 "} {"level":"info","ts":"2026-06-24T11:01:11.105884Z","caller":"traceutil/trace.go:171","msg":"trace[457364676] range","detail":"{range_begin:/registry/ingress/envoy-gateway-system/; range_end:/registry/ingress/envoy-gateway-system0; response_count:0; response_revision:1449; }","duration":"452.894266ms","start":"2026-06-24T11:01:10.652977Z","end":"2026-06-24T11:01:11.105871Z","steps":["trace[457364676] 'agreement among raft nodes before linearized reading' (duration: 452.801364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:11.10614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.426447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:420"} {"level":"warn","ts":"2026-06-24T11:01:11.106159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:10.652963Z","time spent":"453.182572ms","remote":"127.0.0.1:56294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/envoy-gateway-system/\" range_end:\"/registry/ingress/envoy-gateway-system0\" limit:500 "} {"level":"info","ts":"2026-06-24T11:01:11.106156Z","caller":"traceutil/trace.go:171","msg":"trace[2005285777] transaction","detail":"{read_only:false; response_revision:1449; number_of_response:1; }","duration":"350.775545ms","start":"2026-06-24T11:01:10.755357Z","end":"2026-06-24T11:01:11.106132Z","steps":["trace[2005285777] 'process raft request' (duration: 303.081894ms)","trace[2005285777] 'compare' (duration: 46.919936ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:11.106191Z","caller":"traceutil/trace.go:171","msg":"trace[190446896] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1449; }","duration":"207.508179ms","start":"2026-06-24T11:01:10.898671Z","end":"2026-06-24T11:01:11.106179Z","steps":["trace[190446896] 'agreement among raft nodes before linearized reading' (duration: 207.406727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:11.106257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:10.755347Z","time spent":"350.852616ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:01:12.558769Z","caller":"traceutil/trace.go:171","msg":"trace[1925023813] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1511; }","duration":"196.981606ms","start":"2026-06-24T11:01:12.361751Z","end":"2026-06-24T11:01:12.558732Z","steps":["trace[1925023813] 'read index received' (duration: 196.920215ms)","trace[1925023813] 'applied index is now lower than readState.Index' (duration: 60.431µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:12.558873Z","caller":"traceutil/trace.go:171","msg":"trace[18901342] transaction","detail":"{read_only:false; response_revision:1451; number_of_response:1; }","duration":"201.229459ms","start":"2026-06-24T11:01:12.35763Z","end":"2026-06-24T11:01:12.55886Z","steps":["trace[18901342] 'process raft request' (duration: 200.976294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:12.559136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.361463ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T11:01:12.55919Z","caller":"traceutil/trace.go:171","msg":"trace[1619737745] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1451; }","duration":"197.444316ms","start":"2026-06-24T11:01:12.361733Z","end":"2026-06-24T11:01:12.559177Z","steps":["trace[1619737745] 'agreement among raft nodes before linearized reading' (duration: 197.202451ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:12.579135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.198991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:912"} {"level":"info","ts":"2026-06-24T11:01:12.579178Z","caller":"traceutil/trace.go:171","msg":"trace[579454580] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:1452; }","duration":"212.259641ms","start":"2026-06-24T11:01:12.366908Z","end":"2026-06-24T11:01:12.579168Z","steps":["trace[579454580] 'agreement among raft nodes before linearized reading' (duration: 212.132249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:12.579336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.546635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager\" ","response":"range_response_count:1 size:1304"} {"level":"info","ts":"2026-06-24T11:01:12.579429Z","caller":"traceutil/trace.go:171","msg":"trace[256398984] range","detail":"{range_begin:/registry/roles/envoy-gateway-system/envoy-gateway-gateway-helm-infra-manager; range_end:; response_count:1; response_revision:1452; }","duration":"200.675488ms","start":"2026-06-24T11:01:12.378725Z","end":"2026-06-24T11:01:12.579401Z","steps":["trace[256398984] 'agreement among raft nodes before linearized reading' (duration: 200.477494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:12.579569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.904361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/envoy-gateway-system/\" range_end:\"/registry/serviceaccounts/envoy-gateway-system0\" limit:500 ","response":"range_response_count:3 size:1862"} {"level":"info","ts":"2026-06-24T11:01:12.579643Z","caller":"traceutil/trace.go:171","msg":"trace[1129267004] range","detail":"{range_begin:/registry/serviceaccounts/envoy-gateway-system/; range_end:/registry/serviceaccounts/envoy-gateway-system0; response_count:3; response_revision:1452; }","duration":"158.016134ms","start":"2026-06-24T11:01:12.421604Z","end":"2026-06-24T11:01:12.57962Z","steps":["trace[1129267004] 'agreement among raft nodes before linearized reading' (duration: 157.594546ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:15.113579Z","caller":"traceutil/trace.go:171","msg":"trace[28685676] linearizableReadLoop","detail":"{readStateIndex:1523; appliedIndex:1522; }","duration":"223.237707ms","start":"2026-06-24T11:01:14.890301Z","end":"2026-06-24T11:01:15.113538Z","steps":["trace[28685676] 'read index received' (duration: 203.72918ms)","trace[28685676] 'applied index is now lower than readState.Index' (duration: 19.507157ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:15.113748Z","caller":"traceutil/trace.go:171","msg":"trace[260404188] transaction","detail":"{read_only:false; response_revision:1461; number_of_response:1; }","duration":"252.253198ms","start":"2026-06-24T11:01:14.86148Z","end":"2026-06-24T11:01:15.113734Z","steps":["trace[260404188] 'process raft request' (duration: 232.439725ms)","trace[260404188] 'compare' (duration: 19.429296ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:15.113954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.91774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/local-path-storage/\" range_end:\"/registry/deployments/local-path-storage0\" limit:500 ","response":"range_response_count:1 size:3760"} {"level":"info","ts":"2026-06-24T11:01:15.114043Z","caller":"traceutil/trace.go:171","msg":"trace[2039991020] range","detail":"{range_begin:/registry/deployments/local-path-storage/; range_end:/registry/deployments/local-path-storage0; response_count:1; response_revision:1461; }","duration":"195.047482ms","start":"2026-06-24T11:01:14.918975Z","end":"2026-06-24T11:01:15.114023Z","steps":["trace[2039991020] 'agreement among raft nodes before linearized reading' (duration: 194.796308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.114176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.825993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/local-path-storage/\" range_end:\"/registry/services/endpoints/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:01:15.114219Z","caller":"traceutil/trace.go:171","msg":"trace[149992973] range","detail":"{range_begin:/registry/services/endpoints/local-path-storage/; range_end:/registry/services/endpoints/local-path-storage0; response_count:0; response_revision:1461; }","duration":"141.932045ms","start":"2026-06-24T11:01:14.972275Z","end":"2026-06-24T11:01:15.114207Z","steps":["trace[149992973] 'agreement among raft nodes before linearized reading' (duration: 141.844863ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.114299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.512313ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/cilium-config\" ","response":"range_response_count:1 size:6531"} {"level":"info","ts":"2026-06-24T11:01:15.114335Z","caller":"traceutil/trace.go:171","msg":"trace[794037188] range","detail":"{range_begin:/registry/configmaps/kube-system/cilium-config; range_end:; response_count:1; response_revision:1461; }","duration":"146.588634ms","start":"2026-06-24T11:01:14.967737Z","end":"2026-06-24T11:01:15.114325Z","steps":["trace[794037188] 'agreement among raft nodes before linearized reading' (duration: 146.504773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.114511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.202855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/kube-public/system:controller:bootstrap-signer\" ","response":"range_response_count:1 size:709"} {"level":"info","ts":"2026-06-24T11:01:15.11455Z","caller":"traceutil/trace.go:171","msg":"trace[1604272847] range","detail":"{range_begin:/registry/roles/kube-public/system:controller:bootstrap-signer; range_end:; response_count:1; response_revision:1461; }","duration":"224.268787ms","start":"2026-06-24T11:01:14.890269Z","end":"2026-06-24T11:01:15.114538Z","steps":["trace[1604272847] 'agreement among raft nodes before linearized reading' (duration: 224.163125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.58256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.030832ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:01:15.582669Z","caller":"traceutil/trace.go:171","msg":"trace[1001623817] linearizableReadLoop","detail":"{readStateIndex:1524; appliedIndex:1523; }","duration":"406.34268ms","start":"2026-06-24T11:01:15.176309Z","end":"2026-06-24T11:01:15.582651Z","steps":["trace[1001623817] 'read index received' (duration: 42.087214ms)","trace[1001623817] 'applied index is now lower than readState.Index' (duration: 364.254136ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:15.582758Z","caller":"traceutil/trace.go:171","msg":"trace[1037030026] transaction","detail":"{read_only:false; response_revision:1462; number_of_response:1; }","duration":"449.437293ms","start":"2026-06-24T11:01:15.133308Z","end":"2026-06-24T11:01:15.582745Z","steps":["trace[1037030026] 'process raft request' (duration: 85.108086ms)","trace[1037030026] 'compare' (duration: 363.738666ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:15.582821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:15.133289Z","time spent":"449.497025ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:01:15.582927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.186637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T11:01:15.582978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.856936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/kube-system/\" range_end:\"/registry/persistentvolumeclaims/kube-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:01:15.583011Z","caller":"traceutil/trace.go:171","msg":"trace[1823563750] range","detail":"{range_begin:/registry/persistentvolumeclaims/kube-system/; range_end:/registry/persistentvolumeclaims/kube-system0; response_count:0; response_revision:1462; }","duration":"291.936887ms","start":"2026-06-24T11:01:15.291063Z","end":"2026-06-24T11:01:15.582999Z","steps":["trace[1823563750] 'agreement among raft nodes before linearized reading' (duration: 291.880026ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:15.583008Z","caller":"traceutil/trace.go:171","msg":"trace[2064342380] range","detail":"{range_begin:/registry/ingress/local-path-storage/; range_end:/registry/ingress/local-path-storage0; response_count:0; response_revision:1462; }","duration":"391.307779ms","start":"2026-06-24T11:01:15.191684Z","end":"2026-06-24T11:01:15.582992Z","steps":["trace[2064342380] 'agreement among raft nodes before linearized reading' (duration: 391.156656ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.583051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:15.191671Z","time spent":"391.36988ms","remote":"127.0.0.1:56294","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":0,"response size":28,"request content":"key:\"/registry/ingress/local-path-storage/\" range_end:\"/registry/ingress/local-path-storage0\" limit:500 "} {"level":"warn","ts":"2026-06-24T11:01:15.583187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.87115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-24T11:01:15.583247Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.749969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" ","response":"range_response_count:1 size:3017"} {"level":"info","ts":"2026-06-24T11:01:15.58328Z","caller":"traceutil/trace.go:171","msg":"trace[187410652] range","detail":"{range_begin:/registry/configmaps/kube-system/extension-apiserver-authentication; range_end:; response_count:1; response_revision:1462; }","duration":"374.798729ms","start":"2026-06-24T11:01:15.208471Z","end":"2026-06-24T11:01:15.58327Z","steps":["trace[187410652] 'agreement among raft nodes before linearized reading' (duration: 374.727508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.583307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:15.208457Z","time spent":"374.843661ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":69,"response count":1,"response size":3040,"request content":"key:\"/registry/configmaps/kube-system/extension-apiserver-authentication\" "} {"level":"info","ts":"2026-06-24T11:01:15.583251Z","caller":"traceutil/trace.go:171","msg":"trace[1677172345] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1462; }","duration":"406.967532ms","start":"2026-06-24T11:01:15.176267Z","end":"2026-06-24T11:01:15.583235Z","steps":["trace[1677172345] 'agreement among raft nodes before linearized reading' (duration: 406.796998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.583394Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:15.17625Z","time spent":"407.130854ms","remote":"127.0.0.1:56260","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":"warn","ts":"2026-06-24T11:01:15.583298Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.289992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/kube-system/coredns\" ","response":"range_response_count:1 size:612"} {"level":"info","ts":"2026-06-24T11:01:15.583492Z","caller":"traceutil/trace.go:171","msg":"trace[468379434] range","detail":"{range_begin:/registry/configmaps/kube-system/coredns; range_end:; response_count:1; response_revision:1462; }","duration":"371.502446ms","start":"2026-06-24T11:01:15.211971Z","end":"2026-06-24T11:01:15.583473Z","steps":["trace[468379434] 'agreement among raft nodes before linearized reading' (duration: 371.214551ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:15.583979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:15.211964Z","time spent":"371.877794ms","remote":"127.0.0.1:56092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":635,"request content":"key:\"/registry/configmaps/kube-system/coredns\" "} {"level":"info","ts":"2026-06-24T11:01:15.752708Z","caller":"traceutil/trace.go:171","msg":"trace[285699114] transaction","detail":"{read_only:false; response_revision:1463; number_of_response:1; }","duration":"164.273657ms","start":"2026-06-24T11:01:15.588401Z","end":"2026-06-24T11:01:15.752675Z","steps":["trace[285699114] 'process raft request' (duration: 95.374955ms)","trace[285699114] 'compare' (duration: 68.771349ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:17.060468Z","caller":"traceutil/trace.go:171","msg":"trace[1214171320] linearizableReadLoop","detail":"{readStateIndex:1529; appliedIndex:1528; }","duration":"108.248395ms","start":"2026-06-24T11:01:16.952192Z","end":"2026-06-24T11:01:17.060441Z","steps":["trace[1214171320] 'read index received' (duration: 88.89997ms)","trace[1214171320] 'applied index is now lower than readState.Index' (duration: 19.346715ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:17.060687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.469629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/kube-system/kube-dns\" ","response":"range_response_count:1 size:912"} {"level":"info","ts":"2026-06-24T11:01:17.060755Z","caller":"traceutil/trace.go:171","msg":"trace[217078367] range","detail":"{range_begin:/registry/services/endpoints/kube-system/kube-dns; range_end:; response_count:1; response_revision:1466; }","duration":"108.584261ms","start":"2026-06-24T11:01:16.952157Z","end":"2026-06-24T11:01:17.060741Z","steps":["trace[217078367] 'agreement among raft nodes before linearized reading' (duration: 108.377467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:17.060703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.258859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/local-path-storage/kube-root-ca.crt\" ","response":"range_response_count:1 size:1760"} {"level":"info","ts":"2026-06-24T11:01:17.060823Z","caller":"traceutil/trace.go:171","msg":"trace[1935870189] range","detail":"{range_begin:/registry/configmaps/local-path-storage/kube-root-ca.crt; range_end:; response_count:1; response_revision:1466; }","duration":"102.398082ms","start":"2026-06-24T11:01:16.958401Z","end":"2026-06-24T11:01:17.060799Z","steps":["trace[1935870189] 'agreement among raft nodes before linearized reading' (duration: 102.197618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:20.8324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.674947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-24T11:01:20.832485Z","caller":"traceutil/trace.go:171","msg":"trace[614048311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1477; }","duration":"120.79949ms","start":"2026-06-24T11:01:20.711667Z","end":"2026-06-24T11:01:20.832467Z","steps":["trace[614048311] 'range keys from in-memory index tree' (duration: 120.484414ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:21.229573Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":14933266732911494480,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T11:01:21.248117Z","caller":"traceutil/trace.go:171","msg":"trace[220834401] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"522.291648ms","start":"2026-06-24T11:01:20.725808Z","end":"2026-06-24T11:01:21.248099Z","steps":["trace[220834401] 'process raft request' (duration: 522.171356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:21.248317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:20.725794Z","time spent":"522.39166ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:01:21.295188Z","caller":"traceutil/trace.go:171","msg":"trace[1809974492] linearizableReadLoop","detail":"{readStateIndex:1542; appliedIndex:1540; }","duration":"566.535196ms","start":"2026-06-24T11:01:20.728636Z","end":"2026-06-24T11:01:21.295171Z","steps":["trace[1809974492] 'read index received' (duration: 519.28782ms)","trace[1809974492] 'applied index is now lower than readState.Index' (duration: 47.246336ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:21.295277Z","caller":"traceutil/trace.go:171","msg":"trace[1477892158] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"459.125375ms","start":"2026-06-24T11:01:20.83614Z","end":"2026-06-24T11:01:21.295265Z","steps":["trace[1477892158] 'process raft request' (duration: 458.965092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:21.295349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:20.836118Z","time spent":"459.189796ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:01:21.29544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"554.980232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-24T11:01:21.295497Z","caller":"traceutil/trace.go:171","msg":"trace[611517975] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:1479; }","duration":"555.065623ms","start":"2026-06-24T11:01:20.740416Z","end":"2026-06-24T11:01:21.295481Z","steps":["trace[611517975] 'agreement among raft nodes before linearized reading' (duration: 554.980051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:21.295528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:20.740397Z","time spent":"555.124354ms","remote":"127.0.0.1:56204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-06-24T11:01:21.295548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.891642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-24T11:01:21.295651Z","caller":"traceutil/trace.go:171","msg":"trace[295402953] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:1479; }","duration":"567.026515ms","start":"2026-06-24T11:01:20.728604Z","end":"2026-06-24T11:01:21.295631Z","steps":["trace[295402953] 'agreement among raft nodes before linearized reading' (duration: 566.801261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:21.29571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:20.728597Z","time spent":"567.098607ms","remote":"127.0.0.1:56204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"warn","ts":"2026-06-24T11:01:21.29573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.253312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:01:21.295771Z","caller":"traceutil/trace.go:171","msg":"trace[1838036195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1479; }","duration":"546.309783ms","start":"2026-06-24T11:01:20.749448Z","end":"2026-06-24T11:01:21.295758Z","steps":["trace[1838036195] 'agreement among raft nodes before linearized reading' (duration: 546.243202ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:21.295823Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:20.74944Z","time spent":"546.376245ms","remote":"127.0.0.1:55956","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T11:01:21.295682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.795927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T11:01:21.295932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.059691ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T11:01:21.295971Z","caller":"traceutil/trace.go:171","msg":"trace[1627968920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1479; }","duration":"350.117264ms","start":"2026-06-24T11:01:20.945844Z","end":"2026-06-24T11:01:21.295962Z","steps":["trace[1627968920] 'agreement among raft nodes before linearized reading' (duration: 349.668175ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:21.295985Z","caller":"traceutil/trace.go:171","msg":"trace[1393184321] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1479; }","duration":"144.204244ms","start":"2026-06-24T11:01:21.151766Z","end":"2026-06-24T11:01:21.295971Z","steps":["trace[1393184321] 'agreement among raft nodes before linearized reading' (duration: 143.99167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:21.296002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:20.945832Z","time spent":"350.161894ms","remote":"127.0.0.1:56260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T11:01:21.462751Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.712651ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:01:21.462955Z","caller":"traceutil/trace.go:171","msg":"trace[1120254491] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"162.597351ms","start":"2026-06-24T11:01:21.300324Z","end":"2026-06-24T11:01:21.462922Z","steps":["trace[1120254491] 'process raft request' (duration: 61.628004ms)","trace[1120254491] 'compare' (duration: 100.09821ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:21.46338Z","caller":"traceutil/trace.go:171","msg":"trace[637907274] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1542; }","duration":"162.683232ms","start":"2026-06-24T11:01:21.300666Z","end":"2026-06-24T11:01:21.46335Z","steps":["trace[637907274] 'read index received' (duration: 61.280557ms)","trace[637907274] 'applied index is now lower than readState.Index' (duration: 101.400655ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:21.463549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.865776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"info","ts":"2026-06-24T11:01:21.463586Z","caller":"traceutil/trace.go:171","msg":"trace[2001856361] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:1481; }","duration":"162.917587ms","start":"2026-06-24T11:01:21.30066Z","end":"2026-06-24T11:01:21.463577Z","steps":["trace[2001856361] 'agreement among raft nodes before linearized reading' (duration: 162.798894ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:21.46378Z","caller":"traceutil/trace.go:171","msg":"trace[1802126239] transaction","detail":"{read_only:false; response_revision:1481; number_of_response:1; }","duration":"162.471828ms","start":"2026-06-24T11:01:21.301286Z","end":"2026-06-24T11:01:21.463758Z","steps":["trace[1802126239] 'process raft request' (duration: 161.575851ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:22.612601Z","caller":"traceutil/trace.go:171","msg":"trace[1673259741] linearizableReadLoop","detail":"{readStateIndex:1547; appliedIndex:1546; }","duration":"176.167115ms","start":"2026-06-24T11:01:22.436403Z","end":"2026-06-24T11:01:22.61257Z","steps":["trace[1673259741] 'read index received' (duration: 104.737931ms)","trace[1673259741] 'applied index is now lower than readState.Index' (duration: 71.427404ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:22.612807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.858163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T11:01:22.61286Z","caller":"traceutil/trace.go:171","msg":"trace[1394543607] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:1483; }","duration":"119.957765ms","start":"2026-06-24T11:01:22.492891Z","end":"2026-06-24T11:01:22.612849Z","steps":["trace[1394543607] 'agreement among raft nodes before linearized reading' (duration: 119.828103ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:22.613235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.811037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/\" range_end:\"/registry/events/kube-system0\" limit:500 ","response":"range_response_count:89 size:66220"} {"level":"info","ts":"2026-06-24T11:01:22.613319Z","caller":"traceutil/trace.go:171","msg":"trace[567211299] range","detail":"{range_begin:/registry/events/kube-system/; range_end:/registry/events/kube-system0; response_count:89; response_revision:1483; }","duration":"176.941879ms","start":"2026-06-24T11:01:22.43636Z","end":"2026-06-24T11:01:22.613301Z","steps":["trace[567211299] 'agreement among raft nodes before linearized reading' (duration: 176.349677ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:22.787951Z","caller":"traceutil/trace.go:171","msg":"trace[1743541283] linearizableReadLoop","detail":"{readStateIndex:1548; appliedIndex:1547; }","duration":"103.045308ms","start":"2026-06-24T11:01:22.684885Z","end":"2026-06-24T11:01:22.78793Z","steps":["trace[1743541283] 'read index received' (duration: 102.852944ms)","trace[1743541283] 'applied index is now lower than readState.Index' (duration: 191.554µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:22.788053Z","caller":"traceutil/trace.go:171","msg":"trace[2118750495] transaction","detail":"{read_only:false; response_revision:1484; number_of_response:1; }","duration":"146.47613ms","start":"2026-06-24T11:01:22.641554Z","end":"2026-06-24T11:01:22.78803Z","steps":["trace[2118750495] 'process raft request' (duration: 146.239995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:22.788142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.243211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-24T11:01:22.788194Z","caller":"traceutil/trace.go:171","msg":"trace[334616362] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:1484; }","duration":"103.329903ms","start":"2026-06-24T11:01:22.684847Z","end":"2026-06-24T11:01:22.788177Z","steps":["trace[334616362] 'agreement among raft nodes before linearized reading' (duration: 103.220721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:27.633626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.001462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-24T11:01:27.63369Z","caller":"traceutil/trace.go:171","msg":"trace[1290761210] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1499; }","duration":"131.131535ms","start":"2026-06-24T11:01:27.502544Z","end":"2026-06-24T11:01:27.633675Z","steps":["trace[1290761210] 'range keys from in-memory index tree' (duration: 130.82897ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:27.634113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.891745ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-24T11:01:27.634197Z","caller":"traceutil/trace.go:171","msg":"trace[1724496429] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1499; }","duration":"107.012806ms","start":"2026-06-24T11:01:27.527166Z","end":"2026-06-24T11:01:27.634179Z","steps":["trace[1724496429] 'range keys from in-memory index tree' (duration: 106.725051ms)"],"step_count":1}