{"level":"warn","ts":"2026-07-09T13:10:26.902482Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T13:10:26.902593Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.30:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.30:2380","--initial-cluster=instance=https://199.19.213.30:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.30:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.30: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-07-09T13:10:26.902682Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-09T13:10:26.902693Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.30:2380"]} {"level":"info","ts":"2026-07-09T13:10:26.902712Z","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-07-09T13:10:26.903342Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"]} {"level":"info","ts":"2026-07-09T13:10:26.903417Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.30: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-07-09T13:10:26.908714Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.038341ms"} {"level":"info","ts":"2026-07-09T13:10:26.91746Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"e2b5783e11defe7e","cluster-id":"5210a9231a779bf0"} {"level":"info","ts":"2026-07-09T13:10:26.917566Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=()"} {"level":"info","ts":"2026-07-09T13:10:26.917594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 0"} {"level":"info","ts":"2026-07-09T13:10:26.917615Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft e2b5783e11defe7e [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-09T13:10:26.917635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became follower at term 1"} {"level":"info","ts":"2026-07-09T13:10:26.917732Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"} {"level":"warn","ts":"2026-07-09T13:10:26.924484Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-09T13:10:26.926299Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-09T13:10:26.928938Z","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-07-09T13:10:26.930909Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"e2b5783e11defe7e","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-09T13:10:26.932294Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"e2b5783e11defe7e","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-09T13:10:26.933425Z","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-07-09T13:10:26.933615Z","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-07-09T13:10:26.933653Z","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-07-09T13:10:26.935215Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e switched to configuration voters=(16336095431339474558)"} {"level":"info","ts":"2026-07-09T13:10:26.935478Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","added-peer-id":"e2b5783e11defe7e","added-peer-peer-urls":["https://199.19.213.30:2380"]} {"level":"info","ts":"2026-07-09T13:10:26.936401Z","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-07-09T13:10:26.936669Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"e2b5783e11defe7e","initial-advertise-peer-urls":["https://199.19.213.30:2380"],"listen-peer-urls":["https://199.19.213.30:2380"],"advertise-client-urls":["https://199.19.213.30:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.30:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-09T13:10:26.936704Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-09T13:10:26.936822Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.30:2380"} {"level":"info","ts":"2026-07-09T13:10:26.936844Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.30:2380"} {"level":"info","ts":"2026-07-09T13:10:27.91864Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e is starting a new election at term 1"} {"level":"info","ts":"2026-07-09T13:10:27.918735Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became pre-candidate at term 1"} {"level":"info","ts":"2026-07-09T13:10:27.918759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgPreVoteResp from e2b5783e11defe7e at term 1"} {"level":"info","ts":"2026-07-09T13:10:27.918778Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became candidate at term 2"} {"level":"info","ts":"2026-07-09T13:10:27.918791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e received MsgVoteResp from e2b5783e11defe7e at term 2"} {"level":"info","ts":"2026-07-09T13:10:27.918806Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"e2b5783e11defe7e became leader at term 2"} {"level":"info","ts":"2026-07-09T13:10:27.918821Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: e2b5783e11defe7e elected leader e2b5783e11defe7e at term 2"} {"level":"info","ts":"2026-07-09T13:10:27.920061Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T13:10:27.921205Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T13:10:27.921193Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"e2b5783e11defe7e","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.30:2379]}","request-path":"/0/members/e2b5783e11defe7e/attributes","cluster-id":"5210a9231a779bf0","publish-timeout":"7s"} {"level":"info","ts":"2026-07-09T13:10:27.921235Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-09T13:10:27.92176Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5210a9231a779bf0","local-member-id":"e2b5783e11defe7e","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T13:10:27.921903Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T13:10:27.921939Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-09T13:10:27.921955Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-09T13:10:27.922032Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-09T13:10:27.924228Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.30:2379"} {"level":"info","ts":"2026-07-09T13:10:27.92524Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-09T13:11:18.530894Z","caller":"traceutil/trace.go:171","msg":"trace[1557459700] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"118.596701ms","start":"2026-07-09T13:11:18.412245Z","end":"2026-07-09T13:11:18.530841Z","steps":["trace[1557459700] 'process raft request' (duration: 117.891793ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:11:18.702078Z","caller":"traceutil/trace.go:171","msg":"trace[1227275898] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"143.992931ms","start":"2026-07-09T13:11:18.558017Z","end":"2026-07-09T13:11:18.70201Z","steps":["trace[1227275898] 'process raft request' (duration: 143.803489ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:11:18.939941Z","caller":"traceutil/trace.go:171","msg":"trace[1981887253] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"237.948602ms","start":"2026-07-09T13:11:18.701963Z","end":"2026-07-09T13:11:18.939911Z","steps":["trace[1981887253] 'read index received' (duration: 229.655466ms)","trace[1981887253] 'applied index is now lower than readState.Index' (duration: 8.291746ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T13:11:18.940099Z","caller":"traceutil/trace.go:171","msg":"trace[673002717] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"341.045463ms","start":"2026-07-09T13:11:18.599029Z","end":"2026-07-09T13:11:18.940074Z","steps":["trace[673002717] 'process raft request' (duration: 332.670775ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:11:18.940106Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.118605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:11:18.940184Z","caller":"traceutil/trace.go:171","msg":"trace[777139596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"238.257686ms","start":"2026-07-09T13:11:18.701913Z","end":"2026-07-09T13:11:18.940171Z","steps":["trace[777139596] 'agreement among raft nodes before linearized reading' (duration: 238.106074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:11:18.940709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:11:18.599002Z","time spent":"341.161954ms","remote":"127.0.0.1:53692","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-09T13:11:20.710799Z","caller":"traceutil/trace.go:171","msg":"trace[1855498198] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"104.153762ms","start":"2026-07-09T13:11:20.606614Z","end":"2026-07-09T13:11:20.710768Z","steps":["trace[1855498198] 'process raft request' (duration: 15.428602ms)","trace[1855498198] 'compare' (duration: 88.466777ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T13:11:34.075536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.889445ms","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-07-09T13:11:34.075635Z","caller":"traceutil/trace.go:171","msg":"trace[315797905] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:812; }","duration":"245.055969ms","start":"2026-07-09T13:11:33.83056Z","end":"2026-07-09T13:11:34.075616Z","steps":["trace[315797905] 'count revisions from in-memory index tree' (duration: 244.681023ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:04.065235Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:04.565753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:05.066593Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:05.566816Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:05.702366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000483503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-09T13:13:05.70248Z","caller":"traceutil/trace.go:171","msg":"trace[1376845453] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000673839s","start":"2026-07-09T13:13:03.701777Z","end":"2026-07-09T13:13:05.702451Z","steps":["trace[1376845453] 'agreement among raft nodes before linearized reading' (duration: 2.000530215s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:05.70254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:03.701751Z","time spent":"2.000777033s","remote":"127.0.0.1:53250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/09 13:13:05 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T13:13:06.068008Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:06.568624Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:07.069708Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:07.516958Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"4.208182353s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T13:13:07.51762Z","caller":"traceutil/trace.go:171","msg":"trace[1939188870] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"4.208961738s","start":"2026-07-09T13:13:03.308613Z","end":"2026-07-09T13:13:07.517575Z","steps":["trace[1939188870] 'process raft request' (duration: 4.208739012s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.518168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:03.308578Z","time spent":"4.209108653s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T13:13:07.524166Z","caller":"traceutil/trace.go:171","msg":"trace[1804016764] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"3.44792031s","start":"2026-07-09T13:13:04.07621Z","end":"2026-07-09T13:13:07.52413Z","steps":["trace[1804016764] 'process raft request' (duration: 3.447678753s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.52436Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:04.076178Z","time spent":"3.448079845s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T13:13:07.524431Z","caller":"traceutil/trace.go:171","msg":"trace[155415403] transaction","detail":"{read_only:false; response_revision:1245; number_of_response:1; }","duration":"1.135756336s","start":"2026-07-09T13:13:06.388637Z","end":"2026-07-09T13:13:07.524393Z","steps":["trace[155415403] 'process raft request' (duration: 1.135458557s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.524674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:06.38861Z","time spent":"1.135895451s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T13:13:07.536537Z","caller":"traceutil/trace.go:171","msg":"trace[2007333006] linearizableReadLoop","detail":"{readStateIndex:1297; appliedIndex:1293; }","duration":"3.971818347s","start":"2026-07-09T13:13:03.564681Z","end":"2026-07-09T13:13:07.536499Z","steps":["trace[2007333006] 'read index received' (duration: 3.952578093s)","trace[2007333006] 'applied index is now lower than readState.Index' (duration: 19.238234ms)"],"step_count":2} {"level":"warn","ts":"2026-07-09T13:13:07.536849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.642047677s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:07.53689Z","caller":"traceutil/trace.go:171","msg":"trace[437821652] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1245; }","duration":"1.642205362s","start":"2026-07-09T13:13:05.894674Z","end":"2026-07-09T13:13:07.53688Z","steps":["trace[437821652] 'agreement among raft nodes before linearized reading' (duration: 1.642066777s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.536947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:05.894651Z","time spent":"1.642285905s","remote":"127.0.0.1:53654","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:07.536977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.026055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:07.537064Z","caller":"traceutil/trace.go:171","msg":"trace[299791393] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1245; }","duration":"537.229411ms","start":"2026-07-09T13:13:06.999807Z","end":"2026-07-09T13:13:07.537037Z","steps":["trace[299791393] 'agreement among raft nodes before linearized reading' (duration: 537.048415ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.537134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:06.999781Z","time spent":"537.342885ms","remote":"127.0.0.1:53504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:07.53713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.653969769s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T13:13:07.537201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.091978903s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:07.537353Z","caller":"traceutil/trace.go:171","msg":"trace[838590377] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1245; }","duration":"3.654211687s","start":"2026-07-09T13:13:03.883028Z","end":"2026-07-09T13:13:07.537239Z","steps":["trace[838590377] 'agreement among raft nodes before linearized reading' (duration: 3.653844564s)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:13:07.537358Z","caller":"traceutil/trace.go:171","msg":"trace[555393861] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"1.092180178s","start":"2026-07-09T13:13:06.44515Z","end":"2026-07-09T13:13:07.53733Z","steps":["trace[555393861] 'agreement among raft nodes before linearized reading' (duration: 1.091812687s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.537494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:03.882999Z","time spent":"3.654404022s","remote":"127.0.0.1:48940","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:07.537535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.834847514s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:07.537563Z","caller":"traceutil/trace.go:171","msg":"trace[1078044276] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1245; }","duration":"1.834915216s","start":"2026-07-09T13:13:05.70264Z","end":"2026-07-09T13:13:07.537555Z","steps":["trace[1078044276] 'agreement among raft nodes before linearized reading' (duration: 1.834866505s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.537584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:05.702622Z","time spent":"1.834956897s","remote":"127.0.0.1:53238","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-07-09T13:13:07.537495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:06.445123Z","time spent":"1.092355644s","remote":"127.0.0.1:53250","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-07-09T13:13:07.537691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.661906804s","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-07-09T13:13:07.537727Z","caller":"traceutil/trace.go:171","msg":"trace[2048798994] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1245; }","duration":"2.662010697s","start":"2026-07-09T13:13:04.875708Z","end":"2026-07-09T13:13:07.537719Z","steps":["trace[2048798994] 'agreement among raft nodes before linearized reading' (duration: 2.661810551s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.53777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:04.875667Z","time spent":"2.662095789s","remote":"127.0.0.1:53486","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-07-09T13:13:07.537795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.210882452s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"warn","ts":"2026-07-09T13:13:07.537855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.889077653s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T13:13:07.537888Z","caller":"traceutil/trace.go:171","msg":"trace[434799021] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1245; }","duration":"2.889140195s","start":"2026-07-09T13:13:04.648739Z","end":"2026-07-09T13:13:07.53788Z","steps":["trace[434799021] 'agreement among raft nodes before linearized reading' (duration: 2.889017451s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.537913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:04.648718Z","time spent":"2.889191127s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-09T13:13:07.537938Z","caller":"traceutil/trace.go:171","msg":"trace[97309231] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1245; }","duration":"1.211249453s","start":"2026-07-09T13:13:06.326603Z","end":"2026-07-09T13:13:07.537852Z","steps":["trace[97309231] 'agreement among raft nodes before linearized reading' (duration: 1.210394607s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.538027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.889239178s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T13:13:07.538055Z","caller":"traceutil/trace.go:171","msg":"trace[514880563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1245; }","duration":"2.88931244s","start":"2026-07-09T13:13:04.648737Z","end":"2026-07-09T13:13:07.53805Z","steps":["trace[514880563] 'agreement among raft nodes before linearized reading' (duration: 2.889242808s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.538074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:04.648705Z","time spent":"2.889365172s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T13:13:07.538102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.902929683s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:07.538154Z","caller":"traceutil/trace.go:171","msg":"trace[1239108577] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:1245; }","duration":"2.903025136s","start":"2026-07-09T13:13:04.635115Z","end":"2026-07-09T13:13:07.53814Z","steps":["trace[1239108577] 'agreement among raft nodes before linearized reading' (duration: 2.902938543s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.538208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:04.635083Z","time spent":"2.903103578s","remote":"127.0.0.1:48924","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:07.538266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"996.283382ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:07.538335Z","caller":"traceutil/trace.go:171","msg":"trace[839004240] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1245; }","duration":"997.727567ms","start":"2026-07-09T13:13:06.540596Z","end":"2026-07-09T13:13:07.538323Z","steps":["trace[839004240] 'agreement among raft nodes before linearized reading' (duration: 996.23835ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.538373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:06.540554Z","time spent":"997.805779ms","remote":"127.0.0.1:49018","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:07.536797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.972066874s","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":"info","ts":"2026-07-09T13:13:07.53852Z","caller":"traceutil/trace.go:171","msg":"trace[1511351337] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:1245; }","duration":"3.97387967s","start":"2026-07-09T13:13:03.56463Z","end":"2026-07-09T13:13:07.53851Z","steps":["trace[1511351337] 'agreement among raft nodes before linearized reading' (duration: 3.972028823s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.538564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:03.564606Z","time spent":"3.973948913s","remote":"127.0.0.1:53472","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":"warn","ts":"2026-07-09T13:13:07.538054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:06.326503Z","time spent":"1.21148211s","remote":"127.0.0.1:53340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329975,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-07-09T13:13:07.539565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.78472986s","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-07-09T13:13:07.539628Z","caller":"traceutil/trace.go:171","msg":"trace[14227998] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1245; }","duration":"2.784835944s","start":"2026-07-09T13:13:04.754777Z","end":"2026-07-09T13:13:07.539613Z","steps":["trace[14227998] 'agreement among raft nodes before linearized reading' (duration: 2.782008617s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:07.539747Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:04.754752Z","time spent":"2.784961618s","remote":"127.0.0.1:53486","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-07-09T13:13:10.091693Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021270,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:10.59281Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021270,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:10.592818Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.06548234s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T13:13:10.593247Z","caller":"traceutil/trace.go:171","msg":"trace[870292224] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"1.065997806s","start":"2026-07-09T13:13:09.527223Z","end":"2026-07-09T13:13:10.593221Z","steps":["trace[870292224] 'process raft request' (duration: 1.065835611s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:10.593392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.527205Z","time spent":"1.06609113s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T13:13:10.596919Z","caller":"traceutil/trace.go:171","msg":"trace[1659541771] linearizableReadLoop","detail":"{readStateIndex:1305; appliedIndex:1303; }","duration":"1.005667591s","start":"2026-07-09T13:13:09.591218Z","end":"2026-07-09T13:13:10.596886Z","steps":["trace[1659541771] 'read index received' (duration: 1.001918576s)","trace[1659541771] 'applied index is now lower than readState.Index' (duration: 3.747555ms)"],"step_count":2} {"level":"info","ts":"2026-07-09T13:13:10.597031Z","caller":"traceutil/trace.go:171","msg":"trace[1359066302] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"1.068561855s","start":"2026-07-09T13:13:09.528434Z","end":"2026-07-09T13:13:10.596996Z","steps":["trace[1359066302] 'process raft request' (duration: 1.068230815s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:10.59723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005901779s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-07-09T13:13:10.597235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.528421Z","time spent":"1.068695729s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T13:13:10.597284Z","caller":"traceutil/trace.go:171","msg":"trace[1871376987] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1252; }","duration":"1.005995322s","start":"2026-07-09T13:13:09.591271Z","end":"2026-07-09T13:13:10.597266Z","steps":["trace[1871376987] 'agreement among raft nodes before linearized reading' (duration: 1.005769855s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:10.597281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006022342s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-09T13:13:10.597379Z","caller":"traceutil/trace.go:171","msg":"trace[1161088479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1252; }","duration":"1.006191878s","start":"2026-07-09T13:13:09.591165Z","end":"2026-07-09T13:13:10.597356Z","steps":["trace[1161088479] 'agreement among raft nodes before linearized reading' (duration: 1.005855357s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:10.597439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"983.848101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" ","response":"range_response_count:4 size:329952"} {"level":"warn","ts":"2026-07-09T13:13:10.597456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.591139Z","time spent":"1.006306891s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T13:13:10.597464Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.005728414s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-07-09T13:13:10.597328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.591266Z","time spent":"1.006051744s","remote":"127.0.0.1:53486","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":"info","ts":"2026-07-09T13:13:10.597494Z","caller":"traceutil/trace.go:171","msg":"trace[1247391012] range","detail":"{range_begin:/registry/secrets/kube-system/; range_end:/registry/secrets/kube-system0; response_count:4; response_revision:1252; }","duration":"983.930903ms","start":"2026-07-09T13:13:09.613545Z","end":"2026-07-09T13:13:10.597476Z","steps":["trace[1247391012] 'agreement among raft nodes before linearized reading' (duration: 983.634534ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:13:10.59752Z","caller":"traceutil/trace.go:171","msg":"trace[2122904166] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1252; }","duration":"1.005801915s","start":"2026-07-09T13:13:09.591704Z","end":"2026-07-09T13:13:10.597506Z","steps":["trace[2122904166] 'agreement among raft nodes before linearized reading' (duration: 1.005650361s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:10.597544Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.613531Z","time spent":"984.001475ms","remote":"127.0.0.1:53340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":4,"response size":329975,"request content":"key:\"/registry/secrets/kube-system/\" range_end:\"/registry/secrets/kube-system0\" "} {"level":"warn","ts":"2026-07-09T13:13:10.597559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.591696Z","time spent":"1.005854428s","remote":"127.0.0.1:53486","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-07-09T13:13:10.597471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.722932ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:10.597632Z","caller":"traceutil/trace.go:171","msg":"trace[160061130] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1252; }","duration":"894.935598ms","start":"2026-07-09T13:13:09.702675Z","end":"2026-07-09T13:13:10.597611Z","steps":["trace[160061130] 'agreement among raft nodes before linearized reading' (duration: 894.742573ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:10.597621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.006272419s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-07-09T13:13:10.597708Z","caller":"traceutil/trace.go:171","msg":"trace[1018380028] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1252; }","duration":"1.006389074s","start":"2026-07-09T13:13:09.591297Z","end":"2026-07-09T13:13:10.597686Z","steps":["trace[1018380028] 'agreement among raft nodes before linearized reading' (duration: 1.006111455s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:10.597718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.702623Z","time spent":"895.079853ms","remote":"127.0.0.1:53250","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-07-09T13:13:10.597768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:09.591292Z","time spent":"1.006463876s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-07-09T13:13:11.034659Z","caller":"traceutil/trace.go:171","msg":"trace[1968534131] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"431.324563ms","start":"2026-07-09T13:13:10.603294Z","end":"2026-07-09T13:13:11.034618Z","steps":["trace[1968534131] 'process raft request' (duration: 422.324358ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:13:11.03475Z","caller":"traceutil/trace.go:171","msg":"trace[1309515927] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"430.94621ms","start":"2026-07-09T13:13:10.603794Z","end":"2026-07-09T13:13:11.03474Z","steps":["trace[1309515927] 'process raft request' (duration: 430.788896ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:11.034877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:10.603284Z","time spent":"431.474247ms","remote":"127.0.0.1:53486","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-07-09T13:13:11.03465Z","caller":"traceutil/trace.go:171","msg":"trace[1845439813] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"431.195319ms","start":"2026-07-09T13:13:10.603422Z","end":"2026-07-09T13:13:11.034617Z","steps":["trace[1845439813] 'process raft request' (duration: 431.085285ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:11.034929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:10.60378Z","time spent":"431.009823ms","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T13:13:11.035323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:10.603411Z","time spent":"431.594991ms","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T13:13:43.287779Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:43.788926Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:44.289282Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:44.790145Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:45.290699Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":18338269859995021660,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-09T13:13:45.701988Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000669658s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-09T13:13:45.702077Z","caller":"traceutil/trace.go:171","msg":"trace[1287266318] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000829122s","start":"2026-07-09T13:13:43.701231Z","end":"2026-07-09T13:13:45.70206Z","steps":["trace[1287266318] 'agreement among raft nodes before linearized reading' (duration: 2.000714019s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:45.702121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:43.701203Z","time spent":"2.000907785s","remote":"127.0.0.1:53250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/09 13:13:45 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T13:13:45.720413Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.665237174s","expected-duration":"1s"} {"level":"info","ts":"2026-07-09T13:13:45.720905Z","caller":"traceutil/trace.go:171","msg":"trace[35986516] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"3.665837101s","start":"2026-07-09T13:13:42.055045Z","end":"2026-07-09T13:13:45.720882Z","steps":["trace[35986516] 'process raft request' (duration: 3.665658106s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:45.721048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:42.055032Z","time spent":"3.665946024s","remote":"127.0.0.1:53426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2750,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-09T13:13:47.702434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000293881s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-09T13:13:47.702544Z","caller":"traceutil/trace.go:171","msg":"trace[2077584394] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000466586s","start":"2026-07-09T13:13:45.702052Z","end":"2026-07-09T13:13:47.702519Z","steps":["trace[2077584394] 'agreement among raft nodes before linearized reading' (duration: 2.000316142s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:47.702602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:45.702038Z","time spent":"2.000553228s","remote":"127.0.0.1:53238","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/09 13:13:47 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T13:13:47.77283Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:42.775665Z","time spent":"4.997155897s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":0,"request content":""} {"level":"warn","ts":"2026-07-09T13:13:47.785166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.998460703s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-09T13:13:47.78529Z","caller":"traceutil/trace.go:171","msg":"trace[1235410744] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; }","duration":"4.998656478s","start":"2026-07-09T13:13:42.786605Z","end":"2026-07-09T13:13:47.785262Z","steps":["trace[1235410744] 'agreement among raft nodes before linearized reading' (duration: 4.998485894s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:47.785351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:42.786593Z","time spent":"4.99874528s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} 2026/07/09 13:13:47 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T13:13:47.809929Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999463113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-07-09T13:13:47.810048Z","caller":"traceutil/trace.go:171","msg":"trace[838122619] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; }","duration":"4.999670819s","start":"2026-07-09T13:13:42.810351Z","end":"2026-07-09T13:13:47.810022Z","steps":["trace[838122619] 'agreement among raft nodes before linearized reading' (duration: 4.999505245s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:47.810114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:42.810307Z","time spent":"4.999793473s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} 2026/07/09 13:13:47 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T13:13:48.223706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.999652526s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-09T13:13:48.223824Z","caller":"traceutil/trace.go:171","msg":"trace[1513374479] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; }","duration":"4.999826051s","start":"2026-07-09T13:13:43.223972Z","end":"2026-07-09T13:13:48.223799Z","steps":["trace[1513374479] 'agreement among raft nodes before linearized reading' (duration: 4.999670077s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.223882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:43.223959Z","time spent":"4.999911623s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":0,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} 2026/07/09 13:13:48 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T13:13:48.448633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999938604s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-07-09T13:13:48.448755Z","caller":"traceutil/trace.go:171","msg":"trace[2080343764] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000125389s","start":"2026-07-09T13:13:46.448604Z","end":"2026-07-09T13:13:48.448729Z","steps":["trace[2080343764] 'agreement among raft nodes before linearized reading' (duration: 1.999962294s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.448815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:46.448586Z","time spent":"2.000218071s","remote":"127.0.0.1:53250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/07/09 13:13:48 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-07-09T13:13:48.507601Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.786894391s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-09T13:13:48.515526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.755768955s","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-07-09T13:13:48.515673Z","caller":"traceutil/trace.go:171","msg":"trace[1309663886] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1397; }","duration":"1.755942281s","start":"2026-07-09T13:13:46.759709Z","end":"2026-07-09T13:13:48.515652Z","steps":["trace[1309663886] 'range keys from in-memory index tree' (duration: 1.755747074s)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:13:48.5169Z","caller":"traceutil/trace.go:171","msg":"trace[219874665] linearizableReadLoop","detail":"{readStateIndex:1460; appliedIndex:1457; }","duration":"5.730223099s","start":"2026-07-09T13:13:42.786642Z","end":"2026-07-09T13:13:48.516865Z","steps":["trace[219874665] 'read index received' (duration: 2.934088488s)","trace[219874665] 'applied index is now lower than readState.Index' (duration: 2.796133221s)"],"step_count":2} {"level":"info","ts":"2026-07-09T13:13:48.517216Z","caller":"traceutil/trace.go:171","msg":"trace[2033069653] transaction","detail":"{read_only:false; response_revision:1399; number_of_response:1; }","duration":"4.970316843s","start":"2026-07-09T13:13:43.546841Z","end":"2026-07-09T13:13:48.517158Z","steps":["trace[2033069653] 'process raft request' (duration: 4.969918471s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.517404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:43.546806Z","time spent":"4.970495358s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-09T13:13:48.531608Z","caller":"traceutil/trace.go:171","msg":"trace[821656975] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1400; }","duration":"2.807839071s","start":"2026-07-09T13:13:45.72374Z","end":"2026-07-09T13:13:48.531579Z","steps":["trace[821656975] 'process raft request' (duration: 2.807605635s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.53186Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:45.723712Z","time spent":"2.807972665s","remote":"127.0.0.1:53426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":39,"response count":0,"response size":41,"request content":"compare: success: > failure: >"} {"level":"warn","ts":"2026-07-09T13:13:48.601998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.457384738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:48.602115Z","caller":"traceutil/trace.go:171","msg":"trace[176868383] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1400; }","duration":"5.457577114s","start":"2026-07-09T13:13:43.14451Z","end":"2026-07-09T13:13:48.602087Z","steps":["trace[176868383] 'agreement among raft nodes before linearized reading' (duration: 5.457388219s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.602169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:43.144478Z","time spent":"5.457678057s","remote":"127.0.0.1:48932","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:48.60217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.46628015s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T13:13:48.602155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.402892543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:48.60225Z","caller":"traceutil/trace.go:171","msg":"trace[1184784322] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1400; }","duration":"4.466451004s","start":"2026-07-09T13:13:44.135778Z","end":"2026-07-09T13:13:48.602229Z","steps":["trace[1184784322] 'agreement among raft nodes before linearized reading' (duration: 4.466258179s)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:13:48.602266Z","caller":"traceutil/trace.go:171","msg":"trace[1691892353] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:1400; }","duration":"3.403050497s","start":"2026-07-09T13:13:45.199193Z","end":"2026-07-09T13:13:48.602244Z","steps":["trace[1691892353] 'agreement among raft nodes before linearized reading' (duration: 3.402877493s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.602333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:44.135754Z","time spent":"4.466566768s","remote":"127.0.0.1:49046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:48.602351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:45.199168Z","time spent":"3.40316626s","remote":"127.0.0.1:53518","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":0,"response size":28,"request content":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:48.602335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.403335364s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"warn","ts":"2026-07-09T13:13:48.60235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"5.403423337s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-09T13:13:48.602421Z","caller":"traceutil/trace.go:171","msg":"trace[796754113] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1400; }","duration":"5.403508519s","start":"2026-07-09T13:13:43.198892Z","end":"2026-07-09T13:13:48.602401Z","steps":["trace[796754113] 'agreement among raft nodes before linearized reading' (duration: 5.403213221s)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:13:48.602432Z","caller":"traceutil/trace.go:171","msg":"trace[643388610] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1400; }","duration":"5.40355785s","start":"2026-07-09T13:13:43.198856Z","end":"2026-07-09T13:13:48.602414Z","steps":["trace[643388610] 'agreement among raft nodes before linearized reading' (duration: 5.403269512s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.602475Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:43.198872Z","time spent":"5.403593982s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":454,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-07-09T13:13:48.602484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:43.198827Z","time spent":"5.403643863s","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-09T13:13:48.602552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"3.537242815s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 ","response":"range_response_count:6 size:2185"} {"level":"info","ts":"2026-07-09T13:13:48.602588Z","caller":"traceutil/trace.go:171","msg":"trace[1373999994] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:6; response_revision:1400; }","duration":"3.537328617s","start":"2026-07-09T13:13:45.06525Z","end":"2026-07-09T13:13:48.602579Z","steps":["trace[1373999994] 'agreement among raft nodes before linearized reading' (duration: 3.537199132s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.602616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:45.065221Z","time spent":"3.537387349s","remote":"127.0.0.1:53356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":6,"response size":2208,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:500 "} {"level":"warn","ts":"2026-07-09T13:13:48.602638Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"4.583481981s","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":"info","ts":"2026-07-09T13:13:48.602696Z","caller":"traceutil/trace.go:171","msg":"trace[809232556] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1400; }","duration":"4.583584324s","start":"2026-07-09T13:13:44.019096Z","end":"2026-07-09T13:13:48.60268Z","steps":["trace[809232556] 'agreement among raft nodes before linearized reading' (duration: 4.583493041s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.602155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.784348297s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-09T13:13:48.602756Z","caller":"traceutil/trace.go:171","msg":"trace[1673173312] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1400; }","duration":"1.785037467s","start":"2026-07-09T13:13:46.817705Z","end":"2026-07-09T13:13:48.602742Z","steps":["trace[1673173312] 'agreement among raft nodes before linearized reading' (duration: 1.784295756s)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.602752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:44.019075Z","time spent":"4.583660826s","remote":"127.0.0.1:49092","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-07-09T13:13:48.602803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:46.817676Z","time spent":"1.785111889s","remote":"127.0.0.1:48920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true "} {"level":"warn","ts":"2026-07-09T13:13:48.602805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"827.617108ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:550"} {"level":"info","ts":"2026-07-09T13:13:48.602948Z","caller":"traceutil/trace.go:171","msg":"trace[1760457323] range","detail":"{range_begin:/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:1400; }","duration":"827.788493ms","start":"2026-07-09T13:13:47.775144Z","end":"2026-07-09T13:13:48.602932Z","steps":["trace[1760457323] 'agreement among raft nodes before linearized reading' (duration: 827.615338ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.602947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"895.626704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/kube-system/kube-apiserver-instance.18c0a1490bc1b4b6\" ","response":"range_response_count:1 size:774"} {"level":"warn","ts":"2026-07-09T13:13:48.602983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.066513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-09T13:13:48.602993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:47.775125Z","time spent":"827.855914ms","remote":"127.0.0.1:53486","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":573,"request content":"key:\"/registry/leases/envoy-gateway-system/5b9825d2.gateway.envoyproxy.io\" "} {"level":"info","ts":"2026-07-09T13:13:48.603007Z","caller":"traceutil/trace.go:171","msg":"trace[901654391] range","detail":"{range_begin:/registry/events/kube-system/kube-apiserver-instance.18c0a1490bc1b4b6; range_end:; response_count:1; response_revision:1400; }","duration":"895.829989ms","start":"2026-07-09T13:13:47.707157Z","end":"2026-07-09T13:13:48.602987Z","steps":["trace[901654391] 'agreement among raft nodes before linearized reading' (duration: 895.668635ms)"],"step_count":1} {"level":"info","ts":"2026-07-09T13:13:48.603024Z","caller":"traceutil/trace.go:171","msg":"trace[1331022274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1400; }","duration":"892.155026ms","start":"2026-07-09T13:13:47.710858Z","end":"2026-07-09T13:13:48.603013Z","steps":["trace[1331022274] 'agreement among raft nodes before linearized reading' (duration: 892.089054ms)"],"step_count":1} {"level":"warn","ts":"2026-07-09T13:13:48.603063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:47.710837Z","time spent":"892.220547ms","remote":"127.0.0.1:53250","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-07-09T13:13:48.603069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-09T13:13:47.707115Z","time spent":"895.939642ms","remote":"127.0.0.1:53330","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":797,"request content":"key:\"/registry/events/kube-system/kube-apiserver-instance.18c0a1490bc1b4b6\" "} {"level":"info","ts":"2026-07-09T13:13:48.815178Z","caller":"traceutil/trace.go:171","msg":"trace[685199183] transaction","detail":"{read_only:false; response_revision:1405; number_of_response:1; }","duration":"111.377027ms","start":"2026-07-09T13:13:48.703763Z","end":"2026-07-09T13:13:48.81514Z","steps":["trace[685199183] 'process raft request' (duration: 111.166501ms)"],"step_count":1}