{"level":"warn","ts":"2026-06-15T19:04:54.072571Z","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-15T19:04:54.072691Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.118: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.19.213.118:2380","--initial-cluster=instance=https://199.19.213.118:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.118:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.118: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-15T19:04:54.072801Z","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-15T19:04:54.072823Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-06-15T19:04:54.072853Z","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-15T19:04:54.073691Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"]} {"level":"info","ts":"2026-06-15T19:04:54.07379Z","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.19.213.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.118: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-15T19:04:54.084497Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"9.395491ms"} {"level":"info","ts":"2026-06-15T19:04:54.093857Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"511d8c552db01fa8","cluster-id":"8d545d29b73b98f3"} {"level":"info","ts":"2026-06-15T19:04:54.093941Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T19:04:54.093962Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 0"} {"level":"info","ts":"2026-06-15T19:04:54.093974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 511d8c552db01fa8 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T19:04:54.093982Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became follower at term 1"} {"level":"info","ts":"2026-06-15T19:04:54.094019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"warn","ts":"2026-06-15T19:04:54.099667Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T19:04:54.101425Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T19:04:54.102608Z","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-15T19:04:54.105239Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"511d8c552db01fa8","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T19:04:54.10705Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"511d8c552db01fa8","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T19:04:54.107898Z","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-15T19:04:54.108591Z","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-15T19:04:54.108614Z","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-15T19:04:54.108315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 switched to configuration voters=(5844982188863397800)"} {"level":"info","ts":"2026-06-15T19:04:54.108863Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","added-peer-id":"511d8c552db01fa8","added-peer-peer-urls":["https://199.19.213.118:2380"]} {"level":"info","ts":"2026-06-15T19:04:54.112116Z","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-15T19:04:54.112245Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-06-15T19:04:54.112291Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.118:2380"} {"level":"info","ts":"2026-06-15T19:04:54.112428Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"511d8c552db01fa8","initial-advertise-peer-urls":["https://199.19.213.118:2380"],"listen-peer-urls":["https://199.19.213.118:2380"],"advertise-client-urls":["https://199.19.213.118:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.118:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T19:04:54.112491Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T19:04:54.494775Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T19:04:54.494839Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T19:04:54.49488Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgPreVoteResp from 511d8c552db01fa8 at term 1"} {"level":"info","ts":"2026-06-15T19:04:54.494912Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became candidate at term 2"} {"level":"info","ts":"2026-06-15T19:04:54.494923Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 received MsgVoteResp from 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-06-15T19:04:54.494968Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"511d8c552db01fa8 became leader at term 2"} {"level":"info","ts":"2026-06-15T19:04:54.494983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 511d8c552db01fa8 elected leader 511d8c552db01fa8 at term 2"} {"level":"info","ts":"2026-06-15T19:04:54.495966Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"511d8c552db01fa8","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.118:2379]}","request-path":"/0/members/511d8c552db01fa8/attributes","cluster-id":"8d545d29b73b98f3","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T19:04:54.498979Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:04:54.499426Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:54.499561Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T19:04:54.499812Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T19:04:54.499916Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T19:04:54.501059Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T19:04:54.503206Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.118:2379"} {"level":"info","ts":"2026-06-15T19:04:54.508621Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8d545d29b73b98f3","local-member-id":"511d8c552db01fa8","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:54.50887Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:54.508895Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T19:04:59.292979Z","caller":"traceutil/trace.go:171","msg":"trace[1623192310] transaction","detail":"{read_only:false; response_revision:211; number_of_response:1; }","duration":"225.117821ms","start":"2026-06-15T19:04:59.067824Z","end":"2026-06-15T19:04:59.292942Z","steps":["trace[1623192310] 'process raft request' (duration: 142.020463ms)","trace[1623192310] 'compare' (duration: 82.885131ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:04:59.646098Z","caller":"traceutil/trace.go:171","msg":"trace[1384133100] transaction","detail":"{read_only:false; response_revision:220; number_of_response:1; }","duration":"135.83397ms","start":"2026-06-15T19:04:59.510233Z","end":"2026-06-15T19:04:59.646067Z","steps":["trace[1384133100] 'process raft request' (duration: 46.92606ms)","trace[1384133100] 'compare' (duration: 88.251099ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:04:59.646273Z","caller":"traceutil/trace.go:171","msg":"trace[1684413945] linearizableReadLoop","detail":"{readStateIndex:225; appliedIndex:224; }","duration":"130.797799ms","start":"2026-06-15T19:04:59.515436Z","end":"2026-06-15T19:04:59.646234Z","steps":["trace[1684413945] 'read index received' (duration: 41.736304ms)","trace[1684413945] 'applied index is now lower than readState.Index' (duration: 89.057585ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:04:59.646497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.028497ms","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-15T19:04:59.646582Z","caller":"traceutil/trace.go:171","msg":"trace[2114226829] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:220; }","duration":"131.159571ms","start":"2026-06-15T19:04:59.515403Z","end":"2026-06-15T19:04:59.646563Z","steps":["trace[2114226829] 'agreement among raft nodes before linearized reading' (duration: 130.925123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:04:59.646582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.128989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:04:59.646681Z","caller":"traceutil/trace.go:171","msg":"trace[1403038730] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:220; }","duration":"131.283585ms","start":"2026-06-15T19:04:59.515373Z","end":"2026-06-15T19:04:59.646657Z","steps":["trace[1403038730] 'agreement among raft nodes before linearized reading' (duration: 131.107139ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:06.322293Z","caller":"traceutil/trace.go:171","msg":"trace[1012050846] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"170.24178ms","start":"2026-06-15T19:05:06.152029Z","end":"2026-06-15T19:05:06.32227Z","steps":["trace[1012050846] 'process raft request' (duration: 170.083615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:06.470232Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.692268ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:05:06.47039Z","caller":"traceutil/trace.go:171","msg":"trace[796217562] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"144.91333ms","start":"2026-06-15T19:05:06.325452Z","end":"2026-06-15T19:05:06.470365Z","steps":["trace[796217562] 'process raft request' (duration: 17.252451ms)","trace[796217562] 'compare' (duration: 126.579024ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:06.471006Z","caller":"traceutil/trace.go:171","msg":"trace[898293710] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"141.277094ms","start":"2026-06-15T19:05:06.329708Z","end":"2026-06-15T19:05:06.470985Z","steps":["trace[898293710] 'process raft request' (duration: 141.15811ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:07.319685Z","caller":"traceutil/trace.go:171","msg":"trace[1053579403] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"159.856937ms","start":"2026-06-15T19:05:07.1598Z","end":"2026-06-15T19:05:07.319657Z","steps":["trace[1053579403] 'process raft request' (duration: 159.66052ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:08.419468Z","caller":"traceutil/trace.go:171","msg":"trace[1517443511] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"179.507405ms","start":"2026-06-15T19:05:08.239925Z","end":"2026-06-15T19:05:08.419432Z","steps":["trace[1517443511] 'process raft request' (duration: 121.711169ms)","trace[1517443511] 'compare' (duration: 57.59651ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:28.694088Z","caller":"traceutil/trace.go:171","msg":"trace[228211813] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"102.188145ms","start":"2026-06-15T19:05:28.591882Z","end":"2026-06-15T19:05:28.694071Z","steps":["trace[228211813] 'process raft request' (duration: 99.310804ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:34.882043Z","caller":"traceutil/trace.go:171","msg":"trace[1382600998] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"161.282133ms","start":"2026-06-15T19:05:34.720724Z","end":"2026-06-15T19:05:34.882006Z","steps":["trace[1382600998] 'process raft request' (duration: 161.107468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:35.111397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.29297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:35.112121Z","caller":"traceutil/trace.go:171","msg":"trace[1523878568] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:494; }","duration":"186.069394ms","start":"2026-06-15T19:05:34.92602Z","end":"2026-06-15T19:05:35.11209Z","steps":["trace[1523878568] 'range keys from in-memory index tree' (duration: 185.190027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:41.501749Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.088026ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:05:41.501831Z","caller":"traceutil/trace.go:171","msg":"trace[839207942] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"326.740858ms","start":"2026-06-15T19:05:41.175077Z","end":"2026-06-15T19:05:41.501818Z","steps":["trace[839207942] 'process raft request' (duration: 114.527258ms)","trace[839207942] 'compare' (duration: 211.923761ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:05:41.501866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:41.175057Z","time spent":"326.795851ms","remote":"127.0.0.1:34204","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:41.705229Z","caller":"traceutil/trace.go:171","msg":"trace[1281252003] linearizableReadLoop","detail":"{readStateIndex:624; appliedIndex:622; }","duration":"480.937155ms","start":"2026-06-15T19:05:41.224265Z","end":"2026-06-15T19:05:41.705202Z","steps":["trace[1281252003] 'read index received' (duration: 65.41223ms)","trace[1281252003] 'applied index is now lower than readState.Index' (duration: 415.523845ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:41.705338Z","caller":"traceutil/trace.go:171","msg":"trace[109618328] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"487.379182ms","start":"2026-06-15T19:05:41.217891Z","end":"2026-06-15T19:05:41.70527Z","steps":["trace[109618328] 'process raft request' (duration: 418.48194ms)","trace[109618328] 'compare' (duration: 68.703245ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:05:41.705535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"481.233295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:41.705609Z","caller":"traceutil/trace.go:171","msg":"trace[148280176] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:601; }","duration":"481.348409ms","start":"2026-06-15T19:05:41.22424Z","end":"2026-06-15T19:05:41.705589Z","steps":["trace[148280176] 'agreement among raft nodes before linearized reading' (duration: 481.189474ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:41.705647Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:41.217873Z","time spent":"487.65876ms","remote":"127.0.0.1:34104","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-15T19:05:41.705663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:41.224232Z","time spent":"481.421881ms","remote":"127.0.0.1:38166","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-15T19:05:41.705692Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.190006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:41.705788Z","caller":"traceutil/trace.go:171","msg":"trace[2118546625] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:601; }","duration":"190.365052ms","start":"2026-06-15T19:05:41.515409Z","end":"2026-06-15T19:05:41.705774Z","steps":["trace[2118546625] 'agreement among raft nodes before linearized reading' (duration: 190.165075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:41.705718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.944993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-2cxkq\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-15T19:05:41.706111Z","caller":"traceutil/trace.go:171","msg":"trace[865228725] range","detail":"{range_begin:/registry/pods/kube-system/cilium-2cxkq; range_end:; response_count:1; response_revision:601; }","duration":"454.340886ms","start":"2026-06-15T19:05:41.251718Z","end":"2026-06-15T19:05:41.706059Z","steps":["trace[865228725] 'agreement among raft nodes before linearized reading' (duration: 453.84595ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:41.706213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:41.2517Z","time spent":"454.479611ms","remote":"127.0.0.1:38332","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-2cxkq\" "} {"level":"warn","ts":"2026-06-15T19:05:43.053979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.68107ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:05:43.054089Z","caller":"traceutil/trace.go:171","msg":"trace[1077047702] linearizableReadLoop","detail":"{readStateIndex:625; appliedIndex:624; }","duration":"1.020450722s","start":"2026-06-15T19:05:42.033621Z","end":"2026-06-15T19:05:43.054071Z","steps":["trace[1077047702] 'read index received' (duration: 81.595237ms)","trace[1077047702] 'applied index is now lower than readState.Index' (duration: 938.853985ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:43.054171Z","caller":"traceutil/trace.go:171","msg":"trace[1531056312] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"1.333288476s","start":"2026-06-15T19:05:41.720867Z","end":"2026-06-15T19:05:43.054155Z","steps":["trace[1531056312] 'process raft request' (duration: 394.332708ms)","trace[1531056312] 'compare' (duration: 938.06036ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:05:43.054255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:41.72084Z","time spent":"1.333372349s","remote":"127.0.0.1:38332","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:05:43.054444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.020767672s","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-15T19:05:43.054552Z","caller":"traceutil/trace.go:171","msg":"trace[1844208753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:602; }","duration":"1.020951898s","start":"2026-06-15T19:05:42.033567Z","end":"2026-06-15T19:05:43.054519Z","steps":["trace[1844208753] 'agreement among raft nodes before linearized reading' (duration: 1.020616147s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:43.054607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:42.033546Z","time spent":"1.02104797s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-15T19:05:43.086901Z","caller":"traceutil/trace.go:171","msg":"trace[1676468350] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"965.174445ms","start":"2026-06-15T19:05:42.121692Z","end":"2026-06-15T19:05:43.086866Z","steps":["trace[1676468350] 'process raft request' (duration: 964.574416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:43.087111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:42.121666Z","time spent":"965.357732ms","remote":"127.0.0.1:38238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:05:43.115911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.975857ms","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-15T19:05:43.115984Z","caller":"traceutil/trace.go:171","msg":"trace[18164529] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:604; }","duration":"204.112071ms","start":"2026-06-15T19:05:42.911856Z","end":"2026-06-15T19:05:43.115968Z","steps":["trace[18164529] 'agreement among raft nodes before linearized reading' (duration: 203.949016ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:43.115995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.657724ms","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-15T19:05:43.11603Z","caller":"traceutil/trace.go:171","msg":"trace[1276802967] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:604; }","duration":"520.711116ms","start":"2026-06-15T19:05:42.595304Z","end":"2026-06-15T19:05:43.116015Z","steps":["trace[1276802967] 'agreement among raft nodes before linearized reading' (duration: 520.654794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:43.116058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:42.595288Z","time spent":"520.765838ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-15T19:05:43.116155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"889.24032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:05:43.115923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"944.745193ms","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-15T19:05:43.116177Z","caller":"traceutil/trace.go:171","msg":"trace[643276062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:604; }","duration":"889.299332ms","start":"2026-06-15T19:05:42.226872Z","end":"2026-06-15T19:05:43.116172Z","steps":["trace[643276062] 'agreement among raft nodes before linearized reading' (duration: 889.267141ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:43.116192Z","caller":"traceutil/trace.go:171","msg":"trace[2093335167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:604; }","duration":"945.083394ms","start":"2026-06-15T19:05:42.171101Z","end":"2026-06-15T19:05:43.116185Z","steps":["trace[2093335167] 'agreement among raft nodes before linearized reading' (duration: 944.704362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:43.116193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:42.226853Z","time spent":"889.336833ms","remote":"127.0.0.1:38158","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-15T19:05:43.116224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:42.171074Z","time spent":"945.140736ms","remote":"127.0.0.1:34104","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-15T19:05:44.375639Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.030366889s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-15T19:05:44.889855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"513.881758ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:05:44.890507Z","caller":"traceutil/trace.go:171","msg":"trace[1149135475] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:628; }","duration":"664.843491ms","start":"2026-06-15T19:05:44.225641Z","end":"2026-06-15T19:05:44.890485Z","steps":["trace[1149135475] 'read index received' (duration: 150.229149ms)","trace[1149135475] 'applied index is now lower than readState.Index' (duration: 514.613062ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:05:44.890512Z","caller":"traceutil/trace.go:171","msg":"trace[1045551434] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.770582246s","start":"2026-06-15T19:05:43.119893Z","end":"2026-06-15T19:05:44.890475Z","steps":["trace[1045551434] 'process raft request' (duration: 1.770241915s)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:44.890549Z","caller":"traceutil/trace.go:171","msg":"trace[1839169490] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"1.746945372s","start":"2026-06-15T19:05:43.143583Z","end":"2026-06-15T19:05:44.890529Z","steps":["trace[1839169490] 'process raft request' (duration: 1.746852899s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:44.890632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:43.143565Z","time spent":"1.747027644s","remote":"127.0.0.1:34364","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:05:44.890511Z","caller":"traceutil/trace.go:171","msg":"trace[636551339] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"1.770458703s","start":"2026-06-15T19:05:43.120026Z","end":"2026-06-15T19:05:44.890485Z","steps":["trace[636551339] 'process raft request' (duration: 1.770355699s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:44.890681Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:43.119886Z","time spent":"1.770706551s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:05:44.890682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.994416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:05:44.890772Z","caller":"traceutil/trace.go:171","msg":"trace[1028194288] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"665.13092ms","start":"2026-06-15T19:05:44.225588Z","end":"2026-06-15T19:05:44.890718Z","steps":["trace[1028194288] 'agreement among raft nodes before linearized reading' (duration: 664.984385ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:05:44.890824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:44.225569Z","time spent":"665.241223ms","remote":"127.0.0.1:38158","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-15T19:05:44.890494Z","caller":"traceutil/trace.go:171","msg":"trace[1765305977] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"1.770581766s","start":"2026-06-15T19:05:43.119801Z","end":"2026-06-15T19:05:44.890383Z","steps":["trace[1765305977] 'process raft request' (duration: 1.256061378s)","trace[1765305977] 'compare' (duration: 513.597709ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:05:44.890798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:43.120011Z","time spent":"1.770690791s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:05:44.8909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:05:43.119788Z","time spent":"1.771073713s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:05:45.58656Z","caller":"traceutil/trace.go:171","msg":"trace[927924343] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"188.690868ms","start":"2026-06-15T19:05:45.397846Z","end":"2026-06-15T19:05:45.586537Z","steps":["trace[927924343] 'process raft request' (duration: 187.060716ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:47.061382Z","caller":"traceutil/trace.go:171","msg":"trace[1710964944] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"161.620273ms","start":"2026-06-15T19:05:46.899738Z","end":"2026-06-15T19:05:47.061358Z","steps":["trace[1710964944] 'process raft request' (duration: 161.457798ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:47.061383Z","caller":"traceutil/trace.go:171","msg":"trace[1231052907] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"117.426831ms","start":"2026-06-15T19:05:46.943946Z","end":"2026-06-15T19:05:47.061373Z","steps":["trace[1231052907] 'process raft request' (duration: 117.39584ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:47.061526Z","caller":"traceutil/trace.go:171","msg":"trace[1886603764] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"161.071956ms","start":"2026-06-15T19:05:46.900446Z","end":"2026-06-15T19:05:47.061518Z","steps":["trace[1886603764] 'process raft request' (duration: 160.847129ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:47.061577Z","caller":"traceutil/trace.go:171","msg":"trace[312972933] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"141.48459ms","start":"2026-06-15T19:05:46.920059Z","end":"2026-06-15T19:05:47.061543Z","steps":["trace[312972933] 'process raft request' (duration: 141.259313ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:05:59.146257Z","caller":"traceutil/trace.go:171","msg":"trace[73635174] transaction","detail":"{read_only:false; response_revision:757; number_of_response:1; }","duration":"112.185494ms","start":"2026-06-15T19:05:59.034039Z","end":"2026-06-15T19:05:59.146224Z","steps":["trace[73635174] 'process raft request' (duration: 111.848493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:02.733052Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281247813161735274,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T19:06:02.985753Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.285540492s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T19:06:02.986016Z","caller":"traceutil/trace.go:171","msg":"trace[288184578] transaction","detail":"{read_only:false; response_revision:775; number_of_response:1; }","duration":"1.285870862s","start":"2026-06-15T19:06:01.700128Z","end":"2026-06-15T19:06:02.985999Z","steps":["trace[288184578] 'process raft request' (duration: 1.285763839s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:02.986117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:01.70011Z","time spent":"1.285946005s","remote":"127.0.0.1:38316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4905,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:06:03.018287Z","caller":"traceutil/trace.go:171","msg":"trace[907627058] transaction","detail":"{read_only:false; response_revision:776; number_of_response:1; }","duration":"776.677854ms","start":"2026-06-15T19:06:02.241562Z","end":"2026-06-15T19:06:03.01824Z","steps":["trace[907627058] 'process raft request' (duration: 776.392245ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:03.018311Z","caller":"traceutil/trace.go:171","msg":"trace[1865295316] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"639.663315ms","start":"2026-06-15T19:06:02.378615Z","end":"2026-06-15T19:06:03.018278Z","steps":["trace[1865295316] 'process raft request' (duration: 639.521121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:03.018557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:02.241544Z","time spent":"776.853329ms","remote":"127.0.0.1:34104","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-15T19:06:03.018575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:02.378596Z","time spent":"639.890313ms","remote":"127.0.0.1:34070","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:06:03.031801Z","caller":"traceutil/trace.go:171","msg":"trace[777419557] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:803; }","duration":"799.016577ms","start":"2026-06-15T19:06:02.232753Z","end":"2026-06-15T19:06:03.031769Z","steps":["trace[777419557] 'read index received' (duration: 753.207904ms)","trace[777419557] 'applied index is now lower than readState.Index' (duration: 45.806873ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:06:03.032257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"799.255045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-15T19:06:03.032321Z","caller":"traceutil/trace.go:171","msg":"trace[1377596978] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:777; }","duration":"799.603897ms","start":"2026-06-15T19:06:02.232704Z","end":"2026-06-15T19:06:03.032308Z","steps":["trace[1377596978] 'agreement among raft nodes before linearized reading' (duration: 799.173403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:03.032362Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:06:02.232682Z","time spent":"799.669928ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T19:06:07.113122Z","caller":"traceutil/trace.go:171","msg":"trace[1899093357] transaction","detail":"{read_only:false; response_revision:821; number_of_response:1; }","duration":"199.016428ms","start":"2026-06-15T19:06:06.914071Z","end":"2026-06-15T19:06:07.113087Z","steps":["trace[1899093357] 'process raft request' (duration: 196.975683ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:15.35242Z","caller":"traceutil/trace.go:171","msg":"trace[1734349116] transaction","detail":"{read_only:false; response_revision:900; number_of_response:1; }","duration":"104.395711ms","start":"2026-06-15T19:06:15.247982Z","end":"2026-06-15T19:06:15.352378Z","steps":["trace[1734349116] 'process raft request' (duration: 104.153474ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:17.25043Z","caller":"traceutil/trace.go:171","msg":"trace[44945113] transaction","detail":"{read_only:false; response_revision:912; number_of_response:1; }","duration":"266.070735ms","start":"2026-06-15T19:06:16.984341Z","end":"2026-06-15T19:06:17.250412Z","steps":["trace[44945113] 'process raft request' (duration: 243.794902ms)","trace[44945113] 'compare' (duration: 22.093178ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:06:17.250517Z","caller":"traceutil/trace.go:171","msg":"trace[893551849] transaction","detail":"{read_only:false; response_revision:913; number_of_response:1; }","duration":"264.778014ms","start":"2026-06-15T19:06:16.985726Z","end":"2026-06-15T19:06:17.250504Z","steps":["trace[893551849] 'process raft request' (duration: 264.62937ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:17.250699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.693116ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:06:17.250774Z","caller":"traceutil/trace.go:171","msg":"trace[1621712701] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:911; }","duration":"123.329897ms","start":"2026-06-15T19:06:17.127433Z","end":"2026-06-15T19:06:17.250763Z","steps":["trace[1621712701] 'range keys from in-memory index tree' (duration: 122.668956ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:17.683791Z","caller":"traceutil/trace.go:171","msg":"trace[1504106467] linearizableReadLoop","detail":"{readStateIndex:951; appliedIndex:946; }","duration":"253.541804ms","start":"2026-06-15T19:06:17.430229Z","end":"2026-06-15T19:06:17.683771Z","steps":["trace[1504106467] 'read index received' (duration: 34.591146ms)","trace[1504106467] 'applied index is now lower than readState.Index' (duration: 218.949758ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:06:17.683988Z","caller":"traceutil/trace.go:171","msg":"trace[818430691] transaction","detail":"{read_only:false; response_revision:918; number_of_response:1; }","duration":"265.501658ms","start":"2026-06-15T19:06:17.418475Z","end":"2026-06-15T19:06:17.683977Z","steps":["trace[818430691] 'process raft request' (duration: 265.087755ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:17.684146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.901266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-d9jsc\" ","response":"range_response_count:1 size:5072"} {"level":"info","ts":"2026-06-15T19:06:17.684242Z","caller":"traceutil/trace.go:171","msg":"trace[197269337] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-d9jsc; range_end:; response_count:1; response_revision:919; }","duration":"254.026691ms","start":"2026-06-15T19:06:17.430191Z","end":"2026-06-15T19:06:17.684218Z","steps":["trace[197269337] 'agreement among raft nodes before linearized reading' (duration: 253.802093ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:17.684396Z","caller":"traceutil/trace.go:171","msg":"trace[610143239] transaction","detail":"{read_only:false; response_revision:919; number_of_response:1; }","duration":"265.88278ms","start":"2026-06-15T19:06:17.4185Z","end":"2026-06-15T19:06:17.684383Z","steps":["trace[610143239] 'process raft request' (duration: 265.219239ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:28.019458Z","caller":"traceutil/trace.go:171","msg":"trace[1067284789] transaction","detail":"{read_only:false; response_revision:957; number_of_response:1; }","duration":"107.067487ms","start":"2026-06-15T19:06:27.912362Z","end":"2026-06-15T19:06:28.01943Z","steps":["trace[1067284789] 'process raft request' (duration: 81.701465ms)","trace[1067284789] 'compare' (duration: 25.259488ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:06:37.76498Z","caller":"traceutil/trace.go:171","msg":"trace[596047050] linearizableReadLoop","detail":"{readStateIndex:1024; appliedIndex:1023; }","duration":"127.056126ms","start":"2026-06-15T19:06:37.637901Z","end":"2026-06-15T19:06:37.764957Z","steps":["trace[596047050] 'read index received' (duration: 126.911941ms)","trace[596047050] 'applied index is now lower than readState.Index' (duration: 142.895µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:06:37.76521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.294623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:06:37.76525Z","caller":"traceutil/trace.go:171","msg":"trace[1221105762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:987; }","duration":"127.386727ms","start":"2026-06-15T19:06:37.637853Z","end":"2026-06-15T19:06:37.76524Z","steps":["trace[1221105762] 'agreement among raft nodes before linearized reading' (duration: 127.232092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:37.765336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.095289ms","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-15T19:06:37.765412Z","caller":"traceutil/trace.go:171","msg":"trace[1889170332] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:987; }","duration":"113.204843ms","start":"2026-06-15T19:06:37.65219Z","end":"2026-06-15T19:06:37.765395Z","steps":["trace[1889170332] 'agreement among raft nodes before linearized reading' (duration: 112.989866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:06:37.765466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.535122ms","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-15T19:06:37.765568Z","caller":"traceutil/trace.go:171","msg":"trace[1373374290] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:987; }","duration":"112.649565ms","start":"2026-06-15T19:06:37.6529Z","end":"2026-06-15T19:06:37.765549Z","steps":["trace[1373374290] 'agreement among raft nodes before linearized reading' (duration: 112.376876ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:48.148899Z","caller":"traceutil/trace.go:171","msg":"trace[2146385773] linearizableReadLoop","detail":"{readStateIndex:1064; appliedIndex:1063; }","duration":"164.527555ms","start":"2026-06-15T19:06:47.984341Z","end":"2026-06-15T19:06:48.148869Z","steps":["trace[2146385773] 'read index received' (duration: 144.278197ms)","trace[2146385773] 'applied index is now lower than readState.Index' (duration: 20.248308ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:06:48.148974Z","caller":"traceutil/trace.go:171","msg":"trace[1526700820] transaction","detail":"{read_only:false; response_revision:1025; number_of_response:1; }","duration":"181.656993ms","start":"2026-06-15T19:06:47.967276Z","end":"2026-06-15T19:06:48.148933Z","steps":["trace[1526700820] 'process raft request' (duration: 161.327023ms)","trace[1526700820] 'compare' (duration: 20.150295ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:06:48.149103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.013381ms","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-15T19:06:48.149145Z","caller":"traceutil/trace.go:171","msg":"trace[1153503889] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1025; }","duration":"195.100504ms","start":"2026-06-15T19:06:47.954031Z","end":"2026-06-15T19:06:48.149131Z","steps":["trace[1153503889] 'agreement among raft nodes before linearized reading' (duration: 194.947419ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:06:48.177005Z","caller":"traceutil/trace.go:171","msg":"trace[1243423233] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"188.460881ms","start":"2026-06-15T19:06:47.98852Z","end":"2026-06-15T19:06:48.176981Z","steps":["trace[1243423233] 'process raft request' (duration: 188.343157ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:00.508365Z","caller":"traceutil/trace.go:171","msg":"trace[1261554946] transaction","detail":"{read_only:false; response_revision:1067; number_of_response:1; }","duration":"103.830073ms","start":"2026-06-15T19:07:00.404505Z","end":"2026-06-15T19:07:00.508335Z","steps":["trace[1261554946] 'process raft request' (duration: 98.168872ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:04.380673Z","caller":"traceutil/trace.go:171","msg":"trace[1516179511] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1115; }","duration":"207.509121ms","start":"2026-06-15T19:07:04.173146Z","end":"2026-06-15T19:07:04.380655Z","steps":["trace[1516179511] 'read index received' (duration: 207.400668ms)","trace[1516179511] 'applied index is now lower than readState.Index' (duration: 107.463µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:04.380753Z","caller":"traceutil/trace.go:171","msg":"trace[305450865] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"358.950028ms","start":"2026-06-15T19:07:04.021795Z","end":"2026-06-15T19:07:04.380745Z","steps":["trace[305450865] 'process raft request' (duration: 358.736001ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:04.380836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:04.02177Z","time spent":"359.00025ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:04.380985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.827391ms","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-15T19:07:04.381073Z","caller":"traceutil/trace.go:171","msg":"trace[1130771862] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1074; }","duration":"207.970206ms","start":"2026-06-15T19:07:04.173083Z","end":"2026-06-15T19:07:04.381053Z","steps":["trace[1130771862] 'agreement among raft nodes before linearized reading' (duration: 207.700477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:05.078798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.81063ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:05.079003Z","caller":"traceutil/trace.go:171","msg":"trace[1354601372] linearizableReadLoop","detail":"{readStateIndex:1118; appliedIndex:1116; }","duration":"698.263708ms","start":"2026-06-15T19:07:04.380722Z","end":"2026-06-15T19:07:05.078986Z","steps":["trace[1354601372] 'read index received' (duration: 386.17918ms)","trace[1354601372] 'applied index is now lower than readState.Index' (duration: 312.083498ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:05.07915Z","caller":"traceutil/trace.go:171","msg":"trace[1747975902] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"767.39703ms","start":"2026-06-15T19:07:04.311722Z","end":"2026-06-15T19:07:05.079119Z","steps":["trace[1747975902] 'process raft request' (duration: 767.179903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:05.079248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"854.449596ms","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-15T19:07:05.079252Z","caller":"traceutil/trace.go:171","msg":"trace[1343738125] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"900.440628ms","start":"2026-06-15T19:07:04.178775Z","end":"2026-06-15T19:07:05.079215Z","steps":["trace[1343738125] 'process raft request' (duration: 588.131273ms)","trace[1343738125] 'compare' (duration: 311.666545ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:05.079303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:04.31169Z","time spent":"767.525594ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:05.079288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.717042ms","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-15T19:07:05.07944Z","caller":"traceutil/trace.go:171","msg":"trace[1783556935] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1076; }","duration":"728.920679ms","start":"2026-06-15T19:07:04.350505Z","end":"2026-06-15T19:07:05.079426Z","steps":["trace[1783556935] 'agreement among raft nodes before linearized reading' (duration: 728.63915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:05.079435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:04.178757Z","time spent":"900.598783ms","remote":"127.0.0.1:34104","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-15T19:07:05.079471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:04.350481Z","time spent":"728.98183ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T19:07:05.079301Z","caller":"traceutil/trace.go:171","msg":"trace[1480802099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1076; }","duration":"854.522889ms","start":"2026-06-15T19:07:04.224767Z","end":"2026-06-15T19:07:05.07929Z","steps":["trace[1480802099] 'agreement among raft nodes before linearized reading' (duration: 854.391584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:05.07954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:04.224755Z","time spent":"854.766336ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-15T19:07:05.246867Z","caller":"traceutil/trace.go:171","msg":"trace[1365721268] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"167.79926ms","start":"2026-06-15T19:07:05.07905Z","end":"2026-06-15T19:07:05.246849Z","steps":["trace[1365721268] 'read index received' (duration: 167.593934ms)","trace[1365721268] 'applied index is now lower than readState.Index' (duration: 204.346µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:05.246963Z","caller":"traceutil/trace.go:171","msg":"trace[713087214] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"861.952926ms","start":"2026-06-15T19:07:04.38496Z","end":"2026-06-15T19:07:05.246913Z","steps":["trace[713087214] 'process raft request' (duration: 861.739909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:05.247065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.698655ms","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-15T19:07:05.247096Z","caller":"traceutil/trace.go:171","msg":"trace[1112116121] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1077; }","duration":"725.785148ms","start":"2026-06-15T19:07:04.521303Z","end":"2026-06-15T19:07:05.247088Z","steps":["trace[1112116121] 'agreement among raft nodes before linearized reading' (duration: 725.649393ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:05.247129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:04.521283Z","time spent":"725.83533ms","remote":"127.0.0.1:34104","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-15T19:07:05.247135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:04.384938Z","time spent":"862.110311ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:05.247262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.363035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:05.247309Z","caller":"traceutil/trace.go:171","msg":"trace[1066608896] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1077; }","duration":"226.486058ms","start":"2026-06-15T19:07:05.020813Z","end":"2026-06-15T19:07:05.247299Z","steps":["trace[1066608896] 'agreement among raft nodes before linearized reading' (duration: 226.374795ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:05.264358Z","caller":"traceutil/trace.go:171","msg":"trace[486077547] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"180.226148ms","start":"2026-06-15T19:07:05.084117Z","end":"2026-06-15T19:07:05.264343Z","steps":["trace[486077547] 'process raft request' (duration: 180.143735ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:05.264355Z","caller":"traceutil/trace.go:171","msg":"trace[1710361997] transaction","detail":"{read_only:false; response_revision:1078; number_of_response:1; }","duration":"180.238498ms","start":"2026-06-15T19:07:05.084087Z","end":"2026-06-15T19:07:05.264325Z","steps":["trace[1710361997] 'process raft request' (duration: 180.058293ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:10.618267Z","caller":"traceutil/trace.go:171","msg":"trace[1533781956] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"119.762644ms","start":"2026-06-15T19:07:10.498486Z","end":"2026-06-15T19:07:10.618249Z","steps":["trace[1533781956] 'read index received' (duration: 119.678912ms)","trace[1533781956] 'applied index is now lower than readState.Index' (duration: 83.092µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:10.618363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.865958ms","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:7"} {"level":"info","ts":"2026-06-15T19:07:10.618388Z","caller":"traceutil/trace.go:171","msg":"trace[174444582] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1095; }","duration":"119.940901ms","start":"2026-06-15T19:07:10.498439Z","end":"2026-06-15T19:07:10.61838Z","steps":["trace[174444582] 'agreement among raft nodes before linearized reading' (duration: 119.880669ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:10.618521Z","caller":"traceutil/trace.go:171","msg":"trace[774556481] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"211.231384ms","start":"2026-06-15T19:07:10.40727Z","end":"2026-06-15T19:07:10.618501Z","steps":["trace[774556481] 'process raft request' (duration: 210.857212ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:12.906869Z","caller":"traceutil/trace.go:171","msg":"trace[1906077912] transaction","detail":"{read_only:false; response_revision:1101; number_of_response:1; }","duration":"280.979717ms","start":"2026-06-15T19:07:12.625862Z","end":"2026-06-15T19:07:12.906842Z","steps":["trace[1906077912] 'process raft request' (duration: 280.806411ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:13.575504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.685536ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:07:13.57599Z","caller":"traceutil/trace.go:171","msg":"trace[1002499586] linearizableReadLoop","detail":"{readStateIndex:1146; appliedIndex:1144; }","duration":"299.240082ms","start":"2026-06-15T19:07:13.27673Z","end":"2026-06-15T19:07:13.57597Z","steps":["trace[1002499586] 'read index received' (duration: 49.02628ms)","trace[1002499586] 'applied index is now lower than readState.Index' (duration: 250.212732ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:13.576128Z","caller":"traceutil/trace.go:171","msg":"trace[866303268] transaction","detail":"{read_only:false; response_revision:1102; number_of_response:1; }","duration":"377.976073ms","start":"2026-06-15T19:07:13.198114Z","end":"2026-06-15T19:07:13.57609Z","steps":["trace[866303268] 'process raft request' (duration: 377.497258ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:13.57623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.48955ms","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-15T19:07:13.576283Z","caller":"traceutil/trace.go:171","msg":"trace[161987444] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1102; }","duration":"299.591463ms","start":"2026-06-15T19:07:13.276676Z","end":"2026-06-15T19:07:13.576268Z","steps":["trace[161987444] 'agreement among raft nodes before linearized reading' (duration: 299.404757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:13.576324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:13.198092Z","time spent":"378.119098ms","remote":"127.0.0.1:34104","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-15T19:07:13.576701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.961194ms","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-15T19:07:13.576762Z","caller":"traceutil/trace.go:171","msg":"trace[400571272] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1102; }","duration":"280.046607ms","start":"2026-06-15T19:07:13.296701Z","end":"2026-06-15T19:07:13.576748Z","steps":["trace[400571272] 'agreement among raft nodes before linearized reading' (duration: 279.903692ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:13.576706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.498529ms","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-15T19:07:13.576902Z","caller":"traceutil/trace.go:171","msg":"trace[15648259] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1102; }","duration":"254.713666ms","start":"2026-06-15T19:07:13.322171Z","end":"2026-06-15T19:07:13.576884Z","steps":["trace[15648259] 'agreement among raft nodes before linearized reading' (duration: 254.442388ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:13.576702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.868218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:07:13.577324Z","caller":"traceutil/trace.go:171","msg":"trace[1647371678] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1102; }","duration":"283.531169ms","start":"2026-06-15T19:07:13.293771Z","end":"2026-06-15T19:07:13.577302Z","steps":["trace[1647371678] 'agreement among raft nodes before linearized reading' (duration: 282.760524ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:13.895422Z","caller":"traceutil/trace.go:171","msg":"trace[1343323119] transaction","detail":"{read_only:false; response_revision:1104; number_of_response:1; }","duration":"314.034195ms","start":"2026-06-15T19:07:13.58136Z","end":"2026-06-15T19:07:13.895395Z","steps":["trace[1343323119] 'process raft request' (duration: 292.051871ms)","trace[1343323119] 'compare' (duration: 21.737466ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:13.895571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:13.581352Z","time spent":"314.152119ms","remote":"127.0.0.1:34104","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-15T19:07:13.895662Z","caller":"traceutil/trace.go:171","msg":"trace[504201890] transaction","detail":"{read_only:false; response_revision:1105; number_of_response:1; }","duration":"314.070286ms","start":"2026-06-15T19:07:13.58158Z","end":"2026-06-15T19:07:13.895651Z","steps":["trace[504201890] 'process raft request' (duration: 313.771607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:13.895716Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:13.581571Z","time spent":"314.120208ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:13.896647Z","caller":"traceutil/trace.go:171","msg":"trace[524461776] transaction","detail":"{read_only:false; response_revision:1106; number_of_response:1; }","duration":"314.371666ms","start":"2026-06-15T19:07:13.582153Z","end":"2026-06-15T19:07:13.896524Z","steps":["trace[524461776] 'process raft request' (duration: 313.334753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:13.896851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:13.582134Z","time spent":"314.633135ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:15.212206Z","caller":"traceutil/trace.go:171","msg":"trace[1076995730] transaction","detail":"{read_only:false; response_revision:1107; number_of_response:1; }","duration":"292.01967ms","start":"2026-06-15T19:07:14.920154Z","end":"2026-06-15T19:07:15.212174Z","steps":["trace[1076995730] 'process raft request' (duration: 291.874456ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:15.660949Z","caller":"traceutil/trace.go:171","msg":"trace[1616917930] transaction","detail":"{read_only:false; response_revision:1108; number_of_response:1; }","duration":"536.282252ms","start":"2026-06-15T19:07:15.124632Z","end":"2026-06-15T19:07:15.660915Z","steps":["trace[1616917930] 'process raft request' (duration: 492.894933ms)","trace[1616917930] 'compare' (duration: 43.268265ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:15.661125Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:15.124595Z","time spent":"536.438577ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:16.057384Z","caller":"traceutil/trace.go:171","msg":"trace[320383782] linearizableReadLoop","detail":"{readStateIndex:1154; appliedIndex:1153; }","duration":"158.057041ms","start":"2026-06-15T19:07:15.899297Z","end":"2026-06-15T19:07:16.057354Z","steps":["trace[320383782] 'read index received' (duration: 109.701763ms)","trace[320383782] 'applied index is now lower than readState.Index' (duration: 48.351418ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:16.057475Z","caller":"traceutil/trace.go:171","msg":"trace[216586364] transaction","detail":"{read_only:false; response_revision:1110; number_of_response:1; }","duration":"391.168505ms","start":"2026-06-15T19:07:15.666268Z","end":"2026-06-15T19:07:16.057436Z","steps":["trace[216586364] 'process raft request' (duration: 342.791736ms)","trace[216586364] 'compare' (duration: 48.149732ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:16.057642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:15.666254Z","time spent":"391.296589ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:16.057697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.371991ms","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-15T19:07:16.057819Z","caller":"traceutil/trace.go:171","msg":"trace[1924744107] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1110; }","duration":"158.535957ms","start":"2026-06-15T19:07:15.899266Z","end":"2026-06-15T19:07:16.057802Z","steps":["trace[1924744107] 'agreement among raft nodes before linearized reading' (duration: 158.271298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:16.057864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.533017ms","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-15T19:07:16.057939Z","caller":"traceutil/trace.go:171","msg":"trace[55428720] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1110; }","duration":"158.65616ms","start":"2026-06-15T19:07:15.899265Z","end":"2026-06-15T19:07:16.057922Z","steps":["trace[55428720] 'agreement among raft nodes before linearized reading' (duration: 158.417813ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:16.058069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.500684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:07:16.058121Z","caller":"traceutil/trace.go:171","msg":"trace[1986426424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1110; }","duration":"157.563125ms","start":"2026-06-15T19:07:15.900545Z","end":"2026-06-15T19:07:16.058108Z","steps":["trace[1986426424] 'agreement among raft nodes before linearized reading' (duration: 157.435161ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:17.627349Z","caller":"traceutil/trace.go:171","msg":"trace[1627608558] linearizableReadLoop","detail":"{readStateIndex:1158; appliedIndex:1157; }","duration":"402.644753ms","start":"2026-06-15T19:07:17.224683Z","end":"2026-06-15T19:07:17.627328Z","steps":["trace[1627608558] 'read index received' (duration: 402.464087ms)","trace[1627608558] 'applied index is now lower than readState.Index' (duration: 179.936µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:17.627448Z","caller":"traceutil/trace.go:171","msg":"trace[1837030624] transaction","detail":"{read_only:false; response_revision:1114; number_of_response:1; }","duration":"404.281615ms","start":"2026-06-15T19:07:17.223139Z","end":"2026-06-15T19:07:17.62742Z","steps":["trace[1837030624] 'process raft request' (duration: 404.084689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:17.627642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:17.223122Z","time spent":"404.43433ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:17.628126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"403.425148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:17.628185Z","caller":"traceutil/trace.go:171","msg":"trace[1017115678] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1114; }","duration":"403.4906ms","start":"2026-06-15T19:07:17.224679Z","end":"2026-06-15T19:07:17.628169Z","steps":["trace[1017115678] 'agreement among raft nodes before linearized reading' (duration: 402.790887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:17.628327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:17.224655Z","time spent":"403.660695ms","remote":"127.0.0.1:38158","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-15T19:07:18.108605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.358009ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:18.108724Z","caller":"traceutil/trace.go:171","msg":"trace[1127982592] transaction","detail":"{read_only:false; response_revision:1115; number_of_response:1; }","duration":"441.993222ms","start":"2026-06-15T19:07:17.666718Z","end":"2026-06-15T19:07:18.108711Z","steps":["trace[1127982592] 'process raft request' (duration: 170.471999ms)","trace[1127982592] 'compare' (duration: 271.1093ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:18.108765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:17.666695Z","time spent":"442.052555ms","remote":"127.0.0.1:34104","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-15T19:07:18.108884Z","caller":"traceutil/trace.go:171","msg":"trace[1689227695] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"441.059773ms","start":"2026-06-15T19:07:17.667818Z","end":"2026-06-15T19:07:18.108878Z","steps":["trace[1689227695] 'process raft request' (duration: 440.857336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:18.108922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:17.667807Z","time spent":"441.096824ms","remote":"127.0.0.1:38188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:18.517153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.939533ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:18.517246Z","caller":"traceutil/trace.go:171","msg":"trace[123316706] linearizableReadLoop","detail":"{readStateIndex:1162; appliedIndex:1161; }","duration":"402.324422ms","start":"2026-06-15T19:07:18.114906Z","end":"2026-06-15T19:07:18.51723Z","steps":["trace[123316706] 'read index received' (duration: 241.219044ms)","trace[123316706] 'applied index is now lower than readState.Index' (duration: 161.104238ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:18.517286Z","caller":"traceutil/trace.go:171","msg":"trace[107137588] transaction","detail":"{read_only:false; response_revision:1117; number_of_response:1; }","duration":"402.611381ms","start":"2026-06-15T19:07:18.114646Z","end":"2026-06-15T19:07:18.517257Z","steps":["trace[107137588] 'process raft request' (duration: 241.470451ms)","trace[107137588] 'compare' (duration: 160.349665ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:18.517511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.599111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-15T19:07:18.517555Z","caller":"traceutil/trace.go:171","msg":"trace[1322306870] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1117; }","duration":"402.677423ms","start":"2026-06-15T19:07:18.114865Z","end":"2026-06-15T19:07:18.517542Z","steps":["trace[1322306870] 'agreement among raft nodes before linearized reading' (duration: 402.431515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:18.517568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:18.114633Z","time spent":"402.718985ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:18.517708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:18.114849Z","time spent":"402.845849ms","remote":"127.0.0.1:34120","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/endpointslices/default/kubernetes\" "} {"level":"info","ts":"2026-06-15T19:07:18.5209Z","caller":"traceutil/trace.go:171","msg":"trace[2016538398] transaction","detail":"{read_only:false; response_revision:1118; number_of_response:1; }","duration":"405.969709ms","start":"2026-06-15T19:07:18.114904Z","end":"2026-06-15T19:07:18.520874Z","steps":["trace[2016538398] 'process raft request' (duration: 405.797723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:18.520939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.564214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:18.520977Z","caller":"traceutil/trace.go:171","msg":"trace[1747332929] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1118; }","duration":"295.635956ms","start":"2026-06-15T19:07:18.22533Z","end":"2026-06-15T19:07:18.520966Z","steps":["trace[1747332929] 'agreement among raft nodes before linearized reading' (duration: 295.585584ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:18.521024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.88713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-15T19:07:18.521034Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:18.114868Z","time spent":"406.097953ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:18.521062Z","caller":"traceutil/trace.go:171","msg":"trace[446588882] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1118; }","duration":"372.970092ms","start":"2026-06-15T19:07:18.148082Z","end":"2026-06-15T19:07:18.521052Z","steps":["trace[446588882] 'agreement among raft nodes before linearized reading' (duration: 372.869299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:18.52109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:18.148061Z","time spent":"373.022224ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:07:18.520889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.685088ms","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-15T19:07:18.521391Z","caller":"traceutil/trace.go:171","msg":"trace[232273381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1118; }","duration":"375.203674ms","start":"2026-06-15T19:07:18.146177Z","end":"2026-06-15T19:07:18.52138Z","steps":["trace[232273381] 'agreement among raft nodes before linearized reading' (duration: 374.626025ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:18.52142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:18.146168Z","time spent":"375.242345ms","remote":"127.0.0.1:34104","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":"info","ts":"2026-06-15T19:07:31.797443Z","caller":"traceutil/trace.go:171","msg":"trace[131111297] transaction","detail":"{read_only:false; response_revision:1212; number_of_response:1; }","duration":"107.862434ms","start":"2026-06-15T19:07:31.689564Z","end":"2026-06-15T19:07:31.797426Z","steps":["trace[131111297] 'process raft request' (duration: 107.766531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:34.407216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"681.715168ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:07:34.4073Z","caller":"traceutil/trace.go:171","msg":"trace[892628015] linearizableReadLoop","detail":"{readStateIndex:1267; appliedIndex:1266; }","duration":"1.181820311s","start":"2026-06-15T19:07:33.225465Z","end":"2026-06-15T19:07:34.407286Z","steps":["trace[892628015] 'read index received' (duration: 499.9972ms)","trace[892628015] 'applied index is now lower than readState.Index' (duration: 681.822231ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:34.407557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18209126s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:34.407586Z","caller":"traceutil/trace.go:171","msg":"trace[991025803] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1217; }","duration":"1.182160602s","start":"2026-06-15T19:07:33.225416Z","end":"2026-06-15T19:07:34.407576Z","steps":["trace[991025803] 'agreement among raft nodes before linearized reading' (duration: 1.182105711s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:34.407608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:33.225397Z","time spent":"1.182206633s","remote":"127.0.0.1:38158","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-15T19:07:34.410524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.056011362s","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:7"} {"level":"info","ts":"2026-06-15T19:07:34.410571Z","caller":"traceutil/trace.go:171","msg":"trace[972931542] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1218; }","duration":"1.056085615s","start":"2026-06-15T19:07:33.354473Z","end":"2026-06-15T19:07:34.410558Z","steps":["trace[972931542] 'agreement among raft nodes before linearized reading' (duration: 1.056012752s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:34.410607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:33.354456Z","time spent":"1.056143327s","remote":"127.0.0.1:37008","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:07:34.410588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.63897ms","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-15T19:07:34.41067Z","caller":"traceutil/trace.go:171","msg":"trace[1660324821] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1218; }","duration":"609.759464ms","start":"2026-06-15T19:07:33.800898Z","end":"2026-06-15T19:07:34.410657Z","steps":["trace[1660324821] 'agreement among raft nodes before linearized reading' (duration: 609.581378ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:34.41066Z","caller":"traceutil/trace.go:171","msg":"trace[1062907456] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"251.102139ms","start":"2026-06-15T19:07:34.159536Z","end":"2026-06-15T19:07:34.410638Z","steps":["trace[1062907456] 'process raft request' (duration: 250.798379ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:34.410708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:33.800881Z","time spent":"609.817335ms","remote":"127.0.0.1:34104","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-15T19:07:38.771577Z","caller":"traceutil/trace.go:171","msg":"trace[91355932] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"111.386377ms","start":"2026-06-15T19:07:38.660166Z","end":"2026-06-15T19:07:38.771552Z","steps":["trace[91355932] 'process raft request' (duration: 111.330635ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:38.77181Z","caller":"traceutil/trace.go:171","msg":"trace[296932177] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"111.611804ms","start":"2026-06-15T19:07:38.660166Z","end":"2026-06-15T19:07:38.771778Z","steps":["trace[296932177] 'process raft request' (duration: 15.699393ms)","trace[296932177] 'compare' (duration: 95.506718ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:46.807077Z","caller":"traceutil/trace.go:171","msg":"trace[402322088] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"227.918628ms","start":"2026-06-15T19:07:46.579138Z","end":"2026-06-15T19:07:46.807057Z","steps":["trace[402322088] 'process raft request' (duration: 227.763473ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:46.812245Z","caller":"traceutil/trace.go:171","msg":"trace[977699179] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1308; }","duration":"190.025635ms","start":"2026-06-15T19:07:46.622204Z","end":"2026-06-15T19:07:46.81223Z","steps":["trace[977699179] 'read index received' (duration: 184.797077ms)","trace[977699179] 'applied index is now lower than readState.Index' (duration: 5.227738ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:46.812369Z","caller":"traceutil/trace.go:171","msg":"trace[467904255] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"205.703687ms","start":"2026-06-15T19:07:46.606644Z","end":"2026-06-15T19:07:46.812348Z","steps":["trace[467904255] 'process raft request' (duration: 205.518331ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:46.812397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.19184ms","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-15T19:07:46.812427Z","caller":"traceutil/trace.go:171","msg":"trace[1700778873] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1258; }","duration":"190.268763ms","start":"2026-06-15T19:07:46.622151Z","end":"2026-06-15T19:07:46.81242Z","steps":["trace[1700778873] 'agreement among raft nodes before linearized reading' (duration: 190.167769ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:46.812463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.475071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:46.812563Z","caller":"traceutil/trace.go:171","msg":"trace[436750385] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1258; }","duration":"171.627586ms","start":"2026-06-15T19:07:46.640915Z","end":"2026-06-15T19:07:46.812543Z","steps":["trace[436750385] 'agreement among raft nodes before linearized reading' (duration: 171.45944ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.330028Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281247813161736522,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:07:51.363907Z","caller":"traceutil/trace.go:171","msg":"trace[274877806] linearizableReadLoop","detail":"{readStateIndex:1345; appliedIndex:1344; }","duration":"534.161064ms","start":"2026-06-15T19:07:50.829724Z","end":"2026-06-15T19:07:51.363885Z","steps":["trace[274877806] 'read index received' (duration: 533.984568ms)","trace[274877806] 'applied index is now lower than readState.Index' (duration: 175.686µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:51.364019Z","caller":"traceutil/trace.go:171","msg":"trace[155164137] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"546.231311ms","start":"2026-06-15T19:07:50.817775Z","end":"2026-06-15T19:07:51.364006Z","steps":["trace[155164137] 'process raft request' (duration: 545.967922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.364139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.817753Z","time spent":"546.308943ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:51.364343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"534.620658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:07:51.364381Z","caller":"traceutil/trace.go:171","msg":"trace[1688887806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1292; }","duration":"534.68091ms","start":"2026-06-15T19:07:50.829689Z","end":"2026-06-15T19:07:51.36437Z","steps":["trace[1688887806] 'agreement among raft nodes before linearized reading' (duration: 534.565936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.364417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.829674Z","time spent":"534.736662ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-15T19:07:51.3646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.701567ms","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-15T19:07:51.364645Z","caller":"traceutil/trace.go:171","msg":"trace[1086078579] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1292; }","duration":"527.763499ms","start":"2026-06-15T19:07:50.836871Z","end":"2026-06-15T19:07:51.364635Z","steps":["trace[1086078579] 'agreement among raft nodes before linearized reading' (duration: 527.659165ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.364661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.54838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-15T19:07:51.364697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.836862Z","time spent":"527.826081ms","remote":"127.0.0.1:34104","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":"info","ts":"2026-06-15T19:07:51.364748Z","caller":"traceutil/trace.go:171","msg":"trace[687714882] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1292; }","duration":"526.686935ms","start":"2026-06-15T19:07:50.838039Z","end":"2026-06-15T19:07:51.364726Z","steps":["trace[687714882] 'agreement among raft nodes before linearized reading' (duration: 526.489748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.364803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"376.272328ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:07:51.364812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.83802Z","time spent":"526.780658ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-15T19:07:51.364829Z","caller":"traceutil/trace.go:171","msg":"trace[768602572] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1292; }","duration":"376.32477ms","start":"2026-06-15T19:07:50.988496Z","end":"2026-06-15T19:07:51.364821Z","steps":["trace[768602572] 'agreement among raft nodes before linearized reading' (duration: 376.283338ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.364889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.98848Z","time spent":"376.398122ms","remote":"127.0.0.1:51846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:07:51.36495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"529.644009ms","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-15T19:07:51.365169Z","caller":"traceutil/trace.go:171","msg":"trace[306249107] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1292; }","duration":"529.728592ms","start":"2026-06-15T19:07:50.83527Z","end":"2026-06-15T19:07:51.364999Z","steps":["trace[306249107] 'agreement among raft nodes before linearized reading' (duration: 529.543436ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.365164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"530.495416ms","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-15T19:07:51.365234Z","caller":"traceutil/trace.go:171","msg":"trace[1162186334] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1292; }","duration":"530.604561ms","start":"2026-06-15T19:07:50.834618Z","end":"2026-06-15T19:07:51.365223Z","steps":["trace[1162186334] 'agreement among raft nodes before linearized reading' (duration: 529.757063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.365291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.834597Z","time spent":"530.686612ms","remote":"127.0.0.1:34104","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-15T19:07:51.365564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.184668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:51.365681Z","caller":"traceutil/trace.go:171","msg":"trace[1105425811] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1292; }","duration":"140.344424ms","start":"2026-06-15T19:07:51.225318Z","end":"2026-06-15T19:07:51.365662Z","steps":["trace[1105425811] 'agreement among raft nodes before linearized reading' (duration: 139.452075ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:51.365586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:50.835261Z","time spent":"530.308011ms","remote":"127.0.0.1:34104","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-15T19:07:52.007968Z","caller":"traceutil/trace.go:171","msg":"trace[588281296] transaction","detail":"{read_only:false; response_revision:1293; number_of_response:1; }","duration":"638.190195ms","start":"2026-06-15T19:07:51.369756Z","end":"2026-06-15T19:07:52.007947Z","steps":["trace[588281296] 'process raft request' (duration: 638.066651ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.008085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:51.369735Z","time spent":"638.292398ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:52.023111Z","caller":"traceutil/trace.go:171","msg":"trace[710481440] transaction","detail":"{read_only:false; response_revision:1295; number_of_response:1; }","duration":"652.369729ms","start":"2026-06-15T19:07:51.370717Z","end":"2026-06-15T19:07:52.023087Z","steps":["trace[710481440] 'process raft request' (duration: 652.282026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.023265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:51.370703Z","time spent":"652.485592ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:52.023331Z","caller":"traceutil/trace.go:171","msg":"trace[1447423179] transaction","detail":"{read_only:false; response_revision:1296; number_of_response:1; }","duration":"652.006097ms","start":"2026-06-15T19:07:51.371307Z","end":"2026-06-15T19:07:52.023314Z","steps":["trace[1447423179] 'process raft request' (duration: 651.727759ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.023444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:51.371296Z","time spent":"652.08578ms","remote":"127.0.0.1:34104","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-15T19:07:52.023537Z","caller":"traceutil/trace.go:171","msg":"trace[1222495342] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"653.543896ms","start":"2026-06-15T19:07:51.369983Z","end":"2026-06-15T19:07:52.023527Z","steps":["trace[1222495342] 'process raft request' (duration: 652.854114ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.023605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:51.36993Z","time spent":"653.63822ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:52.023676Z","caller":"traceutil/trace.go:171","msg":"trace[1633971864] transaction","detail":"{read_only:false; response_revision:1297; number_of_response:1; }","duration":"651.858593ms","start":"2026-06-15T19:07:51.37181Z","end":"2026-06-15T19:07:52.023669Z","steps":["trace[1633971864] 'process raft request' (duration: 651.44257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:52.023718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:51.3718Z","time spent":"651.897944ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:53.802107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.122448ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:07:53.802293Z","caller":"traceutil/trace.go:171","msg":"trace[1677750321] linearizableReadLoop","detail":"{readStateIndex:1352; appliedIndex:1351; }","duration":"810.896585ms","start":"2026-06-15T19:07:52.991379Z","end":"2026-06-15T19:07:53.802276Z","steps":["trace[1677750321] 'read index received' (duration: 358.54955ms)","trace[1677750321] 'applied index is now lower than readState.Index' (duration: 452.345855ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:53.802453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"811.070521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T19:07:53.802477Z","caller":"traceutil/trace.go:171","msg":"trace[497699208] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1298; }","duration":"811.141723ms","start":"2026-06-15T19:07:52.991329Z","end":"2026-06-15T19:07:53.802471Z","steps":["trace[497699208] 'agreement among raft nodes before linearized reading' (duration: 811.03832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:53.802511Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:52.99131Z","time spent":"811.192554ms","remote":"127.0.0.1:38224","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":116,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:07:53.802754Z","caller":"traceutil/trace.go:171","msg":"trace[1208269733] transaction","detail":"{read_only:false; response_revision:1299; number_of_response:1; }","duration":"422.709795ms","start":"2026-06-15T19:07:53.380022Z","end":"2026-06-15T19:07:53.802731Z","steps":["trace[1208269733] 'process raft request' (duration: 422.168828ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:53.802888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:53.379998Z","time spent":"422.826149ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:54.003809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.997649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:54.003878Z","caller":"traceutil/trace.go:171","msg":"trace[953361867] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1299; }","duration":"772.102992ms","start":"2026-06-15T19:07:53.231758Z","end":"2026-06-15T19:07:54.003861Z","steps":["trace[953361867] 'agreement among raft nodes before linearized reading' (duration: 570.945102ms)","trace[953361867] 'range keys from in-memory index tree' (duration: 201.056528ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:54.003917Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:53.231742Z","time spent":"772.168165ms","remote":"127.0.0.1:38158","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-15T19:07:54.00381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.950324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-15T19:07:54.003965Z","caller":"traceutil/trace.go:171","msg":"trace[296877777] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1299; }","duration":"354.119429ms","start":"2026-06-15T19:07:53.649827Z","end":"2026-06-15T19:07:54.003947Z","steps":["trace[296877777] 'agreement among raft nodes before linearized reading' (duration: 152.969849ms)","trace[296877777] 'count revisions from in-memory index tree' (duration: 200.955074ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:54.004016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:53.649786Z","time spent":"354.215532ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":8,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"info","ts":"2026-06-15T19:07:54.171527Z","caller":"traceutil/trace.go:171","msg":"trace[1919410500] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"144.438105ms","start":"2026-06-15T19:07:54.027068Z","end":"2026-06-15T19:07:54.171506Z","steps":["trace[1919410500] 'read index received' (duration: 144.245648ms)","trace[1919410500] 'applied index is now lower than readState.Index' (duration: 191.597µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:54.171627Z","caller":"traceutil/trace.go:171","msg":"trace[1813461491] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"156.865143ms","start":"2026-06-15T19:07:54.014725Z","end":"2026-06-15T19:07:54.17159Z","steps":["trace[1813461491] 'process raft request' (duration: 156.637136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:54.171739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.647462ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-15T19:07:54.171774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.625941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:07:54.171817Z","caller":"traceutil/trace.go:171","msg":"trace[1957634686] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1300; }","duration":"144.701833ms","start":"2026-06-15T19:07:54.027105Z","end":"2026-06-15T19:07:54.171807Z","steps":["trace[1957634686] 'agreement among raft nodes before linearized reading' (duration: 144.530288ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:54.17182Z","caller":"traceutil/trace.go:171","msg":"trace[421970726] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1300; }","duration":"144.799726ms","start":"2026-06-15T19:07:54.027004Z","end":"2026-06-15T19:07:54.171804Z","steps":["trace[421970726] 'agreement among raft nodes before linearized reading' (duration: 144.589219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:54.171858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.623521ms","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-15T19:07:54.171913Z","caller":"traceutil/trace.go:171","msg":"trace[258915737] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1300; }","duration":"144.685663ms","start":"2026-06-15T19:07:54.027207Z","end":"2026-06-15T19:07:54.171892Z","steps":["trace[258915737] 'agreement among raft nodes before linearized reading' (duration: 144.559839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:54.171922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.198567ms","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-15T19:07:54.171991Z","caller":"traceutil/trace.go:171","msg":"trace[491418796] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1300; }","duration":"144.3142ms","start":"2026-06-15T19:07:54.027658Z","end":"2026-06-15T19:07:54.171973Z","steps":["trace[491418796] 'agreement among raft nodes before linearized reading' (duration: 144.080333ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:54.526445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.595121ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:54.526862Z","caller":"traceutil/trace.go:171","msg":"trace[1374256215] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"349.822021ms","start":"2026-06-15T19:07:54.177021Z","end":"2026-06-15T19:07:54.526843Z","steps":["trace[1374256215] 'process raft request' (duration: 349.535542ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:54.526913Z","caller":"traceutil/trace.go:171","msg":"trace[1551465397] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"349.865353ms","start":"2026-06-15T19:07:54.177017Z","end":"2026-06-15T19:07:54.526882Z","steps":["trace[1551465397] 'process raft request' (duration: 75.710934ms)","trace[1551465397] 'compare' (duration: 273.222469ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:54.527178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:54.177Z","time spent":"350.099261ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:54.527118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:54.176993Z","time spent":"349.938825ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:54.616878Z","caller":"traceutil/trace.go:171","msg":"trace[1707907348] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"439.796483ms","start":"2026-06-15T19:07:54.177059Z","end":"2026-06-15T19:07:54.616855Z","steps":["trace[1707907348] 'process raft request' (duration: 439.764892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:54.616999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:54.177045Z","time spent":"439.895016ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:54.617111Z","caller":"traceutil/trace.go:171","msg":"trace[15512461] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"440.100102ms","start":"2026-06-15T19:07:54.177005Z","end":"2026-06-15T19:07:54.617105Z","steps":["trace[15512461] 'process raft request' (duration: 439.690079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:54.61715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:54.176979Z","time spent":"440.150474ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:55.416045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"432.498169ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:07:55.416147Z","caller":"traceutil/trace.go:171","msg":"trace[1519072500] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1360; }","duration":"482.861892ms","start":"2026-06-15T19:07:54.933269Z","end":"2026-06-15T19:07:55.416131Z","steps":["trace[1519072500] 'read index received' (duration: 50.205838ms)","trace[1519072500] 'applied index is now lower than readState.Index' (duration: 432.655004ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:55.416207Z","caller":"traceutil/trace.go:171","msg":"trace[2106383062] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"563.115841ms","start":"2026-06-15T19:07:54.853082Z","end":"2026-06-15T19:07:55.416197Z","steps":["trace[2106383062] 'process raft request' (duration: 130.374744ms)","trace[2106383062] 'compare' (duration: 432.134147ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:55.416259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:54.853052Z","time spent":"563.184803ms","remote":"127.0.0.1:38224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T19:07:55.416535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"483.262354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-15T19:07:55.416572Z","caller":"traceutil/trace.go:171","msg":"trace[1761163532] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1307; }","duration":"483.339156ms","start":"2026-06-15T19:07:54.933224Z","end":"2026-06-15T19:07:55.416563Z","steps":["trace[1761163532] 'agreement among raft nodes before linearized reading' (duration: 483.199252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:55.416602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:54.933183Z","time spent":"483.413109ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-15T19:07:55.453196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.324192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:55.453197Z","caller":"traceutil/trace.go:171","msg":"trace[1406758080] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"516.027953ms","start":"2026-06-15T19:07:54.937133Z","end":"2026-06-15T19:07:55.453161Z","steps":["trace[1406758080] 'process raft request' (duration: 515.826927ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:07:55.453299Z","caller":"traceutil/trace.go:171","msg":"trace[2081744994] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1308; }","duration":"229.450266ms","start":"2026-06-15T19:07:55.223806Z","end":"2026-06-15T19:07:55.453256Z","steps":["trace[2081744994] 'agreement among raft nodes before linearized reading' (duration: 229.303802ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:55.453197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.79166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T19:07:55.453348Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:54.937108Z","time spent":"516.169158ms","remote":"127.0.0.1:38224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:07:55.453396Z","caller":"traceutil/trace.go:171","msg":"trace[2010685820] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1308; }","duration":"157.037768ms","start":"2026-06-15T19:07:55.296339Z","end":"2026-06-15T19:07:55.453377Z","steps":["trace[2010685820] 'agreement among raft nodes before linearized reading' (duration: 156.753299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:55.453586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.67885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:55.453616Z","caller":"traceutil/trace.go:171","msg":"trace[1968228523] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1308; }","duration":"425.768473ms","start":"2026-06-15T19:07:55.02784Z","end":"2026-06-15T19:07:55.453609Z","steps":["trace[1968228523] 'agreement among raft nodes before linearized reading' (duration: 425.239896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:55.453667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:55.027823Z","time spent":"425.822505ms","remote":"127.0.0.1:34310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-15T19:07:55.955172Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2281247813161736557,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T19:07:56.129758Z","caller":"traceutil/trace.go:171","msg":"trace[567608905] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"708.64937ms","start":"2026-06-15T19:07:55.421085Z","end":"2026-06-15T19:07:56.129735Z","steps":["trace[567608905] 'process raft request' (duration: 708.585488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:56.129923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:55.421064Z","time spent":"708.759223ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:07:56.130134Z","caller":"traceutil/trace.go:171","msg":"trace[1493084780] transaction","detail":"{read_only:false; response_revision:1309; number_of_response:1; }","duration":"709.954082ms","start":"2026-06-15T19:07:55.420171Z","end":"2026-06-15T19:07:56.130125Z","steps":["trace[1493084780] 'process raft request' (duration: 709.393024ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:56.13018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:55.420152Z","time spent":"710.006163ms","remote":"127.0.0.1:38224","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T19:07:56.448452Z","caller":"traceutil/trace.go:171","msg":"trace[123456309] linearizableReadLoop","detail":"{readStateIndex:1365; appliedIndex:1362; }","duration":"994.151062ms","start":"2026-06-15T19:07:55.454283Z","end":"2026-06-15T19:07:56.448434Z","steps":["trace[123456309] 'read index received' (duration: 675.147448ms)","trace[123456309] 'applied index is now lower than readState.Index' (duration: 319.002654ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:07:56.448491Z","caller":"traceutil/trace.go:171","msg":"trace[1011087849] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"640.609642ms","start":"2026-06-15T19:07:55.807837Z","end":"2026-06-15T19:07:56.448447Z","steps":["trace[1011087849] 'process raft request' (duration: 548.39252ms)","trace[1011087849] 'compare' (duration: 92.124039ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:07:56.448565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.266876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:56.448597Z","caller":"traceutil/trace.go:171","msg":"trace[597408367] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1311; }","duration":"994.338668ms","start":"2026-06-15T19:07:55.454251Z","end":"2026-06-15T19:07:56.44859Z","steps":["trace[597408367] 'agreement among raft nodes before linearized reading' (duration: 994.278506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:56.448616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:55.454239Z","time spent":"994.371639ms","remote":"127.0.0.1:38166","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-15T19:07:56.448652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:55.807814Z","time spent":"640.752427ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:07:56.448691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.784037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:83966"} {"level":"info","ts":"2026-06-15T19:07:56.448737Z","caller":"traceutil/trace.go:171","msg":"trace[302242219] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1311; }","duration":"531.87119ms","start":"2026-06-15T19:07:55.916854Z","end":"2026-06-15T19:07:56.448725Z","steps":["trace[302242219] 'agreement among raft nodes before linearized reading' (duration: 531.689495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:56.448768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:55.916837Z","time spent":"531.923723ms","remote":"127.0.0.1:38204","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":83989,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-06-15T19:07:56.448817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.44981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:07:56.448837Z","caller":"traceutil/trace.go:171","msg":"trace[1292182527] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1311; }","duration":"295.507482ms","start":"2026-06-15T19:07:56.153325Z","end":"2026-06-15T19:07:56.448832Z","steps":["trace[1292182527] 'agreement among raft nodes before linearized reading' (duration: 295.467191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:56.448941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.378713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-15T19:07:56.448954Z","caller":"traceutil/trace.go:171","msg":"trace[169658961] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1311; }","duration":"273.428915ms","start":"2026-06-15T19:07:56.175521Z","end":"2026-06-15T19:07:56.44895Z","steps":["trace[169658961] 'agreement among raft nodes before linearized reading' (duration: 273.388213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:56.449051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"521.157888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-15T19:07:56.449082Z","caller":"traceutil/trace.go:171","msg":"trace[486329910] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1311; }","duration":"521.203329ms","start":"2026-06-15T19:07:55.927872Z","end":"2026-06-15T19:07:56.449076Z","steps":["trace[486329910] 'agreement among raft nodes before linearized reading' (duration: 521.063894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:07:56.449099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:07:55.927866Z","time spent":"521.229329ms","remote":"127.0.0.1:38218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":141,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-06-15T19:08:02.796346Z","caller":"traceutil/trace.go:171","msg":"trace[1798365938] linearizableReadLoop","detail":"{readStateIndex:1421; appliedIndex:1420; }","duration":"299.657665ms","start":"2026-06-15T19:08:02.496666Z","end":"2026-06-15T19:08:02.796323Z","steps":["trace[1798365938] 'read index received' (duration: 299.461709ms)","trace[1798365938] 'applied index is now lower than readState.Index' (duration: 195.116µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:08:02.796691Z","caller":"traceutil/trace.go:171","msg":"trace[929896361] transaction","detail":"{read_only:false; response_revision:1366; number_of_response:1; }","duration":"330.596946ms","start":"2026-06-15T19:08:02.466071Z","end":"2026-06-15T19:08:02.796667Z","steps":["trace[929896361] 'process raft request' (duration: 330.119051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:02.796728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"300.040367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-15T19:08:02.796753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.586644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-15T19:08:02.79681Z","caller":"traceutil/trace.go:171","msg":"trace[2000103411] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1366; }","duration":"300.182162ms","start":"2026-06-15T19:08:02.496607Z","end":"2026-06-15T19:08:02.796789Z","steps":["trace[2000103411] 'agreement among raft nodes before linearized reading' (duration: 299.907683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:02.796829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:02.466051Z","time spent":"330.689109ms","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:08:02.796869Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:02.496585Z","time spent":"300.275155ms","remote":"127.0.0.1:34104","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-15T19:08:02.796903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.259232ms","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-15T19:08:02.796827Z","caller":"traceutil/trace.go:171","msg":"trace[577848192] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1366; }","duration":"156.696208ms","start":"2026-06-15T19:08:02.640107Z","end":"2026-06-15T19:08:02.796803Z","steps":["trace[577848192] 'agreement among raft nodes before linearized reading' (duration: 156.501141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:02.797046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.349026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-15T19:08:02.796754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.344272ms","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-15T19:08:02.797087Z","caller":"traceutil/trace.go:171","msg":"trace[764642649] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1366; }","duration":"149.712674ms","start":"2026-06-15T19:08:02.64736Z","end":"2026-06-15T19:08:02.797073Z","steps":["trace[764642649] 'agreement among raft nodes before linearized reading' (duration: 149.26485ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:02.797106Z","caller":"traceutil/trace.go:171","msg":"trace[1814586409] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1366; }","duration":"156.403968ms","start":"2026-06-15T19:08:02.640658Z","end":"2026-06-15T19:08:02.797062Z","steps":["trace[1814586409] 'agreement among raft nodes before linearized reading' (duration: 156.333116ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:02.796929Z","caller":"traceutil/trace.go:171","msg":"trace[553280172] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1366; }","duration":"150.305083ms","start":"2026-06-15T19:08:02.646617Z","end":"2026-06-15T19:08:02.796922Z","steps":["trace[553280172] 'agreement among raft nodes before linearized reading' (duration: 150.22954ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:03.039088Z","caller":"traceutil/trace.go:171","msg":"trace[1224404101] transaction","detail":"{read_only:false; response_revision:1367; number_of_response:1; }","duration":"237.571363ms","start":"2026-06-15T19:08:02.801495Z","end":"2026-06-15T19:08:03.039067Z","steps":["trace[1224404101] 'process raft request' (duration: 206.679664ms)","trace[1224404101] 'compare' (duration: 30.790396ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:08:04.382707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091753414s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T19:08:04.38291Z","caller":"traceutil/trace.go:171","msg":"trace[1122397141] transaction","detail":"{read_only:false; response_revision:1368; number_of_response:1; }","duration":"1.581109849s","start":"2026-06-15T19:08:02.801774Z","end":"2026-06-15T19:08:04.382884Z","steps":["trace[1122397141] 'process raft request' (duration: 489.119567ms)","trace[1122397141] 'compare' (duration: 1.091481446s)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:08:04.383039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:02.801764Z","time spent":"1.581211843s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:08:04.383239Z","caller":"traceutil/trace.go:171","msg":"trace[1701686199] transaction","detail":"{read_only:false; response_revision:1369; number_of_response:1; }","duration":"1.58112219s","start":"2026-06-15T19:08:02.802109Z","end":"2026-06-15T19:08:04.383231Z","steps":["trace[1701686199] 'process raft request' (duration: 1.580688536s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:04.383276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:02.802087Z","time spent":"1.581167571s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T19:08:04.383406Z","caller":"traceutil/trace.go:171","msg":"trace[2007156612] transaction","detail":"{read_only:false; response_revision:1370; number_of_response:1; }","duration":"1.581231804s","start":"2026-06-15T19:08:02.802168Z","end":"2026-06-15T19:08:04.3834Z","steps":["trace[2007156612] 'process raft request' (duration: 1.580690856s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:04.383459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:02.80215Z","time spent":"1.581290775s","remote":"127.0.0.1:34104","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-15T19:08:04.383592Z","caller":"traceutil/trace.go:171","msg":"trace[778603946] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"1.581313556s","start":"2026-06-15T19:08:02.802228Z","end":"2026-06-15T19:08:04.383542Z","steps":["trace[778603946] 'process raft request' (duration: 1.580656445s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:04.384131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:02.802201Z","time spent":"1.581470351s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T19:08:04.52195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.022321ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T19:08:04.522019Z","caller":"traceutil/trace.go:171","msg":"trace[526128055] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1421; }","duration":"1.567939929s","start":"2026-06-15T19:08:02.954067Z","end":"2026-06-15T19:08:04.522007Z","steps":["trace[526128055] 'read index received' (duration: 54.08521ms)","trace[526128055] 'applied index is now lower than readState.Index' (duration: 1.513853759s)"],"step_count":2} {"level":"warn","ts":"2026-06-15T19:08:04.522163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.568086775s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-15T19:08:04.522166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.295628192s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T19:08:04.522193Z","caller":"traceutil/trace.go:171","msg":"trace[1335383023] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1371; }","duration":"1.568148796s","start":"2026-06-15T19:08:02.954033Z","end":"2026-06-15T19:08:04.522182Z","steps":["trace[1335383023] 'agreement among raft nodes before linearized reading' (duration: 1.568035822s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:04.522228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:02.954015Z","time spent":"1.568205758s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-15T19:08:04.522227Z","caller":"traceutil/trace.go:171","msg":"trace[497879558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1371; }","duration":"1.295743526s","start":"2026-06-15T19:08:03.226467Z","end":"2026-06-15T19:08:04.522211Z","steps":["trace[497879558] 'agreement among raft nodes before linearized reading' (duration: 1.295647103s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:04.522258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:03.226439Z","time spent":"1.295813428s","remote":"127.0.0.1:38158","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-15T19:08:04.522446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.191299441s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-15T19:08:04.522534Z","caller":"traceutil/trace.go:171","msg":"trace[414393972] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1371; }","duration":"1.191400974s","start":"2026-06-15T19:08:03.331113Z","end":"2026-06-15T19:08:04.522514Z","steps":["trace[414393972] 'agreement among raft nodes before linearized reading' (duration: 1.191068804s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:04.522577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T19:08:03.331049Z","time spent":"1.191518888s","remote":"127.0.0.1:34104","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-15T19:08:44.805438Z","caller":"traceutil/trace.go:171","msg":"trace[1149335800] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"221.168935ms","start":"2026-06-15T19:08:44.58424Z","end":"2026-06-15T19:08:44.805409Z","steps":["trace[1149335800] 'process raft request' (duration: 221.048381ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:08:44.809054Z","caller":"traceutil/trace.go:171","msg":"trace[1320584547] linearizableReadLoop","detail":"{readStateIndex:1621; appliedIndex:1620; }","duration":"209.15166ms","start":"2026-06-15T19:08:44.599883Z","end":"2026-06-15T19:08:44.809035Z","steps":["trace[1320584547] 'read index received' (duration: 205.513783ms)","trace[1320584547] 'applied index is now lower than readState.Index' (duration: 3.636917ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T19:08:44.809156Z","caller":"traceutil/trace.go:171","msg":"trace[935195366] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"224.432289ms","start":"2026-06-15T19:08:44.58469Z","end":"2026-06-15T19:08:44.809122Z","steps":["trace[935195366] 'process raft request' (duration: 224.271714ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:44.809456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.443831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:532"} {"level":"info","ts":"2026-06-15T19:08:44.809501Z","caller":"traceutil/trace.go:171","msg":"trace[887162137] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1557; }","duration":"109.540803ms","start":"2026-06-15T19:08:44.69995Z","end":"2026-06-15T19:08:44.809491Z","steps":["trace[887162137] 'agreement among raft nodes before linearized reading' (duration: 109.253064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:08:44.809701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.808982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-15T19:08:44.809766Z","caller":"traceutil/trace.go:171","msg":"trace[1665912816] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1557; }","duration":"209.900864ms","start":"2026-06-15T19:08:44.599847Z","end":"2026-06-15T19:08:44.809748Z","steps":["trace[1665912816] 'agreement among raft nodes before linearized reading' (duration: 209.311025ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:22.908332Z","caller":"traceutil/trace.go:171","msg":"trace[1702190997] transaction","detail":"{read_only:false; response_revision:1731; number_of_response:1; }","duration":"114.07142ms","start":"2026-06-15T19:09:22.794234Z","end":"2026-06-15T19:09:22.908305Z","steps":["trace[1702190997] 'process raft request' (duration: 113.862774ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T19:09:22.916046Z","caller":"traceutil/trace.go:171","msg":"trace[1863220570] transaction","detail":"{read_only:false; response_revision:1732; number_of_response:1; }","duration":"119.687129ms","start":"2026-06-15T19:09:22.796336Z","end":"2026-06-15T19:09:22.916023Z","steps":["trace[1863220570] 'process raft request' (duration: 119.550045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T19:09:25.159522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.366355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-15T19:09:25.159619Z","caller":"traceutil/trace.go:171","msg":"trace[1010569618] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1743; }","duration":"127.470098ms","start":"2026-06-15T19:09:25.032127Z","end":"2026-06-15T19:09:25.159597Z","steps":["trace[1010569618] 'agreement among raft nodes before linearized reading' (duration: 127.21909ms)"],"step_count":1}