{"level":"warn","ts":"2026-05-14T07:28:26.825696Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T07:28:26.825776Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-05-14T07:28:26.825833Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-14T07:28:26.825845Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-14T07:28:26.825862Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-14T07:28:26.826536Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-05-14T07:28:26.826641Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-05-14T07:28:26.832932Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.444421ms"} {"level":"info","ts":"2026-05-14T07:28:26.839864Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-05-14T07:28:26.840031Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-14T07:28:26.840065Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-05-14T07:28:26.840088Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-14T07:28:26.840101Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-05-14T07:28:26.840337Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-05-14T07:28:26.851152Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-14T07:28:26.85267Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-14T07:28:26.854116Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-05-14T07:28:26.856452Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-14T07:28:26.857091Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-14T07:28:26.857092Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-14T07:28:26.857183Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-14T07:28:26.857192Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-05-14T07:28:26.860073Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-05-14T07:28:26.860215Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-14T07:28:26.860954Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-05-14T07:28:26.861161Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-14T07:28:26.861194Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-14T07:28:26.861246Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-14T07:28:26.86128Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-14T07:28:27.8415Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-14T07:28:27.841588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-14T07:28:27.841634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-05-14T07:28:27.841654Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-05-14T07:28:27.841666Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-14T07:28:27.841685Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-05-14T07:28:27.841704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-14T07:28:28.123149Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-05-14T07:28:28.123155Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T07:28:28.123165Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T07:28:28.123288Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-14T07:28:28.123482Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-14T07:28:28.123698Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-14T07:28:28.126665Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-05-14T07:28:28.12686Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"warn","ts":"2026-05-14T07:28:28.381809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.287051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"","error":"context canceled"} {"level":"warn","ts":"2026-05-14T07:28:28.381916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.363013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"","error":"context canceled"} {"level":"info","ts":"2026-05-14T07:28:28.381979Z","caller":"traceutil/trace.go:171","msg":"trace[988259188] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"111.469166ms","start":"2026-05-14T07:28:28.270496Z","end":"2026-05-14T07:28:28.381965Z","steps":["trace[988259188] 'agreement among raft nodes before linearized reading' (duration: 111.388694ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.381953Z","caller":"traceutil/trace.go:171","msg":"trace[754867224] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; }","duration":"111.482755ms","start":"2026-05-14T07:28:28.270455Z","end":"2026-05-14T07:28:28.381938Z","steps":["trace[754867224] 'agreement among raft nodes before linearized reading' (duration: 111.297421ms)"],"step_count":1} 2026/05/14 07:28:28 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" 2026/05/14 07:28:28 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"info","ts":"2026-05-14T07:28:28.538751Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T07:28:28.538873Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-14T07:28:28.538915Z","caller":"traceutil/trace.go:171","msg":"trace[1416052669] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"367.474529ms","start":"2026-05-14T07:28:28.171428Z","end":"2026-05-14T07:28:28.538902Z","steps":["trace[1416052669] 'read index received' (duration: 367.264094ms)","trace[1416052669] 'applied index is now lower than readState.Index' (duration: 209.465µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:28:28.538956Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-14T07:28:28.539136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.691063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.539172Z","caller":"traceutil/trace.go:171","msg":"trace[1069517924] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"367.741634ms","start":"2026-05-14T07:28:28.171418Z","end":"2026-05-14T07:28:28.53916Z","steps":["trace[1069517924] 'agreement among raft nodes before linearized reading' (duration: 367.55684ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.539195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:28.171394Z","time spent":"367.793765ms","remote":"127.0.0.1:56118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":121,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 "} {"level":"warn","ts":"2026-05-14T07:28:28.539436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.785595ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.539599Z","caller":"traceutil/trace.go:171","msg":"trace[216018235] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"367.969279ms","start":"2026-05-14T07:28:28.171584Z","end":"2026-05-14T07:28:28.539553Z","steps":["trace[216018235] 'agreement among raft nodes before linearized reading' (duration: 367.56108ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.5397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:28.171529Z","time spent":"368.154813ms","remote":"127.0.0.1:56118","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":0,"response size":27,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-05-14T07:28:28.53986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.926303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.539892Z","caller":"traceutil/trace.go:171","msg":"trace[1800589317] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"105.978483ms","start":"2026-05-14T07:28:28.433906Z","end":"2026-05-14T07:28:28.539884Z","steps":["trace[1800589317] 'agreement among raft nodes before linearized reading' (duration: 105.933412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.54001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.131717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.540035Z","caller":"traceutil/trace.go:171","msg":"trace[648931918] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"106.180487ms","start":"2026-05-14T07:28:28.433848Z","end":"2026-05-14T07:28:28.540028Z","steps":["trace[648931918] 'agreement among raft nodes before linearized reading' (duration: 106.143837ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.540122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.084149ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.540144Z","caller":"traceutil/trace.go:171","msg":"trace[1575868854] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"117.1198ms","start":"2026-05-14T07:28:28.423019Z","end":"2026-05-14T07:28:28.540138Z","steps":["trace[1575868854] 'agreement among raft nodes before linearized reading' (duration: 117.080789ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.540127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.734546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.540291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.280464ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.540318Z","caller":"traceutil/trace.go:171","msg":"trace[717175798] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1; }","duration":"117.337805ms","start":"2026-05-14T07:28:28.422973Z","end":"2026-05-14T07:28:28.540311Z","steps":["trace[717175798] 'agreement among raft nodes before linearized reading' (duration: 117.294954ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.540385Z","caller":"traceutil/trace.go:171","msg":"trace[39171940] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"245.93108ms","start":"2026-05-14T07:28:28.29436Z","end":"2026-05-14T07:28:28.540291Z","steps":["trace[39171940] 'agreement among raft nodes before linearized reading' (duration: 245.626253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.54044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.480168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.540462Z","caller":"traceutil/trace.go:171","msg":"trace[1322823183] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"158.519059ms","start":"2026-05-14T07:28:28.381937Z","end":"2026-05-14T07:28:28.540456Z","steps":["trace[1322823183] 'agreement among raft nodes before linearized reading' (duration: 158.474818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.540597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.668982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.540621Z","caller":"traceutil/trace.go:171","msg":"trace[18159487] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:1; }","duration":"158.706713ms","start":"2026-05-14T07:28:28.381908Z","end":"2026-05-14T07:28:28.540615Z","steps":["trace[18159487] 'agreement among raft nodes before linearized reading' (duration: 158.662822ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.540709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.795391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.540732Z","caller":"traceutil/trace.go:171","msg":"trace[400478132] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"165.823482ms","start":"2026-05-14T07:28:28.374902Z","end":"2026-05-14T07:28:28.540726Z","steps":["trace[400478132] 'agreement among raft nodes before linearized reading' (duration: 165.784151ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.540803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.738886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.540892Z","caller":"traceutil/trace.go:171","msg":"trace[36712681] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"291.86582ms","start":"2026-05-14T07:28:28.249008Z","end":"2026-05-14T07:28:28.540874Z","steps":["trace[36712681] 'agreement among raft nodes before linearized reading' (duration: 291.697166ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.619666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.541111Z","caller":"traceutil/trace.go:171","msg":"trace[1835368199] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1; }","duration":"246.704688ms","start":"2026-05-14T07:28:28.294392Z","end":"2026-05-14T07:28:28.541097Z","steps":["trace[1835368199] 'agreement among raft nodes before linearized reading' (duration: 245.255215ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.782514ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.541126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.159359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.541158Z","caller":"traceutil/trace.go:171","msg":"trace[670445456] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"257.335624ms","start":"2026-05-14T07:28:28.283813Z","end":"2026-05-14T07:28:28.541149Z","steps":["trace[670445456] 'agreement among raft nodes before linearized reading' (duration: 257.284643ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.962498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.541216Z","caller":"traceutil/trace.go:171","msg":"trace[262778092] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"212.997229ms","start":"2026-05-14T07:28:28.328208Z","end":"2026-05-14T07:28:28.541206Z","steps":["trace[262778092] 'agreement among raft nodes before linearized reading' (duration: 212.962678ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.868195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.541384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.434943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.541411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.263075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.541413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.987729ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.541422Z","caller":"traceutil/trace.go:171","msg":"trace[840420947] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"192.507975ms","start":"2026-05-14T07:28:28.348904Z","end":"2026-05-14T07:28:28.541412Z","steps":["trace[840420947] 'agreement among raft nodes before linearized reading' (duration: 192.452273ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.541436Z","caller":"traceutil/trace.go:171","msg":"trace[1684502777] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"227.298006ms","start":"2026-05-14T07:28:28.314129Z","end":"2026-05-14T07:28:28.541427Z","steps":["trace[1684502777] 'agreement among raft nodes before linearized reading' (duration: 227.250455ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.541441Z","caller":"traceutil/trace.go:171","msg":"trace[429137829] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"281.02748ms","start":"2026-05-14T07:28:28.260405Z","end":"2026-05-14T07:28:28.541432Z","steps":["trace[429137829] 'agreement among raft nodes before linearized reading' (duration: 280.989759ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.395992ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.541513Z","caller":"traceutil/trace.go:171","msg":"trace[300410857] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"292.471254ms","start":"2026-05-14T07:28:28.249034Z","end":"2026-05-14T07:28:28.541506Z","steps":["trace[300410857] 'agreement among raft nodes before linearized reading' (duration: 292.390082ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.541558Z","caller":"traceutil/trace.go:171","msg":"trace[624349361] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"302.987927ms","start":"2026-05-14T07:28:28.238417Z","end":"2026-05-14T07:28:28.541405Z","steps":["trace[624349361] 'agreement among raft nodes before linearized reading' (duration: 302.805983ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.870956ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.541629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.740549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.54166Z","caller":"traceutil/trace.go:171","msg":"trace[783357578] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:1; }","duration":"192.815861ms","start":"2026-05-14T07:28:28.348835Z","end":"2026-05-14T07:28:28.541651Z","steps":["trace[783357578] 'agreement among raft nodes before linearized reading' (duration: 192.76482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541757Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:28.238407Z","time spent":"303.326195ms","remote":"127.0.0.1:56158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-14T07:28:28.541842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.246587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.539502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.858701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.54085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.959064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.541887Z","caller":"traceutil/trace.go:171","msg":"trace[1205078624] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"167.003218ms","start":"2026-05-14T07:28:28.374874Z","end":"2026-05-14T07:28:28.541877Z","steps":["trace[1205078624] 'agreement among raft nodes before linearized reading' (duration: 165.948834ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"303.477749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.541935Z","caller":"traceutil/trace.go:171","msg":"trace[1968604653] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"303.52711ms","start":"2026-05-14T07:28:28.238391Z","end":"2026-05-14T07:28:28.541918Z","steps":["trace[1968604653] 'agreement among raft nodes before linearized reading' (duration: 303.473818ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.212524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.542003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.925759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-14T07:28:28.541972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:28.238382Z","time spent":"303.582831ms","remote":"127.0.0.1:56158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 "} {"level":"info","ts":"2026-05-14T07:28:28.542022Z","caller":"traceutil/trace.go:171","msg":"trace[1513205106] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"322.96725ms","start":"2026-05-14T07:28:28.219049Z","end":"2026-05-14T07:28:28.542016Z","steps":["trace[1513205106] 'agreement among raft nodes before linearized reading' (duration: 322.938889ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.542039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:28.219036Z","time spent":"322.999561ms","remote":"127.0.0.1:56136","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":0,"response size":27,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-05-14T07:28:28.542069Z","caller":"traceutil/trace.go:171","msg":"trace[1008504293] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"181.446808ms","start":"2026-05-14T07:28:28.360599Z","end":"2026-05-14T07:28:28.542046Z","steps":["trace[1008504293] 'agreement among raft nodes before linearized reading' (duration: 178.875041ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.542107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.323607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.542127Z","caller":"traceutil/trace.go:171","msg":"trace[36796979] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"313.353887ms","start":"2026-05-14T07:28:28.228767Z","end":"2026-05-14T07:28:28.542121Z","steps":["trace[36796979] 'agreement among raft nodes before linearized reading' (duration: 313.323446ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.542Z","caller":"traceutil/trace.go:171","msg":"trace[2145407581] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"313.259325ms","start":"2026-05-14T07:28:28.228735Z","end":"2026-05-14T07:28:28.541994Z","steps":["trace[2145407581] 'agreement among raft nodes before linearized reading' (duration: 313.211404ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.542146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:28.228762Z","time spent":"313.378987ms","remote":"127.0.0.1:56152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-14T07:28:28.542154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:28.228726Z","time spent":"313.420539ms","remote":"127.0.0.1:56152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 "} {"level":"warn","ts":"2026-05-14T07:28:28.541331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.689472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.54227Z","caller":"traceutil/trace.go:171","msg":"trace[175696225] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"205.698246ms","start":"2026-05-14T07:28:28.336562Z","end":"2026-05-14T07:28:28.54226Z","steps":["trace[175696225] 'agreement among raft nodes before linearized reading' (duration: 205.260077ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.542303Z","caller":"traceutil/trace.go:171","msg":"trace[2037121228] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1; }","duration":"181.785826ms","start":"2026-05-14T07:28:28.360505Z","end":"2026-05-14T07:28:28.542291Z","steps":["trace[2037121228] 'agreement among raft nodes before linearized reading' (duration: 180.678282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.405704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.542559Z","caller":"traceutil/trace.go:171","msg":"trace[2006394183] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"258.630222ms","start":"2026-05-14T07:28:28.283891Z","end":"2026-05-14T07:28:28.542521Z","steps":["trace[2006394183] 'agreement among raft nodes before linearized reading' (duration: 257.405265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.542605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.899774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.542647Z","caller":"traceutil/trace.go:171","msg":"trace[874594314] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"238.953094ms","start":"2026-05-14T07:28:28.303687Z","end":"2026-05-14T07:28:28.542641Z","steps":["trace[874594314] 'agreement among raft nodes before linearized reading' (duration: 238.899243ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.541161Z","caller":"traceutil/trace.go:171","msg":"trace[2110136508] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1; }","duration":"212.884386ms","start":"2026-05-14T07:28:28.328261Z","end":"2026-05-14T07:28:28.541145Z","steps":["trace[2110136508] 'agreement among raft nodes before linearized reading' (duration: 212.807514ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.179865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.54281Z","caller":"traceutil/trace.go:171","msg":"trace[1687239031] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1; }","duration":"206.251919ms","start":"2026-05-14T07:28:28.336551Z","end":"2026-05-14T07:28:28.542803Z","steps":["trace[1687239031] 'agreement among raft nodes before linearized reading' (duration: 205.226107ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.54257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.856423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.542944Z","caller":"traceutil/trace.go:171","msg":"trace[57290638] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1; }","duration":"239.242301ms","start":"2026-05-14T07:28:28.303693Z","end":"2026-05-14T07:28:28.542935Z","steps":["trace[57290638] 'agreement among raft nodes before linearized reading' (duration: 238.855652ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:28.541617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.500821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-14T07:28:28.543Z","caller":"traceutil/trace.go:171","msg":"trace[1226394688] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:1; }","duration":"228.906062ms","start":"2026-05-14T07:28:28.314086Z","end":"2026-05-14T07:28:28.542992Z","steps":["trace[1226394688] 'agreement among raft nodes before linearized reading' (duration: 227.45816ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:28.543Z","caller":"traceutil/trace.go:171","msg":"trace[559073060] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"282.508552ms","start":"2026-05-14T07:28:28.26048Z","end":"2026-05-14T07:28:28.542989Z","steps":["trace[559073060] 'agreement among raft nodes before linearized reading' (duration: 280.868316ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:31.145075Z","caller":"traceutil/trace.go:171","msg":"trace[524403847] transaction","detail":"{read_only:false; response_revision:175; number_of_response:1; }","duration":"166.061217ms","start":"2026-05-14T07:28:30.978987Z","end":"2026-05-14T07:28:31.145048Z","steps":["trace[524403847] 'process raft request' (duration: 156.644329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:56.549526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.30325ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"warn","ts":"2026-05-14T07:28:57.070003Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.814504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:28:57.070108Z","caller":"traceutil/trace.go:171","msg":"trace[1108229032] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:509; }","duration":"373.971268ms","start":"2026-05-14T07:28:56.696114Z","end":"2026-05-14T07:28:57.070085Z","steps":["trace[1108229032] 'range keys from in-memory index tree' (duration: 373.727191ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:28:57.070153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:28:56.696094Z","time spent":"374.049299ms","remote":"127.0.0.1:56158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" "} {"level":"info","ts":"2026-05-14T07:28:57.358489Z","caller":"traceutil/trace.go:171","msg":"trace[78907607] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"100.771568ms","start":"2026-05-14T07:28:57.257691Z","end":"2026-05-14T07:28:57.358463Z","steps":["trace[78907607] 'process raft request' (duration: 100.612835ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:57.365371Z","caller":"traceutil/trace.go:171","msg":"trace[1174373350] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"106.153368ms","start":"2026-05-14T07:28:57.259193Z","end":"2026-05-14T07:28:57.365346Z","steps":["trace[1174373350] 'process raft request' (duration: 105.918883ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:57.365442Z","caller":"traceutil/trace.go:171","msg":"trace[1622844004] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"103.287244ms","start":"2026-05-14T07:28:57.262121Z","end":"2026-05-14T07:28:57.365408Z","steps":["trace[1622844004] 'process raft request' (duration: 103.046809ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:57.365561Z","caller":"traceutil/trace.go:171","msg":"trace[446844943] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"106.417484ms","start":"2026-05-14T07:28:57.259098Z","end":"2026-05-14T07:28:57.365515Z","steps":["trace[446844943] 'process raft request' (duration: 105.950174ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:57.365673Z","caller":"traceutil/trace.go:171","msg":"trace[471914226] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"102.577129ms","start":"2026-05-14T07:28:57.263083Z","end":"2026-05-14T07:28:57.36566Z","steps":["trace[471914226] 'process raft request' (duration: 102.122249ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:28:57.365791Z","caller":"traceutil/trace.go:171","msg":"trace[259539364] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"100.291118ms","start":"2026-05-14T07:28:57.265486Z","end":"2026-05-14T07:28:57.365778Z","steps":["trace[259539364] 'process raft request' (duration: 99.752997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:03.112838Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151051666644179,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T07:29:03.167761Z","caller":"traceutil/trace.go:171","msg":"trace[642950212] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"555.778386ms","start":"2026-05-14T07:29:02.611958Z","end":"2026-05-14T07:29:03.167737Z","steps":["trace[642950212] 'read index received' (duration: 554.810485ms)","trace[642950212] 'applied index is now lower than readState.Index' (duration: 966.921µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:29:03.167886Z","caller":"traceutil/trace.go:171","msg":"trace[464865698] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"889.766065ms","start":"2026-05-14T07:29:02.278109Z","end":"2026-05-14T07:29:03.167876Z","steps":["trace[464865698] 'process raft request' (duration: 889.06325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:03.168443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:02.278083Z","time spent":"889.837476ms","remote":"127.0.0.1:56158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036225,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:29:03.168833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.491044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:29:03.168913Z","caller":"traceutil/trace.go:171","msg":"trace[775996325] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"340.625357ms","start":"2026-05-14T07:29:02.828274Z","end":"2026-05-14T07:29:03.168899Z","steps":["trace[775996325] 'agreement among raft nodes before linearized reading' (duration: 340.513835ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:03.168992Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:02.828252Z","time spent":"340.733559ms","remote":"127.0.0.1:56046","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-05-14T07:29:03.16933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.371372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-14T07:29:03.169386Z","caller":"traceutil/trace.go:171","msg":"trace[1687538717] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:608; }","duration":"557.449603ms","start":"2026-05-14T07:29:02.611914Z","end":"2026-05-14T07:29:03.169363Z","steps":["trace[1687538717] 'agreement among raft nodes before linearized reading' (duration: 557.254879ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:03.169406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:02.611893Z","time spent":"557.508944ms","remote":"127.0.0.1:56310","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-05-14T07:29:03.990699Z","caller":"traceutil/trace.go:171","msg":"trace[1395287715] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"116.898477ms","start":"2026-05-14T07:29:03.873773Z","end":"2026-05-14T07:29:03.990672Z","steps":["trace[1395287715] 'read index received' (duration: 116.019288ms)","trace[1395287715] 'applied index is now lower than readState.Index' (duration: 878.099µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:29:03.990939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.156742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T07:29:03.990981Z","caller":"traceutil/trace.go:171","msg":"trace[1479779387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:615; }","duration":"117.216424ms","start":"2026-05-14T07:29:03.873753Z","end":"2026-05-14T07:29:03.990969Z","steps":["trace[1479779387] 'agreement among raft nodes before linearized reading' (duration: 117.065921ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:29:03.990761Z","caller":"traceutil/trace.go:171","msg":"trace[2047837954] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"326.201497ms","start":"2026-05-14T07:29:03.664531Z","end":"2026-05-14T07:29:03.990733Z","steps":["trace[2047837954] 'process raft request' (duration: 325.477551ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:03.991184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.325614ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-14T07:29:03.991247Z","caller":"traceutil/trace.go:171","msg":"trace[2036574989] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:615; }","duration":"116.455396ms","start":"2026-05-14T07:29:03.874776Z","end":"2026-05-14T07:29:03.991232Z","steps":["trace[2036574989] 'agreement among raft nodes before linearized reading' (duration: 116.325353ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:03.991463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:03.664499Z","time spent":"326.713428ms","remote":"127.0.0.1:56158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:29:04.424023Z","caller":"traceutil/trace.go:171","msg":"trace[1334966914] transaction","detail":"{read_only:false; response_revision:620; number_of_response:1; }","duration":"296.22226ms","start":"2026-05-14T07:29:04.127774Z","end":"2026-05-14T07:29:04.423996Z","steps":["trace[1334966914] 'process raft request' (duration: 289.538691ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:05.329916Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151051666644202,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:29:05.617311Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.095405284s","expected-duration":"1s"} {"level":"info","ts":"2026-05-14T07:29:05.618204Z","caller":"traceutil/trace.go:171","msg":"trace[227768504] linearizableReadLoop","detail":"{readStateIndex:645; appliedIndex:644; }","duration":"789.182762ms","start":"2026-05-14T07:29:04.829003Z","end":"2026-05-14T07:29:05.618186Z","steps":["trace[227768504] 'read index received' (duration: 788.458766ms)","trace[227768504] 'applied index is now lower than readState.Index' (duration: 723.056µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:29:05.6183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"789.288825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:29:05.618374Z","caller":"traceutil/trace.go:171","msg":"trace[1112943510] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:621; }","duration":"789.409657ms","start":"2026-05-14T07:29:04.828948Z","end":"2026-05-14T07:29:05.618358Z","steps":["trace[1112943510] 'agreement among raft nodes before linearized reading' (duration: 789.291425ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:05.618413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:04.828928Z","time spent":"789.478329ms","remote":"127.0.0.1:56046","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-05-14T07:29:05.618484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.773727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-14T07:29:05.618529Z","caller":"traceutil/trace.go:171","msg":"trace[1266732144] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:621; }","duration":"397.870129ms","start":"2026-05-14T07:29:05.220649Z","end":"2026-05-14T07:29:05.618519Z","steps":["trace[1266732144] 'agreement among raft nodes before linearized reading' (duration: 397.671745ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:05.618565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:05.220631Z","time spent":"397.92642ms","remote":"127.0.0.1:56310","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-05-14T07:29:05.618746Z","caller":"traceutil/trace.go:171","msg":"trace[1162047286] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"1.098653557s","start":"2026-05-14T07:29:04.520072Z","end":"2026-05-14T07:29:05.618726Z","steps":["trace[1162047286] 'process raft request' (duration: 1.097648885s)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:05.618907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:04.520045Z","time spent":"1.098778259s","remote":"127.0.0.1:56158","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036289,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:29:10.30887Z","caller":"traceutil/trace.go:171","msg":"trace[710556864] transaction","detail":"{read_only:false; response_revision:691; number_of_response:1; }","duration":"197.64496ms","start":"2026-05-14T07:29:10.111196Z","end":"2026-05-14T07:29:10.308841Z","steps":["trace[710556864] 'process raft request' (duration: 197.381654ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:29:10.410728Z","caller":"traceutil/trace.go:171","msg":"trace[464662495] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"299.335269ms","start":"2026-05-14T07:29:10.111365Z","end":"2026-05-14T07:29:10.4107Z","steps":["trace[464662495] 'process raft request' (duration: 283.573329ms)","trace[464662495] 'compare' (duration: 15.497155ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:29:10.411121Z","caller":"traceutil/trace.go:171","msg":"trace[1646010487] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"299.303279ms","start":"2026-05-14T07:29:10.111806Z","end":"2026-05-14T07:29:10.411109Z","steps":["trace[1646010487] 'process raft request' (duration: 298.850029ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:29:10.413016Z","caller":"traceutil/trace.go:171","msg":"trace[1183555178] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"246.896015ms","start":"2026-05-14T07:29:10.16611Z","end":"2026-05-14T07:29:10.413006Z","steps":["trace[1183555178] 'process raft request' (duration: 244.84052ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:29:10.413035Z","caller":"traceutil/trace.go:171","msg":"trace[587962335] linearizableReadLoop","detail":"{readStateIndex:718; appliedIndex:715; }","duration":"248.738725ms","start":"2026-05-14T07:29:10.164278Z","end":"2026-05-14T07:29:10.413017Z","steps":["trace[587962335] 'read index received' (duration: 144.288905ms)","trace[587962335] 'applied index is now lower than readState.Index' (duration: 104.44878ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:29:10.413192Z","caller":"traceutil/trace.go:171","msg":"trace[1371344389] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"230.705986ms","start":"2026-05-14T07:29:10.18248Z","end":"2026-05-14T07:29:10.413186Z","steps":["trace[1371344389] 'process raft request' (duration: 230.47636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:10.413584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.283148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-cv7xd\" ","response":"range_response_count:1 size:18063"} {"level":"info","ts":"2026-05-14T07:29:10.413647Z","caller":"traceutil/trace.go:171","msg":"trace[1043382163] range","detail":"{range_begin:/registry/pods/kube-system/cilium-cv7xd; range_end:; response_count:1; response_revision:695; }","duration":"249.38791ms","start":"2026-05-14T07:29:10.164245Z","end":"2026-05-14T07:29:10.413633Z","steps":["trace[1043382163] 'agreement among raft nodes before linearized reading' (duration: 249.019892ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:29:10.706217Z","caller":"traceutil/trace.go:171","msg":"trace[486442039] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"102.079857ms","start":"2026-05-14T07:29:10.604113Z","end":"2026-05-14T07:29:10.706193Z","steps":["trace[486442039] 'process raft request' (duration: 101.808801ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:29:20.565849Z","caller":"traceutil/trace.go:171","msg":"trace[224993808] linearizableReadLoop","detail":"{readStateIndex:809; appliedIndex:808; }","duration":"213.724499ms","start":"2026-05-14T07:29:20.352097Z","end":"2026-05-14T07:29:20.565822Z","steps":["trace[224993808] 'read index received' (duration: 213.528804ms)","trace[224993808] 'applied index is now lower than readState.Index' (duration: 194.605µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:29:20.566071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.901755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-14T07:29:20.566102Z","caller":"traceutil/trace.go:171","msg":"trace[623735423] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:781; }","duration":"106.985496ms","start":"2026-05-14T07:29:20.459107Z","end":"2026-05-14T07:29:20.566092Z","steps":["trace[623735423] 'agreement among raft nodes before linearized reading' (duration: 106.844273ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:20.566115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.001324ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-14T07:29:20.56619Z","caller":"traceutil/trace.go:171","msg":"trace[2011094635] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:781; }","duration":"214.125917ms","start":"2026-05-14T07:29:20.352047Z","end":"2026-05-14T07:29:20.566173Z","steps":["trace[2011094635] 'agreement among raft nodes before linearized reading' (duration: 213.910183ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:29:20.566331Z","caller":"traceutil/trace.go:171","msg":"trace[131805909] transaction","detail":"{read_only:false; response_revision:781; number_of_response:1; }","duration":"331.884542ms","start":"2026-05-14T07:29:20.234435Z","end":"2026-05-14T07:29:20.56632Z","steps":["trace[131805909] 'process raft request' (duration: 331.243908ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:20.566356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.028057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-14T07:29:20.566407Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:29:20.234419Z","time spent":"331.939554ms","remote":"127.0.0.1:56248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:29:20.566439Z","caller":"traceutil/trace.go:171","msg":"trace[1485317405] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:781; }","duration":"107.177561ms","start":"2026-05-14T07:29:20.459244Z","end":"2026-05-14T07:29:20.566422Z","steps":["trace[1485317405] 'agreement among raft nodes before linearized reading' (duration: 106.978986ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:29:56.125776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.596221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:29:56.125835Z","caller":"traceutil/trace.go:171","msg":"trace[883861183] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:998; }","duration":"299.690674ms","start":"2026-05-14T07:29:55.826132Z","end":"2026-05-14T07:29:56.125822Z","steps":["trace[883861183] 'range keys from in-memory index tree' (duration: 299.402757ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:00.934132Z","caller":"traceutil/trace.go:171","msg":"trace[1354587144] linearizableReadLoop","detail":"{readStateIndex:1051; appliedIndex:1050; }","duration":"105.350183ms","start":"2026-05-14T07:30:00.828756Z","end":"2026-05-14T07:30:00.934106Z","steps":["trace[1354587144] 'read index received' (duration: 16.342275ms)","trace[1354587144] 'applied index is now lower than readState.Index' (duration: 89.006908ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:00.934239Z","caller":"traceutil/trace.go:171","msg":"trace[1600972123] transaction","detail":"{read_only:false; response_revision:1013; number_of_response:1; }","duration":"133.979792ms","start":"2026-05-14T07:30:00.800223Z","end":"2026-05-14T07:30:00.934203Z","steps":["trace[1600972123] 'process raft request' (duration: 110.899087ms)","trace[1600972123] 'compare' (duration: 22.887791ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:00.934297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.518557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:00.934331Z","caller":"traceutil/trace.go:171","msg":"trace[13928995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1013; }","duration":"105.593059ms","start":"2026-05-14T07:30:00.828729Z","end":"2026-05-14T07:30:00.934322Z","steps":["trace[13928995] 'agreement among raft nodes before linearized reading' (duration: 105.518477ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:19.974665Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151051666645237,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-14T07:30:19.991416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"947.664089ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-14T07:30:19.991503Z","caller":"traceutil/trace.go:171","msg":"trace[718174080] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1072; }","duration":"947.812002ms","start":"2026-05-14T07:30:19.043671Z","end":"2026-05-14T07:30:19.991483Z","steps":["trace[718174080] 'count revisions from in-memory index tree' (duration: 947.588278ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:19.991519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"885.377677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-14T07:30:19.991516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.895149ms","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":"warn","ts":"2026-05-14T07:30:19.991568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.043653Z","time spent":"947.885354ms","remote":"127.0.0.1:56496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-05-14T07:30:19.991577Z","caller":"traceutil/trace.go:171","msg":"trace[1650503278] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1072; }","duration":"885.473939ms","start":"2026-05-14T07:30:19.106085Z","end":"2026-05-14T07:30:19.991559Z","steps":["trace[1650503278] 'range keys from in-memory index tree' (duration: 885.179213ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:19.991587Z","caller":"traceutil/trace.go:171","msg":"trace[1817224350] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:1072; }","duration":"749.016452ms","start":"2026-05-14T07:30:19.242557Z","end":"2026-05-14T07:30:19.991573Z","steps":["trace[1817224350] 'count revisions from in-memory index tree' (duration: 748.819968ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:19.991619Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.106055Z","time spent":"885.555091ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-14T07:30:19.991623Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.242538Z","time spent":"749.074883ms","remote":"127.0.0.1:56310","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":"warn","ts":"2026-05-14T07:30:19.991764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"669.301491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T07:30:19.991802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"965.657041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-14T07:30:19.99184Z","caller":"traceutil/trace.go:171","msg":"trace[939948782] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1072; }","duration":"669.421594ms","start":"2026-05-14T07:30:19.322399Z","end":"2026-05-14T07:30:19.991821Z","steps":["trace[939948782] 'count revisions from in-memory index tree' (duration: 669.206389ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:19.991888Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.322383Z","time spent":"669.495635ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":36,"response count":0,"response size":28,"request content":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true "} {"level":"info","ts":"2026-05-14T07:30:19.991895Z","caller":"traceutil/trace.go:171","msg":"trace[958225643] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1072; }","duration":"965.803084ms","start":"2026-05-14T07:30:19.026068Z","end":"2026-05-14T07:30:19.991871Z","steps":["trace[958225643] 'range keys from in-memory index tree' (duration: 965.458937ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:19.992031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.026044Z","time spent":"965.972717ms","remote":"127.0.0.1:56310","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-05-14T07:30:19.991937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.443193ms","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-05-14T07:30:19.99214Z","caller":"traceutil/trace.go:171","msg":"trace[2123794055] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1072; }","duration":"707.682939ms","start":"2026-05-14T07:30:19.284446Z","end":"2026-05-14T07:30:19.992129Z","steps":["trace[2123794055] 'count revisions from in-memory index tree' (duration: 707.401362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:19.99218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.284439Z","time spent":"707.725169ms","remote":"127.0.0.1:56608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":113,"response size":30,"request content":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true "} {"level":"info","ts":"2026-05-14T07:30:20.087825Z","caller":"traceutil/trace.go:171","msg":"trace[1105670662] linearizableReadLoop","detail":"{readStateIndex:1115; appliedIndex:1114; }","duration":"613.576866ms","start":"2026-05-14T07:30:19.474224Z","end":"2026-05-14T07:30:20.087801Z","steps":["trace[1105670662] 'read index received' (duration: 613.440063ms)","trace[1105670662] 'applied index is now lower than readState.Index' (duration: 135.713µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:20.087882Z","caller":"traceutil/trace.go:171","msg":"trace[772239237] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"670.510158ms","start":"2026-05-14T07:30:19.417347Z","end":"2026-05-14T07:30:20.087857Z","steps":["trace[772239237] 'process raft request' (duration: 670.319034ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:20.088017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.417323Z","time spent":"670.61457ms","remote":"127.0.0.1:56310","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-05-14T07:30:20.0881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.865233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T07:30:20.088157Z","caller":"traceutil/trace.go:171","msg":"trace[2102101709] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1073; }","duration":"613.972124ms","start":"2026-05-14T07:30:19.474174Z","end":"2026-05-14T07:30:20.088146Z","steps":["trace[2102101709] 'agreement among raft nodes before linearized reading' (duration: 613.736249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:20.088201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.474154Z","time spent":"614.038256ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-14T07:30:20.307931Z","caller":"traceutil/trace.go:171","msg":"trace[1053899579] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"311.956068ms","start":"2026-05-14T07:30:19.995951Z","end":"2026-05-14T07:30:20.307907Z","steps":["trace[1053899579] 'process raft request' (duration: 279.709347ms)","trace[1053899579] 'compare' (duration: 32.103848ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:20.308067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.995935Z","time spent":"312.063651ms","remote":"127.0.0.1:56310","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-05-14T07:30:20.308091Z","caller":"traceutil/trace.go:171","msg":"trace[2048773225] linearizableReadLoop","detail":"{readStateIndex:1117; appliedIndex:1115; }","duration":"220.184199ms","start":"2026-05-14T07:30:20.087889Z","end":"2026-05-14T07:30:20.308073Z","steps":["trace[2048773225] 'read index received' (duration: 187.785865ms)","trace[2048773225] 'applied index is now lower than readState.Index' (duration: 32.397114ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:20.309082Z","caller":"traceutil/trace.go:171","msg":"trace[2112132707] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"312.787467ms","start":"2026-05-14T07:30:19.996256Z","end":"2026-05-14T07:30:20.309044Z","steps":["trace[2112132707] 'process raft request' (duration: 311.618521ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:20.309227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"469.571068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T07:30:20.309234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.99624Z","time spent":"312.908309ms","remote":"127.0.0.1:56310","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-05-14T07:30:20.30928Z","caller":"traceutil/trace.go:171","msg":"trace[400324714] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1075; }","duration":"469.67751ms","start":"2026-05-14T07:30:19.839592Z","end":"2026-05-14T07:30:20.309269Z","steps":["trace[400324714] 'agreement among raft nodes before linearized reading' (duration: 469.576448ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:20.309313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:19.839572Z","time spent":"469.727252ms","remote":"127.0.0.1:56046","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-05-14T07:30:20.319836Z","caller":"traceutil/trace.go:171","msg":"trace[1592219132] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"226.801166ms","start":"2026-05-14T07:30:20.093021Z","end":"2026-05-14T07:30:20.319822Z","steps":["trace[1592219132] 'process raft request' (duration: 226.613752ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:21.684543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:21.365042Z","time spent":"319.497357ms","remote":"127.0.0.1:56096","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-14T07:30:21.94415Z","caller":"traceutil/trace.go:171","msg":"trace[1533759149] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"129.765509ms","start":"2026-05-14T07:30:21.814363Z","end":"2026-05-14T07:30:21.944129Z","steps":["trace[1533759149] 'read index received' (duration: 110.58033ms)","trace[1533759149] 'applied index is now lower than readState.Index' (duration: 19.184359ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:21.94424Z","caller":"traceutil/trace.go:171","msg":"trace[894137429] transaction","detail":"{read_only:false; response_revision:1079; number_of_response:1; }","duration":"258.430642ms","start":"2026-05-14T07:30:21.685801Z","end":"2026-05-14T07:30:21.944232Z","steps":["trace[894137429] 'process raft request' (duration: 239.09076ms)","trace[894137429] 'compare' (duration: 19.137387ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:21.944466Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.098596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:21.944498Z","caller":"traceutil/trace.go:171","msg":"trace[742779858] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1079; }","duration":"130.180727ms","start":"2026-05-14T07:30:21.81431Z","end":"2026-05-14T07:30:21.944491Z","steps":["trace[742779858] 'agreement among raft nodes before linearized reading' (duration: 130.077955ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:21.951132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.302434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:21.95121Z","caller":"traceutil/trace.go:171","msg":"trace[1471430235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1080; }","duration":"123.429477ms","start":"2026-05-14T07:30:21.827764Z","end":"2026-05-14T07:30:21.951193Z","steps":["trace[1471430235] 'agreement among raft nodes before linearized reading' (duration: 123.285984ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:22.292619Z","caller":"traceutil/trace.go:171","msg":"trace[1403855064] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"199.498416ms","start":"2026-05-14T07:30:22.093097Z","end":"2026-05-14T07:30:22.292595Z","steps":["trace[1403855064] 'process raft request' (duration: 198.669858ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:22.47624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.834724ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:30:22.476457Z","caller":"traceutil/trace.go:171","msg":"trace[988275596] linearizableReadLoop","detail":"{readStateIndex:1126; appliedIndex:1124; }","duration":"152.767093ms","start":"2026-05-14T07:30:22.323673Z","end":"2026-05-14T07:30:22.47644Z","steps":["trace[988275596] 'read index received' (duration: 46.644932ms)","trace[988275596] 'applied index is now lower than readState.Index' (duration: 106.121351ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:22.476547Z","caller":"traceutil/trace.go:171","msg":"trace[640299613] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"153.253694ms","start":"2026-05-14T07:30:22.323283Z","end":"2026-05-14T07:30:22.476537Z","steps":["trace[640299613] 'process raft request' (duration: 153.08172ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:22.47655Z","caller":"traceutil/trace.go:171","msg":"trace[1436130012] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"153.681183ms","start":"2026-05-14T07:30:22.322826Z","end":"2026-05-14T07:30:22.476507Z","steps":["trace[1436130012] 'process raft request' (duration: 47.485071ms)","trace[1436130012] 'compare' (duration: 105.685761ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:22.476746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.067709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T07:30:22.476784Z","caller":"traceutil/trace.go:171","msg":"trace[225766622] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1083; }","duration":"153.11961ms","start":"2026-05-14T07:30:22.323654Z","end":"2026-05-14T07:30:22.476774Z","steps":["trace[225766622] 'agreement among raft nodes before linearized reading' (duration: 153.003717ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:22.476792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.266573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-14T07:30:22.476847Z","caller":"traceutil/trace.go:171","msg":"trace[494848794] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1083; }","duration":"110.369534ms","start":"2026-05-14T07:30:22.366469Z","end":"2026-05-14T07:30:22.476839Z","steps":["trace[494848794] 'agreement among raft nodes before linearized reading' (duration: 110.235201ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:23.123611Z","caller":"traceutil/trace.go:171","msg":"trace[754402329] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"131.60198ms","start":"2026-05-14T07:30:22.99198Z","end":"2026-05-14T07:30:23.123582Z","steps":["trace[754402329] 'process raft request' (duration: 131.433096ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:23.335595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.727454ms","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-05-14T07:30:23.335728Z","caller":"traceutil/trace.go:171","msg":"trace[1089606927] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1086; }","duration":"116.002902ms","start":"2026-05-14T07:30:23.219687Z","end":"2026-05-14T07:30:23.33569Z","steps":["trace[1089606927] 'count revisions from in-memory index tree' (duration: 115.631663ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:24.506533Z","caller":"traceutil/trace.go:171","msg":"trace[1029909267] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"206.651325ms","start":"2026-05-14T07:30:24.299856Z","end":"2026-05-14T07:30:24.506508Z","steps":["trace[1029909267] 'process raft request' (duration: 206.465041ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:24.65757Z","caller":"traceutil/trace.go:171","msg":"trace[2084849275] transaction","detail":"{read_only:false; response_revision:1089; number_of_response:1; }","duration":"146.682896ms","start":"2026-05-14T07:30:24.510856Z","end":"2026-05-14T07:30:24.657539Z","steps":["trace[2084849275] 'process raft request' (duration: 95.742459ms)","trace[2084849275] 'compare' (duration: 50.712012ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:24.65764Z","caller":"traceutil/trace.go:171","msg":"trace[682291076] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"146.732317ms","start":"2026-05-14T07:30:24.510874Z","end":"2026-05-14T07:30:24.657607Z","steps":["trace[682291076] 'process raft request' (duration: 146.602354ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:24.65757Z","caller":"traceutil/trace.go:171","msg":"trace[1729075149] linearizableReadLoop","detail":"{readStateIndex:1133; appliedIndex:1131; }","duration":"100.258829ms","start":"2026-05-14T07:30:24.55727Z","end":"2026-05-14T07:30:24.657529Z","steps":["trace[1729075149] 'read index received' (duration: 49.278791ms)","trace[1729075149] 'applied index is now lower than readState.Index' (duration: 50.978948ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:24.658435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.155279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T07:30:24.658489Z","caller":"traceutil/trace.go:171","msg":"trace[1051846882] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1090; }","duration":"101.285632ms","start":"2026-05-14T07:30:24.557192Z","end":"2026-05-14T07:30:24.658477Z","steps":["trace[1051846882] 'agreement among raft nodes before linearized reading' (duration: 100.435752ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:37.038417Z","caller":"traceutil/trace.go:171","msg":"trace[188313074] linearizableReadLoop","detail":"{readStateIndex:1225; appliedIndex:1224; }","duration":"422.089298ms","start":"2026-05-14T07:30:36.616305Z","end":"2026-05-14T07:30:37.038394Z","steps":["trace[188313074] 'read index received' (duration: 422.042787ms)","trace[188313074] 'applied index is now lower than readState.Index' (duration: 45.391µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:37.038555Z","caller":"traceutil/trace.go:171","msg":"trace[1176595490] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"423.792946ms","start":"2026-05-14T07:30:36.614726Z","end":"2026-05-14T07:30:37.038519Z","steps":["trace[1176595490] 'process raft request' (duration: 423.378537ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:37.038674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.345385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-14T07:30:37.038716Z","caller":"traceutil/trace.go:171","msg":"trace[1652198694] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1178; }","duration":"422.438736ms","start":"2026-05-14T07:30:36.616268Z","end":"2026-05-14T07:30:37.038707Z","steps":["trace[1652198694] 'agreement among raft nodes before linearized reading' (duration: 422.233381ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:37.038776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.614705Z","time spent":"423.96482ms","remote":"127.0.0.1:56310","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-05-14T07:30:37.038798Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.616251Z","time spent":"422.538009ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-14T07:30:37.434792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.744944ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:37.4349Z","caller":"traceutil/trace.go:171","msg":"trace[1622031006] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1178; }","duration":"256.876277ms","start":"2026-05-14T07:30:37.178007Z","end":"2026-05-14T07:30:37.434884Z","steps":["trace[1622031006] 'range keys from in-memory index tree' (duration: 256.722114ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:37.437165Z","caller":"traceutil/trace.go:171","msg":"trace[1747812616] linearizableReadLoop","detail":"{readStateIndex:1226; appliedIndex:1225; }","duration":"398.638804ms","start":"2026-05-14T07:30:37.03848Z","end":"2026-05-14T07:30:37.437118Z","steps":["trace[1747812616] 'read index received' (duration: 394.655636ms)","trace[1747812616] 'applied index is now lower than readState.Index' (duration: 3.971738ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:37.437231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.141996ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-14T07:30:37.437272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.24798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T07:30:37.437312Z","caller":"traceutil/trace.go:171","msg":"trace[31049937] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1178; }","duration":"609.258158ms","start":"2026-05-14T07:30:36.828034Z","end":"2026-05-14T07:30:37.437292Z","steps":["trace[31049937] 'agreement among raft nodes before linearized reading' (duration: 609.121125ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:37.437341Z","caller":"traceutil/trace.go:171","msg":"trace[1078936183] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1178; }","duration":"661.350593ms","start":"2026-05-14T07:30:36.775977Z","end":"2026-05-14T07:30:37.437328Z","steps":["trace[1078936183] 'agreement among raft nodes before linearized reading' (duration: 661.144168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:37.43736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.828017Z","time spent":"609.33717ms","remote":"127.0.0.1:56046","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-05-14T07:30:37.437385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.775967Z","time spent":"661.411934ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-14T07:30:37.437442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.993297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T07:30:37.437293Z","caller":"traceutil/trace.go:171","msg":"trace[1182128569] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"394.661326ms","start":"2026-05-14T07:30:37.042573Z","end":"2026-05-14T07:30:37.437235Z","steps":["trace[1182128569] 'process raft request' (duration: 394.453021ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:37.437477Z","caller":"traceutil/trace.go:171","msg":"trace[1995524280] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1179; }","duration":"726.060428ms","start":"2026-05-14T07:30:36.711407Z","end":"2026-05-14T07:30:37.437467Z","steps":["trace[1995524280] 'agreement among raft nodes before linearized reading' (duration: 725.883744ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:37.437504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.711398Z","time spent":"726.100479ms","remote":"127.0.0.1:56310","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-05-14T07:30:37.437528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:37.042557Z","time spent":"394.921661ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-14T07:30:37.437604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"765.144181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-14T07:30:37.437622Z","caller":"traceutil/trace.go:171","msg":"trace[1583308787] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1179; }","duration":"765.190022ms","start":"2026-05-14T07:30:36.672425Z","end":"2026-05-14T07:30:37.437615Z","steps":["trace[1583308787] 'agreement among raft nodes before linearized reading' (duration: 765.152931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:37.437643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.672406Z","time spent":"765.232403ms","remote":"127.0.0.1:56518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-05-14T07:30:37.437722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"726.442036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-14T07:30:37.437749Z","caller":"traceutil/trace.go:171","msg":"trace[2113673235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1179; }","duration":"726.499419ms","start":"2026-05-14T07:30:36.71124Z","end":"2026-05-14T07:30:37.437739Z","steps":["trace[2113673235] 'agreement among raft nodes before linearized reading' (duration: 726.393706ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:37.437767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.71122Z","time spent":"726.543009ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-14T07:30:37.43788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"509.285686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-14T07:30:37.437906Z","caller":"traceutil/trace.go:171","msg":"trace[795101074] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1179; }","duration":"509.344587ms","start":"2026-05-14T07:30:36.928556Z","end":"2026-05-14T07:30:37.437901Z","steps":["trace[795101074] 'agreement among raft nodes before linearized reading' (duration: 509.293716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:37.437925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:36.928541Z","time spent":"509.377448ms","remote":"127.0.0.1:56158","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":11,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-05-14T07:30:53.243394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"406.289631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:53.243519Z","caller":"traceutil/trace.go:171","msg":"trace[1357803112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1238; }","duration":"406.779463ms","start":"2026-05-14T07:30:52.836706Z","end":"2026-05-14T07:30:53.243486Z","steps":["trace[1357803112] 'range keys from in-memory index tree' (duration: 406.20902ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:53.243574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:52.836688Z","time spent":"406.872175ms","remote":"127.0.0.1:56046","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-05-14T07:30:53.265525Z","caller":"traceutil/trace.go:171","msg":"trace[115230657] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"148.59103ms","start":"2026-05-14T07:30:53.116914Z","end":"2026-05-14T07:30:53.265505Z","steps":["trace[115230657] 'process raft request' (duration: 148.237512ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:53.633928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.078568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T07:30:53.633996Z","caller":"traceutil/trace.go:171","msg":"trace[344303710] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1239; }","duration":"124.201241ms","start":"2026-05-14T07:30:53.509778Z","end":"2026-05-14T07:30:53.633979Z","steps":["trace[344303710] 'range keys from in-memory index tree' (duration: 123.872114ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:53.634241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.082598ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-14T07:30:53.634319Z","caller":"traceutil/trace.go:171","msg":"trace[354302983] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1239; }","duration":"124.199911ms","start":"2026-05-14T07:30:53.5101Z","end":"2026-05-14T07:30:53.6343Z","steps":["trace[354302983] 'range keys from in-memory index tree' (duration: 123.948155ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:53.634376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.621818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-14T07:30:53.634442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.026099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-14T07:30:53.634477Z","caller":"traceutil/trace.go:171","msg":"trace[2067368337] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1239; }","duration":"129.089041ms","start":"2026-05-14T07:30:53.505375Z","end":"2026-05-14T07:30:53.634464Z","steps":["trace[2067368337] 'range keys from in-memory index tree' (duration: 128.897687ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:53.634488Z","caller":"traceutil/trace.go:171","msg":"trace[2097024722] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1239; }","duration":"107.772981ms","start":"2026-05-14T07:30:53.526687Z","end":"2026-05-14T07:30:53.63446Z","steps":["trace[2097024722] 'range keys from in-memory index tree' (duration: 107.415203ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:53.634672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.234605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T07:30:53.634694Z","caller":"traceutil/trace.go:171","msg":"trace[591263987] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1239; }","duration":"121.294016ms","start":"2026-05-14T07:30:53.513394Z","end":"2026-05-14T07:30:53.634688Z","steps":["trace[591263987] 'range keys from in-memory index tree' (duration: 121.161813ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:53.779443Z","caller":"traceutil/trace.go:171","msg":"trace[1154362852] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"140.756574ms","start":"2026-05-14T07:30:53.63867Z","end":"2026-05-14T07:30:53.779427Z","steps":["trace[1154362852] 'process raft request' (duration: 138.157725ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:53.779647Z","caller":"traceutil/trace.go:171","msg":"trace[479003660] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"139.862263ms","start":"2026-05-14T07:30:53.639774Z","end":"2026-05-14T07:30:53.779636Z","steps":["trace[479003660] 'process raft request' (duration: 139.823222ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:53.779735Z","caller":"traceutil/trace.go:171","msg":"trace[610301901] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"140.238762ms","start":"2026-05-14T07:30:53.639487Z","end":"2026-05-14T07:30:53.779725Z","steps":["trace[610301901] 'process raft request' (duration: 140.065108ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:53.779711Z","caller":"traceutil/trace.go:171","msg":"trace[886332422] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"140.884187ms","start":"2026-05-14T07:30:53.638763Z","end":"2026-05-14T07:30:53.779647Z","steps":["trace[886332422] 'process raft request' (duration: 140.630881ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:54.52184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.39871ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:30:54.521972Z","caller":"traceutil/trace.go:171","msg":"trace[853434963] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"223.80044ms","start":"2026-05-14T07:30:54.298149Z","end":"2026-05-14T07:30:54.521949Z","steps":["trace[853434963] 'process raft request' (duration: 69.197545ms)","trace[853434963] 'compare' (duration: 154.257817ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:55.660377Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"832.260336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:55.660454Z","caller":"traceutil/trace.go:171","msg":"trace[1069426494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1250; }","duration":"832.448409ms","start":"2026-05-14T07:30:54.827988Z","end":"2026-05-14T07:30:55.660437Z","steps":["trace[1069426494] 'range keys from in-memory index tree' (duration: 832.140452ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:55.660489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:54.827957Z","time spent":"832.524401ms","remote":"127.0.0.1:56046","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-05-14T07:30:56.141212Z","caller":"traceutil/trace.go:171","msg":"trace[1083510169] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1301; }","duration":"491.820475ms","start":"2026-05-14T07:30:55.64936Z","end":"2026-05-14T07:30:56.141181Z","steps":["trace[1083510169] 'read index received' (duration: 491.647791ms)","trace[1083510169] 'applied index is now lower than readState.Index' (duration: 168.384µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:56.14135Z","caller":"traceutil/trace.go:171","msg":"trace[1840077548] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"872.081591ms","start":"2026-05-14T07:30:55.269227Z","end":"2026-05-14T07:30:56.141309Z","steps":["trace[1840077548] 'process raft request' (duration: 871.778534ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.141494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.107051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-05-14T07:30:56.141525Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:55.269201Z","time spent":"872.225883ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:30:56.14155Z","caller":"traceutil/trace.go:171","msg":"trace[1834944725] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1251; }","duration":"492.218554ms","start":"2026-05-14T07:30:55.649314Z","end":"2026-05-14T07:30:56.141532Z","steps":["trace[1834944725] 'agreement among raft nodes before linearized reading' (duration: 491.989708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.141607Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:55.649293Z","time spent":"492.303395ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-14T07:30:56.152302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"489.678166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:56.152368Z","caller":"traceutil/trace.go:171","msg":"trace[1311935456] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1252; }","duration":"489.770008ms","start":"2026-05-14T07:30:55.662583Z","end":"2026-05-14T07:30:56.152353Z","steps":["trace[1311935456] 'agreement among raft nodes before linearized reading' (duration: 489.658505ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.152396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:55.662572Z","time spent":"489.817719ms","remote":"127.0.0.1:56032","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-05-14T07:30:56.152405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.536388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-14T07:30:56.152437Z","caller":"traceutil/trace.go:171","msg":"trace[988407902] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1252; }","duration":"366.585139ms","start":"2026-05-14T07:30:55.785842Z","end":"2026-05-14T07:30:56.152427Z","steps":["trace[988407902] 'agreement among raft nodes before linearized reading' (duration: 366.510708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.152457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:55.785832Z","time spent":"366.62042ms","remote":"127.0.0.1:56310","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-05-14T07:30:56.152573Z","caller":"traceutil/trace.go:171","msg":"trace[1620874444] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"274.872487ms","start":"2026-05-14T07:30:55.87769Z","end":"2026-05-14T07:30:56.152563Z","steps":["trace[1620874444] 'process raft request' (duration: 274.444028ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.15273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.961652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-14T07:30:56.152754Z","caller":"traceutil/trace.go:171","msg":"trace[1078640104] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1252; }","duration":"365.018114ms","start":"2026-05-14T07:30:55.787729Z","end":"2026-05-14T07:30:56.152748Z","steps":["trace[1078640104] 'agreement among raft nodes before linearized reading' (duration: 364.942282ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.152775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:55.787718Z","time spent":"365.051834ms","remote":"127.0.0.1:56310","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-05-14T07:30:56.152772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.4221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T07:30:56.152802Z","caller":"traceutil/trace.go:171","msg":"trace[685809676] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1252; }","duration":"368.485142ms","start":"2026-05-14T07:30:55.784309Z","end":"2026-05-14T07:30:56.152794Z","steps":["trace[685809676] 'agreement among raft nodes before linearized reading' (duration: 368.384099ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.152825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:55.784286Z","time spent":"368.534112ms","remote":"127.0.0.1:56310","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-05-14T07:30:56.152884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.636344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T07:30:56.152906Z","caller":"traceutil/trace.go:171","msg":"trace[1583803169] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1252; }","duration":"368.691286ms","start":"2026-05-14T07:30:55.784207Z","end":"2026-05-14T07:30:56.152898Z","steps":["trace[1583803169] 'agreement among raft nodes before linearized reading' (duration: 368.629225ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:56.152925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:55.784191Z","time spent":"368.729766ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-05-14T07:30:57.484337Z","caller":"traceutil/trace.go:171","msg":"trace[2131586711] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"234.581132ms","start":"2026-05-14T07:30:57.249738Z","end":"2026-05-14T07:30:57.484319Z","steps":["trace[2131586711] 'process raft request' (duration: 234.431059ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:58.0193Z","caller":"traceutil/trace.go:171","msg":"trace[551927677] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"363.076239ms","start":"2026-05-14T07:30:57.656197Z","end":"2026-05-14T07:30:58.019273Z","steps":["trace[551927677] 'process raft request' (duration: 362.869865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:58.019489Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:30:57.656169Z","time spent":"363.213143ms","remote":"127.0.0.1:56248","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11371,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-14T07:30:58.019687Z","caller":"traceutil/trace.go:171","msg":"trace[138279682] linearizableReadLoop","detail":"{readStateIndex:1312; appliedIndex:1312; }","duration":"191.483704ms","start":"2026-05-14T07:30:57.828192Z","end":"2026-05-14T07:30:58.019676Z","steps":["trace[138279682] 'read index received' (duration: 191.478794ms)","trace[138279682] 'applied index is now lower than readState.Index' (duration: 3.77µs)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:30:58.019866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.650877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:58.019947Z","caller":"traceutil/trace.go:171","msg":"trace[245319431] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1260; }","duration":"191.787521ms","start":"2026-05-14T07:30:57.828141Z","end":"2026-05-14T07:30:58.019928Z","steps":["trace[245319431] 'agreement among raft nodes before linearized reading' (duration: 191.645208ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:58.297322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.596336ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-14T07:30:58.297684Z","caller":"traceutil/trace.go:171","msg":"trace[258674302] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"149.970261ms","start":"2026-05-14T07:30:58.147695Z","end":"2026-05-14T07:30:58.297665Z","steps":["trace[258674302] 'process raft request' (duration: 149.91946ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:58.298294Z","caller":"traceutil/trace.go:171","msg":"trace[1052390223] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"269.275712ms","start":"2026-05-14T07:30:58.029001Z","end":"2026-05-14T07:30:58.298277Z","steps":["trace[1052390223] 'process raft request' (duration: 40.631963ms)","trace[1052390223] 'compare' (duration: 226.988872ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:58.298781Z","caller":"traceutil/trace.go:171","msg":"trace[1421743595] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1312; }","duration":"265.871196ms","start":"2026-05-14T07:30:58.032895Z","end":"2026-05-14T07:30:58.298766Z","steps":["trace[1421743595] 'read index received' (duration: 36.746676ms)","trace[1421743595] 'applied index is now lower than readState.Index' (duration: 229.12283ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:30:58.298867Z","caller":"traceutil/trace.go:171","msg":"trace[1252969660] transaction","detail":"{read_only:false; response_revision:1262; number_of_response:1; }","duration":"269.764833ms","start":"2026-05-14T07:30:58.029096Z","end":"2026-05-14T07:30:58.298861Z","steps":["trace[1252969660] 'process raft request' (duration: 268.335962ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:30:58.299305Z","caller":"traceutil/trace.go:171","msg":"trace[2054165294] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"265.090608ms","start":"2026-05-14T07:30:58.034207Z","end":"2026-05-14T07:30:58.299298Z","steps":["trace[2054165294] 'process raft request' (duration: 263.327459ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:30:58.299412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.50895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:30:58.299443Z","caller":"traceutil/trace.go:171","msg":"trace[1348417005] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1264; }","duration":"266.562711ms","start":"2026-05-14T07:30:58.032873Z","end":"2026-05-14T07:30:58.299435Z","steps":["trace[1348417005] 'agreement among raft nodes before linearized reading' (duration: 266.51618ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:08.842394Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151051666645813,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-14T07:31:09.314031Z","caller":"traceutil/trace.go:171","msg":"trace[1496451800] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"972.521738ms","start":"2026-05-14T07:31:08.341487Z","end":"2026-05-14T07:31:09.314009Z","steps":["trace[1496451800] 'read index received' (duration: 972.315063ms)","trace[1496451800] 'applied index is now lower than readState.Index' (duration: 204.385µs)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:31:09.314123Z","caller":"traceutil/trace.go:171","msg":"trace[1139776191] transaction","detail":"{read_only:false; response_revision:1344; number_of_response:1; }","duration":"981.229264ms","start":"2026-05-14T07:31:08.33287Z","end":"2026-05-14T07:31:09.3141Z","steps":["trace[1139776191] 'process raft request' (duration: 980.993299ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.332846Z","time spent":"981.308545ms","remote":"127.0.0.1:56310","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-05-14T07:31:09.314229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.744013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-05-14T07:31:09.314259Z","caller":"traceutil/trace.go:171","msg":"trace[2010914049] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1344; }","duration":"972.816624ms","start":"2026-05-14T07:31:08.341433Z","end":"2026-05-14T07:31:09.31425Z","steps":["trace[2010914049] 'agreement among raft nodes before linearized reading' (duration: 972.687971ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.341414Z","time spent":"972.868116ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-14T07:31:09.314385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"904.170361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:31:09.314401Z","caller":"traceutil/trace.go:171","msg":"trace[861218362] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1344; }","duration":"904.227713ms","start":"2026-05-14T07:31:08.410169Z","end":"2026-05-14T07:31:09.314396Z","steps":["trace[861218362] 'agreement among raft nodes before linearized reading' (duration: 904.199562ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.410145Z","time spent":"904.265674ms","remote":"127.0.0.1:56046","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-05-14T07:31:09.314395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.94147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-14T07:31:09.314464Z","caller":"traceutil/trace.go:171","msg":"trace[1400464848] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1344; }","duration":"962.042033ms","start":"2026-05-14T07:31:08.352406Z","end":"2026-05-14T07:31:09.314448Z","steps":["trace[1400464848] 'agreement among raft nodes before linearized reading' (duration: 961.874619ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.352392Z","time spent":"962.101354ms","remote":"127.0.0.1:56310","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-05-14T07:31:09.314542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.930585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:31:09.314561Z","caller":"traceutil/trace.go:171","msg":"trace[1933876654] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1344; }","duration":"377.966475ms","start":"2026-05-14T07:31:08.936588Z","end":"2026-05-14T07:31:09.314555Z","steps":["trace[1933876654] 'agreement among raft nodes before linearized reading' (duration: 377.938823ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.936574Z","time spent":"377.996055ms","remote":"127.0.0.1:58982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":112,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true "} {"level":"warn","ts":"2026-05-14T07:31:09.314681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.738162ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-05-14T07:31:09.314677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"961.766348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-05-14T07:31:09.314699Z","caller":"traceutil/trace.go:171","msg":"trace[459390076] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1344; }","duration":"551.783062ms","start":"2026-05-14T07:31:08.762909Z","end":"2026-05-14T07:31:09.314692Z","steps":["trace[459390076] 'agreement among raft nodes before linearized reading' (duration: 551.754091ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:31:09.314706Z","caller":"traceutil/trace.go:171","msg":"trace[347578797] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1344; }","duration":"961.801558ms","start":"2026-05-14T07:31:08.352896Z","end":"2026-05-14T07:31:09.314697Z","steps":["trace[347578797] 'agreement among raft nodes before linearized reading' (duration: 961.689626ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.352873Z","time spent":"961.856989ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-14T07:31:09.314741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.022593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-14T07:31:09.314785Z","caller":"traceutil/trace.go:171","msg":"trace[415790306] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1344; }","duration":"962.083865ms","start":"2026-05-14T07:31:08.352689Z","end":"2026-05-14T07:31:09.314773Z","steps":["trace[415790306] 'agreement among raft nodes before linearized reading' (duration: 961.970442ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.762894Z","time spent":"551.815392ms","remote":"127.0.0.1:40050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":1,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true "} {"level":"warn","ts":"2026-05-14T07:31:09.314825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.352685Z","time spent":"962.133886ms","remote":"127.0.0.1:56310","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-14T07:31:09.314886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"962.317219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-14T07:31:09.314931Z","caller":"traceutil/trace.go:171","msg":"trace[710614171] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1344; }","duration":"962.372401ms","start":"2026-05-14T07:31:08.352549Z","end":"2026-05-14T07:31:09.314921Z","steps":["trace[710614171] 'agreement among raft nodes before linearized reading' (duration: 962.270469ms)"],"step_count":1} {"level":"warn","ts":"2026-05-14T07:31:09.314973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-14T07:31:08.352543Z","time spent":"962.422822ms","remote":"127.0.0.1:56310","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-05-14T07:32:41.937699Z","caller":"traceutil/trace.go:171","msg":"trace[376437612] linearizableReadLoop","detail":"{readStateIndex:1843; appliedIndex:1841; }","duration":"104.183912ms","start":"2026-05-14T07:32:41.83349Z","end":"2026-05-14T07:32:41.937674Z","steps":["trace[376437612] 'read index received' (duration: 46.981626ms)","trace[376437612] 'applied index is now lower than readState.Index' (duration: 57.201296ms)"],"step_count":2} {"level":"info","ts":"2026-05-14T07:32:41.937828Z","caller":"traceutil/trace.go:171","msg":"trace[1227112373] transaction","detail":"{read_only:false; response_revision:1770; number_of_response:1; }","duration":"116.930488ms","start":"2026-05-14T07:32:41.820853Z","end":"2026-05-14T07:32:41.937784Z","steps":["trace[1227112373] 'process raft request' (duration: 91.422855ms)","trace[1227112373] 'compare' (duration: 25.324059ms)"],"step_count":2} {"level":"warn","ts":"2026-05-14T07:32:41.937926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.383886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-14T07:32:41.937994Z","caller":"traceutil/trace.go:171","msg":"trace[1552461679] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1770; }","duration":"104.523779ms","start":"2026-05-14T07:32:41.833454Z","end":"2026-05-14T07:32:41.937977Z","steps":["trace[1552461679] 'agreement among raft nodes before linearized reading' (duration: 104.351276ms)"],"step_count":1} {"level":"info","ts":"2026-05-14T07:34:19.904362Z","caller":"traceutil/trace.go:171","msg":"trace[1253887401] transaction","detail":"{read_only:false; response_revision:2248; number_of_response:1; }","duration":"171.240815ms","start":"2026-05-14T07:34:19.733074Z","end":"2026-05-14T07:34:19.904315Z","steps":["trace[1253887401] 'process raft request' (duration: 170.960248ms)"],"step_count":1}