{"level":"warn","ts":"2026-08-11T07:27:07.21371Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T07:27:07.213839Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.216: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.216:2380","--initial-cluster=instance=https://199.19.213.216:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.216:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.216: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-08-11T07:27:07.213924Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T07:27:07.213994Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-08-11T07:27:07.214092Z","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-08-11T07:27:07.214845Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"]} {"level":"info","ts":"2026-08-11T07:27:07.214975Z","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.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.216: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-08-11T07:27:07.219985Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.709403ms"} {"level":"info","ts":"2026-08-11T07:27:07.228912Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"58fa9386873601ed","cluster-id":"b3ae27d84cfabdf7"} {"level":"info","ts":"2026-08-11T07:27:07.228991Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T07:27:07.229012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 0"} {"level":"info","ts":"2026-08-11T07:27:07.229025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 58fa9386873601ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T07:27:07.229033Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became follower at term 1"} {"level":"info","ts":"2026-08-11T07:27:07.229194Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"warn","ts":"2026-08-11T07:27:07.236887Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T07:27:07.238444Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T07:27:07.241319Z","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-08-11T07:27:07.244106Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"58fa9386873601ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T07:27:07.244375Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"58fa9386873601ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T07:27:07.244521Z","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-08-11T07:27:07.244572Z","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-08-11T07:27:07.244595Z","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-08-11T07:27:07.245271Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed switched to configuration voters=(6411599225518686701)"} {"level":"info","ts":"2026-08-11T07:27:07.245502Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","added-peer-id":"58fa9386873601ed","added-peer-peer-urls":["https://199.19.213.216:2380"]} {"level":"info","ts":"2026-08-11T07:27:07.25036Z","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-08-11T07:27:07.250616Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-08-11T07:27:07.250759Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.216:2380"} {"level":"info","ts":"2026-08-11T07:27:07.251692Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"58fa9386873601ed","initial-advertise-peer-urls":["https://199.19.213.216:2380"],"listen-peer-urls":["https://199.19.213.216:2380"],"advertise-client-urls":["https://199.19.213.216:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.216:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T07:27:07.251821Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T07:27:07.430393Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T07:27:07.430458Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T07:27:07.430533Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgPreVoteResp from 58fa9386873601ed at term 1"} {"level":"info","ts":"2026-08-11T07:27:07.430553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became candidate at term 2"} {"level":"info","ts":"2026-08-11T07:27:07.430565Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed received MsgVoteResp from 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-08-11T07:27:07.430581Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"58fa9386873601ed became leader at term 2"} {"level":"info","ts":"2026-08-11T07:27:07.430602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 58fa9386873601ed elected leader 58fa9386873601ed at term 2"} {"level":"info","ts":"2026-08-11T07:27:07.431631Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:27:07.432582Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"58fa9386873601ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.216:2379]}","request-path":"/0/members/58fa9386873601ed/attributes","cluster-id":"b3ae27d84cfabdf7","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T07:27:07.432647Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T07:27:07.432704Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T07:27:07.433016Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b3ae27d84cfabdf7","local-member-id":"58fa9386873601ed","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:27:07.433319Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:27:07.433356Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T07:27:07.433577Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T07:27:07.433697Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T07:27:07.436434Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T07:27:07.436802Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.216:2379"} {"level":"warn","ts":"2026-08-11T07:27:09.32173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.20929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:3491"} {"level":"info","ts":"2026-08-11T07:27:09.321872Z","caller":"traceutil/trace.go:171","msg":"trace[210969877] transaction","detail":"{read_only:false; response_revision:21; number_of_response:1; }","duration":"103.485334ms","start":"2026-08-11T07:27:09.218347Z","end":"2026-08-11T07:27:09.321832Z","steps":["trace[210969877] 'process raft request' (duration: 72.539223ms)","trace[210969877] 'compare' (duration: 29.74202ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:09.321964Z","caller":"traceutil/trace.go:171","msg":"trace[1123822282] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:28; }","duration":"102.489497ms","start":"2026-08-11T07:27:09.219447Z","end":"2026-08-11T07:27:09.321937Z","steps":["trace[1123822282] 'agreement among raft nodes before linearized reading' (duration: 102.127598ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:09.32217Z","caller":"traceutil/trace.go:171","msg":"trace[909915159] transaction","detail":"{read_only:false; response_revision:25; number_of_response:1; }","duration":"100.805973ms","start":"2026-08-11T07:27:09.221337Z","end":"2026-08-11T07:27:09.322142Z","steps":["trace[909915159] 'process raft request' (duration: 99.622623ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:09.322198Z","caller":"traceutil/trace.go:171","msg":"trace[1816683826] transaction","detail":"{read_only:false; response_revision:24; number_of_response:1; }","duration":"101.019479ms","start":"2026-08-11T07:27:09.221119Z","end":"2026-08-11T07:27:09.322139Z","steps":["trace[1816683826] 'process raft request' (duration: 99.802528ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:09.322349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.736813ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-08-11T07:27:09.322384Z","caller":"traceutil/trace.go:171","msg":"trace[408622609] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:28; }","duration":"102.810465ms","start":"2026-08-11T07:27:09.219565Z","end":"2026-08-11T07:27:09.322375Z","steps":["trace[408622609] 'agreement among raft nodes before linearized reading' (duration: 102.747034ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:09.322412Z","caller":"traceutil/trace.go:171","msg":"trace[860148510] transaction","detail":"{read_only:false; response_revision:22; number_of_response:1; }","duration":"103.962807ms","start":"2026-08-11T07:27:09.218423Z","end":"2026-08-11T07:27:09.322386Z","steps":["trace[860148510] 'process raft request' (duration: 102.417197ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:09.322289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.167277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-public/\" range_end:\"/registry/resourcequotas/kube-public0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-08-11T07:27:09.322598Z","caller":"traceutil/trace.go:171","msg":"trace[774997282] transaction","detail":"{read_only:false; response_revision:23; number_of_response:1; }","duration":"102.935359ms","start":"2026-08-11T07:27:09.219652Z","end":"2026-08-11T07:27:09.322587Z","steps":["trace[774997282] 'process raft request' (duration: 101.240445ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:09.322756Z","caller":"traceutil/trace.go:171","msg":"trace[811443743] range","detail":"{range_begin:/registry/resourcequotas/kube-public/; range_end:/registry/resourcequotas/kube-public0; response_count:0; response_revision:28; }","duration":"100.574228ms","start":"2026-08-11T07:27:09.222084Z","end":"2026-08-11T07:27:09.322659Z","steps":["trace[811443743] 'agreement among raft nodes before linearized reading' (duration: 100.170737ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:27.366036Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447814319,"retry-timeout":"500ms"} {"level":"info","ts":"2026-08-11T07:27:27.410843Z","caller":"traceutil/trace.go:171","msg":"trace[1275514042] linearizableReadLoop","detail":"{readStateIndex:441; appliedIndex:440; }","duration":"545.843946ms","start":"2026-08-11T07:27:26.864977Z","end":"2026-08-11T07:27:27.410821Z","steps":["trace[1275514042] 'read index received' (duration: 545.721173ms)","trace[1275514042] 'applied index is now lower than readState.Index' (duration: 122.013µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:27.410945Z","caller":"traceutil/trace.go:171","msg":"trace[1100197418] transaction","detail":"{read_only:false; response_revision:425; number_of_response:1; }","duration":"681.656847ms","start":"2026-08-11T07:27:26.729278Z","end":"2026-08-11T07:27:27.410934Z","steps":["trace[1100197418] 'process raft request' (duration: 681.37551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:27.411441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"546.434751ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:27:27.411519Z","caller":"traceutil/trace.go:171","msg":"trace[1299568980] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:425; }","duration":"546.566405ms","start":"2026-08-11T07:27:26.864934Z","end":"2026-08-11T07:27:27.4115Z","steps":["trace[1299568980] 'agreement among raft nodes before linearized reading' (duration: 546.38862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:27.41156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:26.864912Z","time spent":"546.641416ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:27:27.411558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:26.729258Z","time spent":"681.713229ms","remote":"127.0.0.1:58010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7288,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:27:28.591549Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.075747983s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-11T07:27:28.603411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.12022375s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:27:28.603651Z","caller":"traceutil/trace.go:171","msg":"trace[510574074] linearizableReadLoop","detail":"{readStateIndex:443; appliedIndex:441; }","duration":"1.175380087s","start":"2026-08-11T07:27:27.428253Z","end":"2026-08-11T07:27:28.603633Z","steps":["trace[510574074] 'read index received' (duration: 54.279165ms)","trace[510574074] 'applied index is now lower than readState.Index' (duration: 1.121100012s)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:28.603768Z","caller":"traceutil/trace.go:171","msg":"trace[636924789] transaction","detail":"{read_only:false; response_revision:426; number_of_response:1; }","duration":"1.185703626s","start":"2026-08-11T07:27:27.418054Z","end":"2026-08-11T07:27:28.603758Z","steps":["trace[636924789] 'process raft request' (duration: 64.496381ms)","trace[636924789] 'compare' (duration: 1.119631565s)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:27:28.603833Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:27.418036Z","time spent":"1.185764539s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:27:28.603967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.175699725s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:27:28.604044Z","caller":"traceutil/trace.go:171","msg":"trace[733267809] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:427; }","duration":"1.175825528s","start":"2026-08-11T07:27:27.428196Z","end":"2026-08-11T07:27:28.604022Z","steps":["trace[733267809] 'agreement among raft nodes before linearized reading' (duration: 1.175643304s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:28.604065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"815.559629ms","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-08-11T07:27:28.604085Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:27.428177Z","time spent":"1.175898461s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T07:27:28.604107Z","caller":"traceutil/trace.go:171","msg":"trace[1606956753] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:427; }","duration":"815.635411ms","start":"2026-08-11T07:27:27.788462Z","end":"2026-08-11T07:27:28.604097Z","steps":["trace[1606956753] 'agreement among raft nodes before linearized reading' (duration: 815.562489ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:28.604145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:27.788443Z","time spent":"815.695183ms","remote":"127.0.0.1:58078","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":"info","ts":"2026-08-11T07:27:28.604233Z","caller":"traceutil/trace.go:171","msg":"trace[1455665335] transaction","detail":"{read_only:false; response_revision:427; number_of_response:1; }","duration":"1.180979122s","start":"2026-08-11T07:27:27.42324Z","end":"2026-08-11T07:27:28.604219Z","steps":["trace[1455665335] 'process raft request' (duration: 1.180287695s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:28.604325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.629408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:27:28.604327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:27.423228Z","time spent":"1.181041245s","remote":"127.0.0.1:58010","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7096,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:27:28.604363Z","caller":"traceutil/trace.go:171","msg":"trace[1418810448] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:427; }","duration":"283.70344ms","start":"2026-08-11T07:27:28.320651Z","end":"2026-08-11T07:27:28.604354Z","steps":["trace[1418810448] 'agreement among raft nodes before linearized reading' (duration: 283.647388ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:28.604494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"754.97519ms","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-08-11T07:27:28.604531Z","caller":"traceutil/trace.go:171","msg":"trace[1042511349] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:427; }","duration":"755.044001ms","start":"2026-08-11T07:27:27.849478Z","end":"2026-08-11T07:27:28.604522Z","steps":["trace[1042511349] 'agreement among raft nodes before linearized reading' (duration: 754.97986ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:28.604557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:27.849459Z","time spent":"755.091953ms","remote":"127.0.0.1:58078","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-08-11T07:27:45.976283Z","caller":"traceutil/trace.go:171","msg":"trace[507504177] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"101.942463ms","start":"2026-08-11T07:27:45.874091Z","end":"2026-08-11T07:27:45.976033Z","steps":["trace[507504177] 'process raft request' (duration: 101.710737ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:45.984275Z","caller":"traceutil/trace.go:171","msg":"trace[1100447597] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"106.247866ms","start":"2026-08-11T07:27:45.877996Z","end":"2026-08-11T07:27:45.984244Z","steps":["trace[1100447597] 'process raft request' (duration: 105.266501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.096507Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447814581,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:27:47.597282Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447814581,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:27:47.63165Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.402908413s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T07:27:47.645191Z","caller":"traceutil/trace.go:171","msg":"trace[831138197] transaction","detail":"{read_only:false; response_revision:575; number_of_response:1; }","duration":"1.416533391s","start":"2026-08-11T07:27:46.228626Z","end":"2026-08-11T07:27:47.645159Z","steps":["trace[831138197] 'process raft request' (duration: 1.403353215s)","trace[831138197] 'compare' (duration: 12.236131ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:47.645307Z","caller":"traceutil/trace.go:171","msg":"trace[962934614] transaction","detail":"{read_only:false; response_revision:576; number_of_response:1; }","duration":"1.407865753s","start":"2026-08-11T07:27:46.237429Z","end":"2026-08-11T07:27:47.645295Z","steps":["trace[962934614] 'process raft request' (duration: 1.407678609s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.645351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.228611Z","time spent":"1.416653744s","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:27:47.645381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.237422Z","time spent":"1.407923415s","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":59607,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:27:47.655778Z","caller":"traceutil/trace.go:171","msg":"trace[1793701266] linearizableReadLoop","detail":"{readStateIndex:601; appliedIndex:597; }","duration":"1.060218456s","start":"2026-08-11T07:27:46.595541Z","end":"2026-08-11T07:27:47.655759Z","steps":["trace[1793701266] 'read index received' (duration: 1.036439893s)","trace[1793701266] 'applied index is now lower than readState.Index' (duration: 23.777383ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:47.656058Z","caller":"traceutil/trace.go:171","msg":"trace[1881245939] transaction","detail":"{read_only:false; response_revision:577; number_of_response:1; }","duration":"1.341594917s","start":"2026-08-11T07:27:46.314456Z","end":"2026-08-11T07:27:47.65605Z","steps":["trace[1881245939] 'process raft request' (duration: 1.340813986s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.656139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.314434Z","time spent":"1.341652438s","remote":"127.0.0.1:57852","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T07:27:47.656557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060891284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.656603Z","caller":"traceutil/trace.go:171","msg":"trace[461281536] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:577; }","duration":"1.060943755s","start":"2026-08-11T07:27:46.595643Z","end":"2026-08-11T07:27:47.656586Z","steps":["trace[461281536] 'agreement among raft nodes before linearized reading' (duration: 1.060856833s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.656646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.595612Z","time spent":"1.061027037s","remote":"127.0.0.1:42430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-11T07:27:47.656798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.973852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.656824Z","caller":"traceutil/trace.go:171","msg":"trace[1457301545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:577; }","duration":"336.040623ms","start":"2026-08-11T07:27:47.320777Z","end":"2026-08-11T07:27:47.656817Z","steps":["trace[1457301545] 'agreement among raft nodes before linearized reading' (duration: 336.003683ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.656846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:47.320759Z","time spent":"336.083925ms","remote":"127.0.0.1:57818","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-08-11T07:27:47.656887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.100661ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:27:47.656947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"989.318487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.656947Z","caller":"traceutil/trace.go:171","msg":"trace[1157663391] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:577; }","duration":"989.222524ms","start":"2026-08-11T07:27:46.66771Z","end":"2026-08-11T07:27:47.656933Z","steps":["trace[1157663391] 'agreement among raft nodes before linearized reading' (duration: 989.107641ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:47.656969Z","caller":"traceutil/trace.go:171","msg":"trace[1787905965] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:577; }","duration":"989.365828ms","start":"2026-08-11T07:27:46.667597Z","end":"2026-08-11T07:27:47.656963Z","steps":["trace[1787905965] 'agreement among raft nodes before linearized reading' (duration: 989.332517ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.656988Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.667686Z","time spent":"989.294407ms","remote":"127.0.0.1:42460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:27:47.657024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008362127s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.657053Z","caller":"traceutil/trace.go:171","msg":"trace[2039432843] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:577; }","duration":"1.008406727s","start":"2026-08-11T07:27:46.648635Z","end":"2026-08-11T07:27:47.657042Z","steps":["trace[2039432843] 'agreement among raft nodes before linearized reading' (duration: 1.008371916s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.648627Z","time spent":"1.008443609s","remote":"127.0.0.1:42450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-11T07:27:47.657198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.469207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:27:47.657221Z","caller":"traceutil/trace.go:171","msg":"trace[290052568] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:577; }","duration":"892.54595ms","start":"2026-08-11T07:27:46.764669Z","end":"2026-08-11T07:27:47.657215Z","steps":["trace[290052568] 'agreement among raft nodes before linearized reading' (duration: 892.467187ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.764643Z","time spent":"892.59184ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T07:27:47.657246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009384284s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.657271Z","caller":"traceutil/trace.go:171","msg":"trace[1627501036] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:577; }","duration":"1.009484827s","start":"2026-08-11T07:27:46.647777Z","end":"2026-08-11T07:27:47.657262Z","steps":["trace[1627501036] 'agreement among raft nodes before linearized reading' (duration: 1.009446466s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.647762Z","time spent":"1.009524108s","remote":"127.0.0.1:42450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:27:47.65737Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"894.410699ms","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-08-11T07:27:47.657392Z","caller":"traceutil/trace.go:171","msg":"trace[414706989] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:577; }","duration":"894.46632ms","start":"2026-08-11T07:27:46.762919Z","end":"2026-08-11T07:27:47.657385Z","steps":["trace[414706989] 'agreement among raft nodes before linearized reading' (duration: 894.409509ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.762896Z","time spent":"894.512702ms","remote":"127.0.0.1:58078","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-08-11T07:27:47.657428Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031703059s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.65745Z","caller":"traceutil/trace.go:171","msg":"trace[361991107] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:577; }","duration":"1.031781192s","start":"2026-08-11T07:27:46.625662Z","end":"2026-08-11T07:27:47.657443Z","steps":["trace[361991107] 'agreement among raft nodes before linearized reading' (duration: 1.031745061s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.95087ms","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-08-11T07:27:47.657567Z","caller":"traceutil/trace.go:171","msg":"trace[1483212876] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:577; }","duration":"938.054783ms","start":"2026-08-11T07:27:46.719506Z","end":"2026-08-11T07:27:47.657561Z","steps":["trace[1483212876] 'agreement among raft nodes before linearized reading' (duration: 938.017342ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.719447Z","time spent":"938.133165ms","remote":"127.0.0.1:58078","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-08-11T07:27:47.657613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.032963272s","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-08-11T07:27:47.657646Z","caller":"traceutil/trace.go:171","msg":"trace[169846756] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:577; }","duration":"1.033007934s","start":"2026-08-11T07:27:46.624625Z","end":"2026-08-11T07:27:47.657633Z","steps":["trace[169846756] 'agreement among raft nodes before linearized reading' (duration: 1.032950972s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.624621Z","time spent":"1.033040834s","remote":"127.0.0.1:42444","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-08-11T07:27:47.65767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"967.021963ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:27:47.657692Z","caller":"traceutil/trace.go:171","msg":"trace[573956719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:577; }","duration":"967.065744ms","start":"2026-08-11T07:27:46.690621Z","end":"2026-08-11T07:27:47.657686Z","steps":["trace[573956719] 'agreement among raft nodes before linearized reading' (duration: 967.028733ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.690605Z","time spent":"967.100705ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:27:47.657785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.033166007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.657807Z","caller":"traceutil/trace.go:171","msg":"trace[1052852414] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:577; }","duration":"1.033212659s","start":"2026-08-11T07:27:46.624587Z","end":"2026-08-11T07:27:47.657799Z","steps":["trace[1052852414] 'agreement among raft nodes before linearized reading' (duration: 1.033174818s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657822Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.511314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:27:47.657827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.624568Z","time spent":"1.033253679s","remote":"127.0.0.1:42444","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"info","ts":"2026-08-11T07:27:47.657842Z","caller":"traceutil/trace.go:171","msg":"trace[1573560777] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:577; }","duration":"970.580286ms","start":"2026-08-11T07:27:46.687255Z","end":"2026-08-11T07:27:47.657836Z","steps":["trace[1573560777] 'agreement among raft nodes before linearized reading' (duration: 970.539595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.657862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.687227Z","time spent":"970.629037ms","remote":"127.0.0.1:42468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 "} {"level":"warn","ts":"2026-08-11T07:27:47.657965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"970.857433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.657983Z","caller":"traceutil/trace.go:171","msg":"trace[349342412] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:577; }","duration":"970.891824ms","start":"2026-08-11T07:27:46.687086Z","end":"2026-08-11T07:27:47.657978Z","steps":["trace[349342412] 'agreement among raft nodes before linearized reading' (duration: 970.863074ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.658002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.687078Z","time spent":"970.917785ms","remote":"127.0.0.1:42468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:27:47.657389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.009797314s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.658078Z","caller":"traceutil/trace.go:171","msg":"trace[877497239] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:577; }","duration":"1.010498023s","start":"2026-08-11T07:27:46.647571Z","end":"2026-08-11T07:27:47.658069Z","steps":["trace[877497239] 'agreement among raft nodes before linearized reading' (duration: 1.009796915s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.6581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.64756Z","time spent":"1.010532343s","remote":"127.0.0.1:42450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-11T07:27:47.658111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.039528ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.658134Z","caller":"traceutil/trace.go:171","msg":"trace[2053914474] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:577; }","duration":"971.065608ms","start":"2026-08-11T07:27:46.687061Z","end":"2026-08-11T07:27:47.658127Z","steps":["trace[2053914474] 'agreement among raft nodes before linearized reading' (duration: 971.025547ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.658157Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.68702Z","time spent":"971.13127ms","remote":"127.0.0.1:42468","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 "} {"level":"warn","ts":"2026-08-11T07:27:47.658292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"990.351164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:47.658312Z","caller":"traceutil/trace.go:171","msg":"trace[2034644290] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:577; }","duration":"990.380235ms","start":"2026-08-11T07:27:46.667925Z","end":"2026-08-11T07:27:47.658305Z","steps":["trace[2034644290] 'agreement among raft nodes before linearized reading' (duration: 990.347514ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.658333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.66792Z","time spent":"990.407576ms","remote":"127.0.0.1:42460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-08-11T07:27:47.656994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.667583Z","time spent":"989.405889ms","remote":"127.0.0.1:42460","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"warn","ts":"2026-08-11T07:27:47.657471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.625644Z","time spent":"1.031820772s","remote":"127.0.0.1:42430","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-11T07:27:47.656355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.060797151s","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-08-11T07:27:47.659188Z","caller":"traceutil/trace.go:171","msg":"trace[952858601] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:577; }","duration":"1.063640535s","start":"2026-08-11T07:27:46.595534Z","end":"2026-08-11T07:27:47.659174Z","steps":["trace[952858601] 'agreement among raft nodes before linearized reading' (duration: 1.060721729s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:47.659223Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:46.595487Z","time spent":"1.063725018s","remote":"127.0.0.1:42430","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":"info","ts":"2026-08-11T07:27:50.254962Z","caller":"traceutil/trace.go:171","msg":"trace[1764452016] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"572.239958ms","start":"2026-08-11T07:27:49.68266Z","end":"2026-08-11T07:27:50.2549Z","steps":["trace[1764452016] 'process raft request' (duration: 571.977531ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:50.255206Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:49.682643Z","time spent":"572.439452ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:27:50.308771Z","caller":"traceutil/trace.go:171","msg":"trace[776299794] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"624.031317ms","start":"2026-08-11T07:27:49.684671Z","end":"2026-08-11T07:27:50.308702Z","steps":["trace[776299794] 'process raft request' (duration: 623.941355ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:50.308937Z","caller":"traceutil/trace.go:171","msg":"trace[399505643] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"625.297049ms","start":"2026-08-11T07:27:49.683612Z","end":"2026-08-11T07:27:50.308909Z","steps":["trace[399505643] 'process raft request' (duration: 589.86181ms)","trace[399505643] 'compare' (duration: 34.757172ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:50.308944Z","caller":"traceutil/trace.go:171","msg":"trace[1341968603] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"624.334264ms","start":"2026-08-11T07:27:49.684578Z","end":"2026-08-11T07:27:50.308912Z","steps":["trace[1341968603] 'process raft request' (duration: 623.965035ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:50.308996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:49.684665Z","time spent":"624.203631ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:27:50.309093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:49.683595Z","time spent":"625.413733ms","remote":"127.0.0.1:58078","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-08-11T07:27:50.309117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:49.684569Z","time spent":"624.451547ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:27:50.982041Z","caller":"traceutil/trace.go:171","msg":"trace[910461506] transaction","detail":"{read_only:false; response_revision:622; number_of_response:1; }","duration":"118.59318ms","start":"2026-08-11T07:27:50.863401Z","end":"2026-08-11T07:27:50.981994Z","steps":["trace[910461506] 'process raft request' (duration: 117.953023ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:51.588864Z","caller":"traceutil/trace.go:171","msg":"trace[1492523707] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"110.423847ms","start":"2026-08-11T07:27:51.478205Z","end":"2026-08-11T07:27:51.588629Z","steps":["trace[1492523707] 'process raft request' (duration: 107.532451ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:52.636017Z","caller":"traceutil/trace.go:171","msg":"trace[1065914084] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"241.077103ms","start":"2026-08-11T07:27:52.394912Z","end":"2026-08-11T07:27:52.635989Z","steps":["trace[1065914084] 'process raft request' (duration: 238.117215ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:52.636333Z","caller":"traceutil/trace.go:171","msg":"trace[1118108027] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"241.37588ms","start":"2026-08-11T07:27:52.394935Z","end":"2026-08-11T07:27:52.636311Z","steps":["trace[1118108027] 'process raft request' (duration: 240.9863ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:52.636482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.3359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:52.636539Z","caller":"traceutil/trace.go:171","msg":"trace[342186302] range","detail":"{range_begin:/registry/rolebindings/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:631; }","duration":"241.417002ms","start":"2026-08-11T07:27:52.395106Z","end":"2026-08-11T07:27:52.636523Z","steps":["trace[342186302] 'agreement among raft nodes before linearized reading' (duration: 241.305339ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:52.636566Z","caller":"traceutil/trace.go:171","msg":"trace[1461298371] linearizableReadLoop","detail":"{readStateIndex:656; appliedIndex:653; }","duration":"241.134025ms","start":"2026-08-11T07:27:52.395113Z","end":"2026-08-11T07:27:52.636247Z","steps":["trace[1461298371] 'read index received' (duration: 39.912167ms)","trace[1461298371] 'applied index is now lower than readState.Index' (duration: 201.219657ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:53.777143Z","caller":"traceutil/trace.go:171","msg":"trace[2035575323] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"135.621837ms","start":"2026-08-11T07:27:53.641497Z","end":"2026-08-11T07:27:53.777118Z","steps":["trace[2035575323] 'process raft request' (duration: 134.58357ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:55.593689Z","caller":"traceutil/trace.go:171","msg":"trace[547033377] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"172.945346ms","start":"2026-08-11T07:27:55.420717Z","end":"2026-08-11T07:27:55.593663Z","steps":["trace[547033377] 'process raft request' (duration: 172.274458ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:55.87329Z","caller":"traceutil/trace.go:171","msg":"trace[136861618] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"235.183998ms","start":"2026-08-11T07:27:55.638074Z","end":"2026-08-11T07:27:55.873258Z","steps":["trace[136861618] 'process raft request' (duration: 234.971903ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:27:56.552906Z","caller":"traceutil/trace.go:171","msg":"trace[398191428] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"881.847829ms","start":"2026-08-11T07:27:55.671007Z","end":"2026-08-11T07:27:56.552855Z","steps":["trace[398191428] 'process raft request' (duration: 794.614301ms)","trace[398191428] 'compare' (duration: 86.464298ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:27:56.552979Z","caller":"traceutil/trace.go:171","msg":"trace[231554212] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"257.086823ms","start":"2026-08-11T07:27:56.295856Z","end":"2026-08-11T07:27:56.552942Z","steps":["trace[231554212] 'read index received' (duration: 169.825914ms)","trace[231554212] 'applied index is now lower than readState.Index' (duration: 87.256459ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:27:56.553054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:55.670984Z","time spent":"881.994043ms","remote":"127.0.0.1:58052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-08-11T07:27:58.321637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.99530851s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-08-11T07:27:58.321692Z","caller":"traceutil/trace.go:171","msg":"trace[1931559808] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"1.995402223s","start":"2026-08-11T07:27:56.326276Z","end":"2026-08-11T07:27:58.321678Z","steps":["trace[1931559808] 'agreement among raft nodes before linearized reading' (duration: 1.995334751s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:58.321728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:56.326257Z","time spent":"1.995464645s","remote":"127.0.0.1:57818","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/08/11 07:27:58 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-08-11T07:27:59.094449Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.54206451s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T07:27:59.094652Z","caller":"traceutil/trace.go:171","msg":"trace[435363738] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"2.541553277s","start":"2026-08-11T07:27:56.55307Z","end":"2026-08-11T07:27:59.094623Z","steps":["trace[435363738] 'read index received' (duration: 63.032µs)","trace[435363738] 'applied index is now lower than readState.Index' (duration: 2.541484445s)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:27:59.09529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"773.196629ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:27:59.095401Z","caller":"traceutil/trace.go:171","msg":"trace[1139572191] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:650; }","duration":"773.372985ms","start":"2026-08-11T07:27:58.321998Z","end":"2026-08-11T07:27:59.095371Z","steps":["trace[1139572191] 'agreement among raft nodes before linearized reading' (duration: 773.220131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:59.095447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:58.321968Z","time spent":"773.471037ms","remote":"127.0.0.1:57810","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-08-11T07:27:59.097031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.801154076s","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-08-11T07:27:59.097112Z","caller":"traceutil/trace.go:171","msg":"trace[1247902494] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:650; }","duration":"2.80128341s","start":"2026-08-11T07:27:56.295804Z","end":"2026-08-11T07:27:59.097088Z","steps":["trace[1247902494] 'agreement among raft nodes before linearized reading' (duration: 257.291928ms)","trace[1247902494] 'range keys from in-memory index tree' (duration: 2.541439444s)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:27:59.097054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.538030395s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/job-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-08-11T07:27:59.097242Z","caller":"traceutil/trace.go:171","msg":"trace[591553846] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/job-controller; range_end:; response_count:1; response_revision:650; }","duration":"2.538288932s","start":"2026-08-11T07:27:56.55893Z","end":"2026-08-11T07:27:59.097219Z","steps":["trace[591553846] 'agreement among raft nodes before linearized reading' (duration: 2.536130235s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:59.097249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:56.295784Z","time spent":"2.801449014s","remote":"127.0.0.1:58078","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-08-11T07:27:59.097325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:56.558904Z","time spent":"2.538409765s","remote":"127.0.0.1:58032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/job-controller\" "} {"level":"warn","ts":"2026-08-11T07:27:59.097368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.649251421s","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-08-11T07:27:59.097455Z","caller":"traceutil/trace.go:171","msg":"trace[841880242] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:650; }","duration":"2.649409015s","start":"2026-08-11T07:27:56.448023Z","end":"2026-08-11T07:27:59.097432Z","steps":["trace[841880242] 'agreement among raft nodes before linearized reading' (duration: 2.646988642s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:59.097518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:56.447987Z","time spent":"2.649515078s","remote":"127.0.0.1:58078","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-08-11T07:27:59.097734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.372508785s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-11T07:27:59.097861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.431144211s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:27:59.098202Z","caller":"traceutil/trace.go:171","msg":"trace[880369256] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:650; }","duration":"2.431260605s","start":"2026-08-11T07:27:56.666678Z","end":"2026-08-11T07:27:59.097939Z","steps":["trace[880369256] 'agreement among raft nodes before linearized reading' (duration: 2.428720709s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:59.098334Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:56.666658Z","time spent":"2.431661936s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T07:27:59.097971Z","caller":"traceutil/trace.go:171","msg":"trace[1603487682] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:650; }","duration":"2.372692099s","start":"2026-08-11T07:27:56.725191Z","end":"2026-08-11T07:27:59.097883Z","steps":["trace[1603487682] 'agreement among raft nodes before linearized reading' (duration: 2.369973578s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:27:59.098549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:27:56.725177Z","time spent":"2.373350628s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T07:28:04.195977Z","caller":"traceutil/trace.go:171","msg":"trace[2041273530] transaction","detail":"{read_only:false; response_revision:732; number_of_response:1; }","duration":"258.208866ms","start":"2026-08-11T07:28:03.937732Z","end":"2026-08-11T07:28:04.195941Z","steps":["trace[2041273530] 'process raft request' (duration: 257.930799ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:04.578136Z","caller":"traceutil/trace.go:171","msg":"trace[1394968843] transaction","detail":"{read_only:false; response_revision:735; number_of_response:1; }","duration":"183.249124ms","start":"2026-08-11T07:28:04.394863Z","end":"2026-08-11T07:28:04.578112Z","steps":["trace[1394968843] 'process raft request' (duration: 182.996358ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:04.615454Z","caller":"traceutil/trace.go:171","msg":"trace[1754168704] linearizableReadLoop","detail":"{readStateIndex:763; appliedIndex:761; }","duration":"106.684018ms","start":"2026-08-11T07:28:04.508741Z","end":"2026-08-11T07:28:04.615425Z","steps":["trace[1754168704] 'read index received' (duration: 69.025137ms)","trace[1754168704] 'applied index is now lower than readState.Index' (duration: 37.658001ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:04.615551Z","caller":"traceutil/trace.go:171","msg":"trace[1781390987] transaction","detail":"{read_only:false; response_revision:736; number_of_response:1; }","duration":"217.568467ms","start":"2026-08-11T07:28:04.397923Z","end":"2026-08-11T07:28:04.615491Z","steps":["trace[1781390987] 'process raft request' (duration: 217.191707ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:04.615664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.892544ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:1 size:4083"} {"level":"info","ts":"2026-08-11T07:28:04.615725Z","caller":"traceutil/trace.go:171","msg":"trace[146389886] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:1; response_revision:736; }","duration":"106.975206ms","start":"2026-08-11T07:28:04.508733Z","end":"2026-08-11T07:28:04.615708Z","steps":["trace[146389886] 'agreement among raft nodes before linearized reading' (duration: 106.791331ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:04.829312Z","caller":"traceutil/trace.go:171","msg":"trace[688536688] linearizableReadLoop","detail":"{readStateIndex:764; appliedIndex:763; }","duration":"132.999ms","start":"2026-08-11T07:28:04.696281Z","end":"2026-08-11T07:28:04.82928Z","steps":["trace[688536688] 'read index received' (duration: 132.62937ms)","trace[688536688] 'applied index is now lower than readState.Index' (duration: 368.58µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:04.829419Z","caller":"traceutil/trace.go:171","msg":"trace[2023316490] transaction","detail":"{read_only:false; response_revision:737; number_of_response:1; }","duration":"138.009842ms","start":"2026-08-11T07:28:04.691375Z","end":"2026-08-11T07:28:04.829385Z","steps":["trace[2023316490] 'process raft request' (duration: 137.629283ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:04.82962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.298937ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-hqrvb\" ","response":"range_response_count:1 size:18337"} {"level":"info","ts":"2026-08-11T07:28:04.829704Z","caller":"traceutil/trace.go:171","msg":"trace[619035975] range","detail":"{range_begin:/registry/pods/kube-system/cilium-hqrvb; range_end:; response_count:1; response_revision:737; }","duration":"133.431192ms","start":"2026-08-11T07:28:04.696253Z","end":"2026-08-11T07:28:04.829684Z","steps":["trace[619035975] 'agreement among raft nodes before linearized reading' (duration: 133.130933ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:04.873522Z","caller":"traceutil/trace.go:171","msg":"trace[751881212] transaction","detail":"{read_only:false; response_revision:738; number_of_response:1; }","duration":"177.196204ms","start":"2026-08-11T07:28:04.696299Z","end":"2026-08-11T07:28:04.873495Z","steps":["trace[751881212] 'process raft request' (duration: 177.04706ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:04.873647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.380903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-08-11T07:28:04.873725Z","caller":"traceutil/trace.go:171","msg":"trace[1623944665] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:738; }","duration":"165.486036ms","start":"2026-08-11T07:28:04.708219Z","end":"2026-08-11T07:28:04.873705Z","steps":["trace[1623944665] 'agreement among raft nodes before linearized reading' (duration: 165.25675ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:04.87382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.818021ms","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-08-11T07:28:04.873969Z","caller":"traceutil/trace.go:171","msg":"trace[1351753533] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:738; }","duration":"148.029706ms","start":"2026-08-11T07:28:04.725907Z","end":"2026-08-11T07:28:04.873937Z","steps":["trace[1351753533] 'agreement among raft nodes before linearized reading' (duration: 147.629666ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:11.530732Z","caller":"traceutil/trace.go:171","msg":"trace[1148582015] linearizableReadLoop","detail":"{readStateIndex:827; appliedIndex:826; }","duration":"335.490521ms","start":"2026-08-11T07:28:11.195221Z","end":"2026-08-11T07:28:11.530712Z","steps":["trace[1148582015] 'read index received' (duration: 335.384468ms)","trace[1148582015] 'applied index is now lower than readState.Index' (duration: 104.873µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:11.530835Z","caller":"traceutil/trace.go:171","msg":"trace[938751253] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"336.522139ms","start":"2026-08-11T07:28:11.194305Z","end":"2026-08-11T07:28:11.530827Z","steps":["trace[938751253] 'process raft request' (duration: 336.297803ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:11.530923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:11.19428Z","time spent":"336.57238ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:11.531133Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.895901ms","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-08-11T07:28:11.531184Z","caller":"traceutil/trace.go:171","msg":"trace[418092701] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:797; }","duration":"335.968364ms","start":"2026-08-11T07:28:11.195202Z","end":"2026-08-11T07:28:11.53117Z","steps":["trace[418092701] 'agreement among raft nodes before linearized reading' (duration: 335.754328ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:11.531212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:11.195193Z","time spent":"336.012624ms","remote":"127.0.0.1:58078","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-08-11T07:28:11.531861Z","caller":"traceutil/trace.go:171","msg":"trace[1259844391] transaction","detail":"{read_only:false; response_revision:798; number_of_response:1; }","duration":"334.594937ms","start":"2026-08-11T07:28:11.19724Z","end":"2026-08-11T07:28:11.531835Z","steps":["trace[1259844391] 'process raft request' (duration: 334.125855ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:11.531913Z","caller":"traceutil/trace.go:171","msg":"trace[1332822277] transaction","detail":"{read_only:false; response_revision:799; number_of_response:1; }","duration":"334.074473ms","start":"2026-08-11T07:28:11.197829Z","end":"2026-08-11T07:28:11.531903Z","steps":["trace[1332822277] 'process raft request' (duration: 333.828296ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:11.531976Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:11.197816Z","time spent":"334.118854ms","remote":"127.0.0.1:58078","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-08-11T07:28:11.531973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:11.197227Z","time spent":"334.692299ms","remote":"127.0.0.1:58078","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-08-11T07:28:11.532709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.787534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:11.532775Z","caller":"traceutil/trace.go:171","msg":"trace[1832161992] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:799; }","duration":"211.881457ms","start":"2026-08-11T07:28:11.320877Z","end":"2026-08-11T07:28:11.532759Z","steps":["trace[1832161992] 'agreement among raft nodes before linearized reading' (duration: 210.827009ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:14.820829Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447815050,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:28:15.321083Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447815050,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:28:15.82145Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447815050,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:28:15.992497Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.142709879s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T07:28:15.992946Z","caller":"traceutil/trace.go:171","msg":"trace[1792542018] transaction","detail":"{read_only:false; response_revision:815; number_of_response:1; }","duration":"2.143283304s","start":"2026-08-11T07:28:13.849635Z","end":"2026-08-11T07:28:15.992919Z","steps":["trace[1792542018] 'process raft request' (duration: 2.14310856s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:15.993112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:13.849607Z","time spent":"2.143420487s","remote":"127.0.0.1:58002","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4948,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:16.054861Z","caller":"traceutil/trace.go:171","msg":"trace[1271315662] linearizableReadLoop","detail":"{readStateIndex:848; appliedIndex:845; }","duration":"1.734334251s","start":"2026-08-11T07:28:14.320494Z","end":"2026-08-11T07:28:16.054829Z","steps":["trace[1271315662] 'read index received' (duration: 1.672306127s)","trace[1271315662] 'applied index is now lower than readState.Index' (duration: 62.026864ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:16.054944Z","caller":"traceutil/trace.go:171","msg":"trace[1026779293] transaction","detail":"{read_only:false; response_revision:816; number_of_response:1; }","duration":"2.029531531s","start":"2026-08-11T07:28:14.025374Z","end":"2026-08-11T07:28:16.054905Z","steps":["trace[1026779293] 'process raft request' (duration: 2.029196671s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.055061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.734559266s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:28:16.055103Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:14.025355Z","time spent":"2.029670424s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:16.055123Z","caller":"traceutil/trace.go:171","msg":"trace[365849725] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:817; }","duration":"1.734628578s","start":"2026-08-11T07:28:14.32048Z","end":"2026-08-11T07:28:16.055108Z","steps":["trace[365849725] 'agreement among raft nodes before linearized reading' (duration: 1.734527175s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.055162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:14.320432Z","time spent":"1.73472091s","remote":"127.0.0.1:57818","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-08-11T07:28:16.055219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.085223715s","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-08-11T07:28:16.055282Z","caller":"traceutil/trace.go:171","msg":"trace[1622091880] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"1.085356408s","start":"2026-08-11T07:28:14.969911Z","end":"2026-08-11T07:28:16.055267Z","steps":["trace[1622091880] 'agreement among raft nodes before linearized reading' (duration: 1.085128282s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.055338Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:14.969887Z","time spent":"1.085439721s","remote":"127.0.0.1:58078","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-08-11T07:28:16.055323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.934007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-11T07:28:16.055412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"508.455284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:28:16.055429Z","caller":"traceutil/trace.go:171","msg":"trace[617526304] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:817; }","duration":"506.076701ms","start":"2026-08-11T07:28:15.549323Z","end":"2026-08-11T07:28:16.0554Z","steps":["trace[617526304] 'agreement among raft nodes before linearized reading' (duration: 505.768263ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.055474Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"506.349757ms","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-08-11T07:28:16.05547Z","caller":"traceutil/trace.go:171","msg":"trace[993052324] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:817; }","duration":"508.560426ms","start":"2026-08-11T07:28:15.546896Z","end":"2026-08-11T07:28:16.055456Z","steps":["trace[993052324] 'agreement among raft nodes before linearized reading' (duration: 508.272269ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.055479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"661.741457ms","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-08-11T07:28:16.055481Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:15.549309Z","time spent":"506.162763ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T07:28:16.0555Z","caller":"traceutil/trace.go:171","msg":"trace[784904402] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:817; }","duration":"506.44062ms","start":"2026-08-11T07:28:15.549052Z","end":"2026-08-11T07:28:16.055493Z","steps":["trace[784904402] 'agreement among raft nodes before linearized reading' (duration: 506.340587ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.055512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:15.546874Z","time spent":"508.630898ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T07:28:16.055518Z","caller":"traceutil/trace.go:171","msg":"trace[722210444] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:817; }","duration":"661.8305ms","start":"2026-08-11T07:28:15.393675Z","end":"2026-08-11T07:28:16.055505Z","steps":["trace[722210444] 'agreement among raft nodes before linearized reading' (duration: 661.768139ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.055527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:15.549031Z","time spent":"506.488272ms","remote":"127.0.0.1:58078","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-08-11T07:28:16.05555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:15.393647Z","time spent":"661.895062ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":40,"response count":7,"response size":30,"request content":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:28:16.056193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.155374ms","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-08-11T07:28:16.056281Z","caller":"traceutil/trace.go:171","msg":"trace[367249772] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:817; }","duration":"503.272777ms","start":"2026-08-11T07:28:15.552985Z","end":"2026-08-11T07:28:16.056258Z","steps":["trace[367249772] 'agreement among raft nodes before linearized reading' (duration: 502.509807ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.056377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:15.552977Z","time spent":"503.38865ms","remote":"127.0.0.1:58078","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":"info","ts":"2026-08-11T07:28:16.06224Z","caller":"traceutil/trace.go:171","msg":"trace[92975294] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"1.296477205s","start":"2026-08-11T07:28:14.758515Z","end":"2026-08-11T07:28:16.054992Z","steps":["trace[92975294] 'process raft request' (duration: 1.296253238s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:16.062851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:14.758492Z","time spent":"1.303850189s","remote":"127.0.0.1:58052","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:22.288675Z","caller":"traceutil/trace.go:171","msg":"trace[845601940] linearizableReadLoop","detail":"{readStateIndex:918; appliedIndex:917; }","duration":"100.797403ms","start":"2026-08-11T07:28:22.187851Z","end":"2026-08-11T07:28:22.288648Z","steps":["trace[845601940] 'read index received' (duration: 36.249434ms)","trace[845601940] 'applied index is now lower than readState.Index' (duration: 64.546719ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:22.288851Z","caller":"traceutil/trace.go:171","msg":"trace[1398712840] transaction","detail":"{read_only:false; response_revision:885; number_of_response:1; }","duration":"156.862069ms","start":"2026-08-11T07:28:22.131924Z","end":"2026-08-11T07:28:22.288786Z","steps":["trace[1398712840] 'process raft request' (duration: 92.152876ms)","trace[1398712840] 'compare' (duration: 64.434416ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:22.288987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.117822ms","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-08-11T07:28:22.289774Z","caller":"traceutil/trace.go:171","msg":"trace[929304047] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:885; }","duration":"101.929212ms","start":"2026-08-11T07:28:22.187792Z","end":"2026-08-11T07:28:22.289722Z","steps":["trace[929304047] 'agreement among raft nodes before linearized reading' (duration: 101.018449ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:41.637838Z","caller":"traceutil/trace.go:171","msg":"trace[297284522] linearizableReadLoop","detail":"{readStateIndex:1034; appliedIndex:1033; }","duration":"317.538249ms","start":"2026-08-11T07:28:41.320277Z","end":"2026-08-11T07:28:41.637816Z","steps":["trace[297284522] 'read index received' (duration: 317.413836ms)","trace[297284522] 'applied index is now lower than readState.Index' (duration: 123.123µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:28:41.637984Z","caller":"traceutil/trace.go:171","msg":"trace[871591802] transaction","detail":"{read_only:false; response_revision:997; number_of_response:1; }","duration":"345.456252ms","start":"2026-08-11T07:28:41.292483Z","end":"2026-08-11T07:28:41.637939Z","steps":["trace[871591802] 'process raft request' (duration: 345.188395ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:41.638211Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:41.292453Z","time spent":"345.641197ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:41.638205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.875077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:41.638367Z","caller":"traceutil/trace.go:171","msg":"trace[565942664] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:997; }","duration":"318.125814ms","start":"2026-08-11T07:28:41.320207Z","end":"2026-08-11T07:28:41.638332Z","steps":["trace[565942664] 'agreement among raft nodes before linearized reading' (duration: 317.833756ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:41.638439Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:41.320174Z","time spent":"318.253207ms","remote":"127.0.0.1:57818","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-08-11T07:28:43.065565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.88141ms","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-08-11T07:28:43.065715Z","caller":"traceutil/trace.go:171","msg":"trace[1076364107] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:997; }","duration":"668.052854ms","start":"2026-08-11T07:28:42.397631Z","end":"2026-08-11T07:28:43.065684Z","steps":["trace[1076364107] 'range keys from in-memory index tree' (duration: 667.859708ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.065731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.321858ms","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-08-11T07:28:43.06582Z","caller":"traceutil/trace.go:171","msg":"trace[1933238621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:997; }","duration":"666.470953ms","start":"2026-08-11T07:28:42.399328Z","end":"2026-08-11T07:28:43.065799Z","steps":["trace[1933238621] 'range keys from in-memory index tree' (duration: 666.045721ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.065876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:42.399302Z","time spent":"666.563815ms","remote":"127.0.0.1:58078","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-08-11T07:28:43.06615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"628.112553ms","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-08-11T07:28:43.066198Z","caller":"traceutil/trace.go:171","msg":"trace[1199892330] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:997; }","duration":"628.179075ms","start":"2026-08-11T07:28:42.438007Z","end":"2026-08-11T07:28:43.066186Z","steps":["trace[1199892330] 'range keys from in-memory index tree' (duration: 628.008401ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.066227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:42.437995Z","time spent":"628.226166ms","remote":"127.0.0.1:58078","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-08-11T07:28:43.066776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.693732ms","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-08-11T07:28:43.066814Z","caller":"traceutil/trace.go:171","msg":"trace[1896531355] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:997; }","duration":"597.793485ms","start":"2026-08-11T07:28:42.46901Z","end":"2026-08-11T07:28:43.066804Z","steps":["trace[1896531355] 'count revisions from in-memory index tree' (duration: 597.572789ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.066846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:42.468982Z","time spent":"597.854567ms","remote":"127.0.0.1:58138","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:28:43.067221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.02562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-11T07:28:43.067295Z","caller":"traceutil/trace.go:171","msg":"trace[317686673] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:997; }","duration":"791.158864ms","start":"2026-08-11T07:28:42.276115Z","end":"2026-08-11T07:28:43.067274Z","steps":["trace[317686673] 'range keys from in-memory index tree' (duration: 790.737963ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.067323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:42.276085Z","time spent":"791.232097ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T07:28:43.067646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"791.359249ms","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-08-11T07:28:43.067671Z","caller":"traceutil/trace.go:171","msg":"trace[978387616] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:997; }","duration":"791.423521ms","start":"2026-08-11T07:28:42.276242Z","end":"2026-08-11T07:28:43.067665Z","steps":["trace[978387616] 'range keys from in-memory index tree' (duration: 791.184545ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.067687Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:42.276212Z","time spent":"791.470442ms","remote":"127.0.0.1:58078","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-08-11T07:28:43.067665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"836.19384ms","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-08-11T07:28:43.067743Z","caller":"traceutil/trace.go:171","msg":"trace[2143813218] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:997; }","duration":"836.328573ms","start":"2026-08-11T07:28:42.231393Z","end":"2026-08-11T07:28:43.067721Z","steps":["trace[2143813218] 'range keys from in-memory index tree' (duration: 836.042585ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.067784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:42.231369Z","time spent":"836.406025ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T07:28:43.506898Z","caller":"traceutil/trace.go:171","msg":"trace[356048283] transaction","detail":"{read_only:false; response_revision:1000; number_of_response:1; }","duration":"434.786394ms","start":"2026-08-11T07:28:43.072077Z","end":"2026-08-11T07:28:43.506864Z","steps":["trace[356048283] 'process raft request' (duration: 434.670901ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:43.506984Z","caller":"traceutil/trace.go:171","msg":"trace[270422487] linearizableReadLoop","detail":"{readStateIndex:1040; appliedIndex:1035; }","duration":"221.467139ms","start":"2026-08-11T07:28:43.285489Z","end":"2026-08-11T07:28:43.506956Z","steps":["trace[270422487] 'read index received' (duration: 220.919245ms)","trace[270422487] 'applied index is now lower than readState.Index' (duration: 546.324µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:28:43.507097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:43.072071Z","time spent":"434.911117ms","remote":"127.0.0.1:58078","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-08-11T07:28:43.507075Z","caller":"traceutil/trace.go:171","msg":"trace[1802981377] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"432.7579ms","start":"2026-08-11T07:28:43.074296Z","end":"2026-08-11T07:28:43.507053Z","steps":["trace[1802981377] 'process raft request' (duration: 432.562245ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:43.507135Z","caller":"traceutil/trace.go:171","msg":"trace[1050422924] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"432.781851ms","start":"2026-08-11T07:28:43.074336Z","end":"2026-08-11T07:28:43.507118Z","steps":["trace[1050422924] 'process raft request' (duration: 432.566915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.507226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:43.074332Z","time spent":"432.834792ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:43.507255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:43.074289Z","time spent":"432.877683ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:43.506952Z","caller":"traceutil/trace.go:171","msg":"trace[247670128] transaction","detail":"{read_only:false; response_revision:999; number_of_response:1; }","duration":"435.130043ms","start":"2026-08-11T07:28:43.071775Z","end":"2026-08-11T07:28:43.506905Z","steps":["trace[247670128] 'process raft request' (duration: 434.795134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.507344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.819398ms","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-08-11T07:28:43.507407Z","caller":"traceutil/trace.go:171","msg":"trace[1246631952] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:1003; }","duration":"221.951512ms","start":"2026-08-11T07:28:43.285442Z","end":"2026-08-11T07:28:43.507394Z","steps":["trace[1246631952] 'agreement among raft nodes before linearized reading' (duration: 221.821028ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.507432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:43.071758Z","time spent":"435.624645ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:28:43.507439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.701264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:28:43.507553Z","caller":"traceutil/trace.go:171","msg":"trace[1483241070] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1003; }","duration":"186.868638ms","start":"2026-08-11T07:28:43.320656Z","end":"2026-08-11T07:28:43.507524Z","steps":["trace[1483241070] 'agreement among raft nodes before linearized reading' (duration: 186.687193ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:28:43.506984Z","caller":"traceutil/trace.go:171","msg":"trace[1880935279] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"434.833725ms","start":"2026-08-11T07:28:43.072125Z","end":"2026-08-11T07:28:43.506959Z","steps":["trace[1880935279] 'process raft request' (duration: 434.679541ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:28:43.508271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:28:43.07212Z","time spent":"436.050177ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:28:51.722653Z","caller":"traceutil/trace.go:171","msg":"trace[682767761] transaction","detail":"{read_only:false; response_revision:1034; number_of_response:1; }","duration":"110.794107ms","start":"2026-08-11T07:28:51.611825Z","end":"2026-08-11T07:28:51.722619Z","steps":["trace[682767761] 'process raft request' (duration: 64.076397ms)","trace[682767761] 'compare' (duration: 46.494134ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:05.967324Z","caller":"traceutil/trace.go:171","msg":"trace[1484008097] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"177.465007ms","start":"2026-08-11T07:29:05.789822Z","end":"2026-08-11T07:29:05.967287Z","steps":["trace[1484008097] 'process raft request' (duration: 177.236631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:07.406645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.046774323s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T07:29:07.40674Z","caller":"traceutil/trace.go:171","msg":"trace[219746965] linearizableReadLoop","detail":"{readStateIndex:1122; appliedIndex:1121; }","duration":"299.67945ms","start":"2026-08-11T07:29:07.107043Z","end":"2026-08-11T07:29:07.406723Z","steps":["trace[219746965] 'read index received' (duration: 74.362µs)","trace[219746965] 'applied index is now lower than readState.Index' (duration: 299.603528ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:29:07.406962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.920847ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:29:07.406993Z","caller":"traceutil/trace.go:171","msg":"trace[816967543] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1080; }","duration":"300.01637ms","start":"2026-08-11T07:29:07.106968Z","end":"2026-08-11T07:29:07.406984Z","steps":["trace[816967543] 'agreement among raft nodes before linearized reading' (duration: 299.933956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:07.407019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:07.106921Z","time spent":"300.090952ms","remote":"127.0.0.1:57926","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":30,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-08-11T07:29:07.469515Z","caller":"traceutil/trace.go:171","msg":"trace[1396450531] transaction","detail":"{read_only:false; response_revision:1081; number_of_response:1; }","duration":"199.356659ms","start":"2026-08-11T07:29:07.270125Z","end":"2026-08-11T07:29:07.469482Z","steps":["trace[1396450531] 'process raft request' (duration: 199.136113ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:07.470392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.685966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:07.470521Z","caller":"traceutil/trace.go:171","msg":"trace[891694477] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1082; }","duration":"152.84508ms","start":"2026-08-11T07:29:07.317621Z","end":"2026-08-11T07:29:07.470466Z","steps":["trace[891694477] 'agreement among raft nodes before linearized reading' (duration: 152.670695ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:07.470601Z","caller":"traceutil/trace.go:171","msg":"trace[1710757666] transaction","detail":"{read_only:false; response_revision:1082; number_of_response:1; }","duration":"164.318465ms","start":"2026-08-11T07:29:07.306234Z","end":"2026-08-11T07:29:07.470552Z","steps":["trace[1710757666] 'process raft request' (duration: 163.810402ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:07.774269Z","caller":"traceutil/trace.go:171","msg":"trace[562181630] transaction","detail":"{read_only:false; response_revision:1083; number_of_response:1; }","duration":"138.029867ms","start":"2026-08-11T07:29:07.636207Z","end":"2026-08-11T07:29:07.774237Z","steps":["trace[562181630] 'process raft request' (duration: 137.841682ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:08.023702Z","caller":"traceutil/trace.go:171","msg":"trace[125271148] transaction","detail":"{read_only:false; response_revision:1085; number_of_response:1; }","duration":"242.730164ms","start":"2026-08-11T07:29:07.780955Z","end":"2026-08-11T07:29:08.023685Z","steps":["trace[125271148] 'process raft request' (duration: 242.58993ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:08.024133Z","caller":"traceutil/trace.go:171","msg":"trace[1809225820] transaction","detail":"{read_only:false; response_revision:1086; number_of_response:1; }","duration":"243.084273ms","start":"2026-08-11T07:29:07.781031Z","end":"2026-08-11T07:29:08.024115Z","steps":["trace[1809225820] 'process raft request' (duration: 242.615571ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.269005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.159154396s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:29:10.269495Z","caller":"traceutil/trace.go:171","msg":"trace[1328708404] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"2.240018038s","start":"2026-08-11T07:29:08.029423Z","end":"2026-08-11T07:29:10.269441Z","steps":["trace[1328708404] 'process raft request' (duration: 80.298447ms)","trace[1328708404] 'compare' (duration: 2.158504669s)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:10.26966Z","caller":"traceutil/trace.go:171","msg":"trace[1973616773] linearizableReadLoop","detail":"{readStateIndex:1129; appliedIndex:1128; }","duration":"1.923238773s","start":"2026-08-11T07:29:08.3464Z","end":"2026-08-11T07:29:10.269639Z","steps":["trace[1973616773] 'read index received' (duration: 36.181µs)","trace[1973616773] 'applied index is now lower than readState.Index' (duration: 1.923200262s)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:10.269845Z","caller":"traceutil/trace.go:171","msg":"trace[2121453847] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"785.881847ms","start":"2026-08-11T07:29:09.483946Z","end":"2026-08-11T07:29:10.269828Z","steps":["trace[2121453847] 'process raft request' (duration: 785.213929ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.269851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:08.029406Z","time spent":"2.240173652s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:29:10.269906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.304307122s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:10.269962Z","caller":"traceutil/trace.go:171","msg":"trace[1627549984] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1088; }","duration":"1.304414435s","start":"2026-08-11T07:29:08.965533Z","end":"2026-08-11T07:29:10.269947Z","steps":["trace[1627549984] 'agreement among raft nodes before linearized reading' (duration: 1.304355483s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.270015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:08.965495Z","time spent":"1.304492867s","remote":"127.0.0.1:42418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:29:10.270127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"392.157293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:29:10.270203Z","caller":"traceutil/trace.go:171","msg":"trace[1828287328] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:1088; }","duration":"392.278396ms","start":"2026-08-11T07:29:09.877906Z","end":"2026-08-11T07:29:10.270184Z","steps":["trace[1828287328] 'agreement among raft nodes before linearized reading' (duration: 392.141353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.270252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:09.877881Z","time spent":"392.360718ms","remote":"127.0.0.1:58070","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:29:10.270357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.034617ms","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-08-11T07:29:10.270373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.363148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:29:10.270413Z","caller":"traceutil/trace.go:171","msg":"trace[709868308] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1088; }","duration":"393.108429ms","start":"2026-08-11T07:29:09.877276Z","end":"2026-08-11T07:29:10.270384Z","steps":["trace[709868308] 'agreement among raft nodes before linearized reading' (duration: 392.948964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.270444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:09.877252Z","time spent":"393.185591ms","remote":"127.0.0.1:58078","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-08-11T07:29:10.270518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.879228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:29:10.270555Z","caller":"traceutil/trace.go:171","msg":"trace[700806985] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1088; }","duration":"242.976541ms","start":"2026-08-11T07:29:10.02757Z","end":"2026-08-11T07:29:10.270547Z","steps":["trace[700806985] 'agreement among raft nodes before linearized reading' (duration: 242.803406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.269947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:09.483922Z","time spent":"785.980629ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:29:10.269857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.923451328s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:10.270711Z","caller":"traceutil/trace.go:171","msg":"trace[300462682] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1088; }","duration":"1.924333483s","start":"2026-08-11T07:29:08.346369Z","end":"2026-08-11T07:29:10.270703Z","steps":["trace[300462682] 'agreement among raft nodes before linearized reading' (duration: 1.923421528s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.270743Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:08.346351Z","time spent":"1.924384694s","remote":"127.0.0.1:57818","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-08-11T07:29:10.270837Z","caller":"traceutil/trace.go:171","msg":"trace[1569956961] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1088; }","duration":"241.44191ms","start":"2026-08-11T07:29:10.02896Z","end":"2026-08-11T07:29:10.270402Z","steps":["trace[1569956961] 'agreement among raft nodes before linearized reading' (duration: 241.325167ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.271027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.347037ms","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":"warn","ts":"2026-08-11T07:29:10.271034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"490.81654ms","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-08-11T07:29:10.271084Z","caller":"traceutil/trace.go:171","msg":"trace[877127840] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1088; }","duration":"490.908932ms","start":"2026-08-11T07:29:09.780161Z","end":"2026-08-11T07:29:10.27107Z","steps":["trace[877127840] 'agreement among raft nodes before linearized reading' (duration: 490.713817ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.271175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:09.780143Z","time spent":"491.019965ms","remote":"127.0.0.1:58078","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-08-11T07:29:10.270894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.118959777s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-11T07:29:10.271077Z","caller":"traceutil/trace.go:171","msg":"trace[799601853] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:1088; }","duration":"609.438669ms","start":"2026-08-11T07:29:09.661625Z","end":"2026-08-11T07:29:10.271064Z","steps":["trace[799601853] 'agreement among raft nodes before linearized reading' (duration: 609.350497ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:10.27137Z","caller":"traceutil/trace.go:171","msg":"trace[2004935094] range","detail":"{range_begin:/registry/csinodes/; range_end:/registry/csinodes0; response_count:0; response_revision:1088; }","duration":"1.11946831s","start":"2026-08-11T07:29:09.151883Z","end":"2026-08-11T07:29:10.271352Z","steps":["trace[2004935094] 'agreement among raft nodes before linearized reading' (duration: 1.118679329s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.271437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:09.151864Z","time spent":"1.119554423s","remote":"127.0.0.1:58218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":30,"request content":"key:\"/registry/csinodes/\" range_end:\"/registry/csinodes0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:29:10.27139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:09.661599Z","time spent":"609.772108ms","remote":"127.0.0.1:58296","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-08-11T07:29:10.492722Z","caller":"traceutil/trace.go:171","msg":"trace[322897091] transaction","detail":"{read_only:false; response_revision:1090; number_of_response:1; }","duration":"215.621072ms","start":"2026-08-11T07:29:10.277057Z","end":"2026-08-11T07:29:10.492678Z","steps":["trace[322897091] 'process raft request' (duration: 199.938153ms)","trace[322897091] 'compare' (duration: 14.691832ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:10.493513Z","caller":"traceutil/trace.go:171","msg":"trace[595766590] linearizableReadLoop","detail":"{readStateIndex:1134; appliedIndex:1131; }","duration":"214.099131ms","start":"2026-08-11T07:29:10.279388Z","end":"2026-08-11T07:29:10.493487Z","steps":["trace[595766590] 'read index received' (duration: 46.980711ms)","trace[595766590] 'applied index is now lower than readState.Index' (duration: 167.11725ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:10.493633Z","caller":"traceutil/trace.go:171","msg":"trace[1777897204] transaction","detail":"{read_only:false; response_revision:1091; number_of_response:1; }","duration":"216.600217ms","start":"2026-08-11T07:29:10.27702Z","end":"2026-08-11T07:29:10.49362Z","steps":["trace[1777897204] 'process raft request' (duration: 215.426606ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:10.493743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.270575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:10.493842Z","caller":"traceutil/trace.go:171","msg":"trace[620678383] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1092; }","duration":"214.461621ms","start":"2026-08-11T07:29:10.279361Z","end":"2026-08-11T07:29:10.493823Z","steps":["trace[620678383] 'agreement among raft nodes before linearized reading' (duration: 214.239145ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:10.494003Z","caller":"traceutil/trace.go:171","msg":"trace[539068173] transaction","detail":"{read_only:false; response_revision:1092; number_of_response:1; }","duration":"216.897255ms","start":"2026-08-11T07:29:10.277093Z","end":"2026-08-11T07:29:10.49399Z","steps":["trace[539068173] 'process raft request' (duration: 216.31722ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:11.083682Z","caller":"traceutil/trace.go:171","msg":"trace[2076880762] transaction","detail":"{read_only:false; response_revision:1093; number_of_response:1; }","duration":"159.121207ms","start":"2026-08-11T07:29:10.924525Z","end":"2026-08-11T07:29:11.083646Z","steps":["trace[2076880762] 'process raft request' (duration: 79.896728ms)","trace[2076880762] 'compare' (duration: 76.760203ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:12.381541Z","caller":"traceutil/trace.go:171","msg":"trace[512711781] transaction","detail":"{read_only:false; response_revision:1094; number_of_response:1; }","duration":"102.704664ms","start":"2026-08-11T07:29:12.278805Z","end":"2026-08-11T07:29:12.381509Z","steps":["trace[512711781] 'process raft request' (duration: 102.494199ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:12.805865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.85721ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:29:12.806117Z","caller":"traceutil/trace.go:171","msg":"trace[697357484] transaction","detail":"{read_only:false; response_revision:1096; number_of_response:1; }","duration":"390.091907ms","start":"2026-08-11T07:29:12.416004Z","end":"2026-08-11T07:29:12.806096Z","steps":["trace[697357484] 'process raft request' (duration: 390.021186ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:12.806191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:12.415978Z","time spent":"390.17706ms","remote":"127.0.0.1:58078","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-08-11T07:29:12.806381Z","caller":"traceutil/trace.go:171","msg":"trace[852194805] linearizableReadLoop","detail":"{readStateIndex:1138; appliedIndex:1137; }","duration":"473.639692ms","start":"2026-08-11T07:29:12.332676Z","end":"2026-08-11T07:29:12.806316Z","steps":["trace[852194805] 'read index received' (duration: 49.156669ms)","trace[852194805] 'applied index is now lower than readState.Index' (duration: 424.478983ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:12.80657Z","caller":"traceutil/trace.go:171","msg":"trace[561609221] transaction","detail":"{read_only:false; response_revision:1095; number_of_response:1; }","duration":"525.491624ms","start":"2026-08-11T07:29:12.280963Z","end":"2026-08-11T07:29:12.806455Z","steps":["trace[561609221] 'process raft request' (duration: 243.923876ms)","trace[561609221] 'compare' (duration: 280.680665ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:29:12.806708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"474.003112ms","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-08-11T07:29:12.806769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.279019ms","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-08-11T07:29:12.806762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:12.280947Z","time spent":"525.715689ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:29:12.806798Z","caller":"traceutil/trace.go:171","msg":"trace[1472674921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1096; }","duration":"474.160465ms","start":"2026-08-11T07:29:12.332619Z","end":"2026-08-11T07:29:12.80678Z","steps":["trace[1472674921] 'agreement among raft nodes before linearized reading' (duration: 473.894048ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:12.806815Z","caller":"traceutil/trace.go:171","msg":"trace[973306986] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1096; }","duration":"308.386102ms","start":"2026-08-11T07:29:12.498415Z","end":"2026-08-11T07:29:12.806801Z","steps":["trace[973306986] 'agreement among raft nodes before linearized reading' (duration: 308.162326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:12.80684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:12.332596Z","time spent":"474.237438ms","remote":"127.0.0.1:58078","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-08-11T07:29:12.806858Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:12.498384Z","time spent":"308.462804ms","remote":"127.0.0.1:58078","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-08-11T07:29:12.806841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.501421ms","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-08-11T07:29:12.806928Z","caller":"traceutil/trace.go:171","msg":"trace[1244615493] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1096; }","duration":"306.614014ms","start":"2026-08-11T07:29:12.500293Z","end":"2026-08-11T07:29:12.806907Z","steps":["trace[1244615493] 'agreement among raft nodes before linearized reading' (duration: 306.380468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:12.806975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:12.500284Z","time spent":"306.683846ms","remote":"127.0.0.1:58078","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-08-11T07:29:12.80757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.689126ms","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-08-11T07:29:12.807641Z","caller":"traceutil/trace.go:171","msg":"trace[124895668] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1096; }","duration":"306.80861ms","start":"2026-08-11T07:29:12.500818Z","end":"2026-08-11T07:29:12.807627Z","steps":["trace[124895668] 'agreement among raft nodes before linearized reading' (duration: 305.795643ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:12.80768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:12.500793Z","time spent":"306.873831ms","remote":"127.0.0.1:58078","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-08-11T07:29:13.062605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.46348ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:29:13.062793Z","caller":"traceutil/trace.go:171","msg":"trace[913481260] transaction","detail":"{read_only:false; response_revision:1098; number_of_response:1; }","duration":"248.159948ms","start":"2026-08-11T07:29:12.814617Z","end":"2026-08-11T07:29:13.062777Z","steps":["trace[913481260] 'process raft request' (duration: 248.090146ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:13.062833Z","caller":"traceutil/trace.go:171","msg":"trace[618000445] transaction","detail":"{read_only:false; response_revision:1097; number_of_response:1; }","duration":"248.220619ms","start":"2026-08-11T07:29:12.81457Z","end":"2026-08-11T07:29:13.062791Z","steps":["trace[618000445] 'process raft request' (duration: 98.482112ms)","trace[618000445] 'compare' (duration: 149.300136ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:13.063151Z","caller":"traceutil/trace.go:171","msg":"trace[1163639653] transaction","detail":"{read_only:false; response_revision:1099; number_of_response:1; }","duration":"248.20083ms","start":"2026-08-11T07:29:12.814908Z","end":"2026-08-11T07:29:13.063109Z","steps":["trace[1163639653] 'process raft request' (duration: 247.838639ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:13.063446Z","caller":"traceutil/trace.go:171","msg":"trace[1212696516] transaction","detail":"{read_only:false; response_revision:1100; number_of_response:1; }","duration":"248.276452ms","start":"2026-08-11T07:29:12.815103Z","end":"2026-08-11T07:29:13.06338Z","steps":["trace[1212696516] 'process raft request' (duration: 248.100207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:25.32407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.388883ms","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-08-11T07:29:25.324108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.232819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-08-11T07:29:25.324185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.387603ms","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-08-11T07:29:25.32422Z","caller":"traceutil/trace.go:171","msg":"trace[1671512866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1136; }","duration":"109.424604ms","start":"2026-08-11T07:29:25.214786Z","end":"2026-08-11T07:29:25.324211Z","steps":["trace[1671512866] 'range keys from in-memory index tree' (duration: 108.855599ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:25.324227Z","caller":"traceutil/trace.go:171","msg":"trace[552207188] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1136; }","duration":"109.387013ms","start":"2026-08-11T07:29:25.214815Z","end":"2026-08-11T07:29:25.324202Z","steps":["trace[552207188] 'range keys from in-memory index tree' (duration: 108.928361ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:25.324162Z","caller":"traceutil/trace.go:171","msg":"trace[1538925635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1136; }","duration":"109.536027ms","start":"2026-08-11T07:29:25.214604Z","end":"2026-08-11T07:29:25.32414Z","steps":["trace[1538925635] 'range keys from in-memory index tree' (duration: 109.183817ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:25.615005Z","caller":"traceutil/trace.go:171","msg":"trace[882734031] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"285.280937ms","start":"2026-08-11T07:29:25.329694Z","end":"2026-08-11T07:29:25.614974Z","steps":["trace[882734031] 'process raft request' (duration: 285.182515ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:25.61509Z","caller":"traceutil/trace.go:171","msg":"trace[270914908] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"285.648367ms","start":"2026-08-11T07:29:25.329413Z","end":"2026-08-11T07:29:25.615061Z","steps":["trace[270914908] 'process raft request' (duration: 208.477872ms)","trace[270914908] 'compare' (duration: 76.775254ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:33.315153Z","caller":"traceutil/trace.go:171","msg":"trace[316183022] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"132.95141ms","start":"2026-08-11T07:29:33.182179Z","end":"2026-08-11T07:29:33.315131Z","steps":["trace[316183022] 'process raft request' (duration: 132.823517ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:33.315631Z","caller":"traceutil/trace.go:171","msg":"trace[497932966] linearizableReadLoop","detail":"{readStateIndex:1263; appliedIndex:1263; }","duration":"113.854702ms","start":"2026-08-11T07:29:33.201769Z","end":"2026-08-11T07:29:33.315623Z","steps":["trace[497932966] 'read index received' (duration: 113.852062ms)","trace[497932966] 'applied index is now lower than readState.Index' (duration: 2.28µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:29:33.31572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.949034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-11T07:29:33.315741Z","caller":"traceutil/trace.go:171","msg":"trace[1067929381] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1214; }","duration":"114.024206ms","start":"2026-08-11T07:29:33.201711Z","end":"2026-08-11T07:29:33.315735Z","steps":["trace[1067929381] 'agreement among raft nodes before linearized reading' (duration: 113.940404ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:37.405677Z","caller":"traceutil/trace.go:171","msg":"trace[1909926502] linearizableReadLoop","detail":"{readStateIndex:1275; appliedIndex:1274; }","duration":"399.769366ms","start":"2026-08-11T07:29:37.005883Z","end":"2026-08-11T07:29:37.405653Z","steps":["trace[1909926502] 'read index received' (duration: 399.570341ms)","trace[1909926502] 'applied index is now lower than readState.Index' (duration: 198.305µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:37.405765Z","caller":"traceutil/trace.go:171","msg":"trace[1277043657] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"811.808828ms","start":"2026-08-11T07:29:36.593949Z","end":"2026-08-11T07:29:37.405758Z","steps":["trace[1277043657] 'process raft request' (duration: 811.570851ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:37.405852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:36.593912Z","time spent":"811.878509ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:29:37.405932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.73513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:37.406001Z","caller":"traceutil/trace.go:171","msg":"trace[1714596104] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1225; }","duration":"252.791111ms","start":"2026-08-11T07:29:37.153175Z","end":"2026-08-11T07:29:37.405966Z","steps":["trace[1714596104] 'agreement among raft nodes before linearized reading' (duration: 252.677508ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:37.406104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"400.211877ms","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-08-11T07:29:37.406184Z","caller":"traceutil/trace.go:171","msg":"trace[2063323043] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1225; }","duration":"400.34352ms","start":"2026-08-11T07:29:37.005822Z","end":"2026-08-11T07:29:37.406166Z","steps":["trace[2063323043] 'agreement among raft nodes before linearized reading' (duration: 400.134355ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:37.406216Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:37.0058Z","time spent":"400.410663ms","remote":"127.0.0.1:58078","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-08-11T07:29:38.236249Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447816020,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:29:38.736746Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447816020,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:29:39.238041Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447816020,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:29:39.522369Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.11200483s","expected-duration":"1s"} {"level":"info","ts":"2026-08-11T07:29:39.523407Z","caller":"traceutil/trace.go:171","msg":"trace[2128924824] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"2.113105548s","start":"2026-08-11T07:29:37.410275Z","end":"2026-08-11T07:29:39.52338Z","steps":["trace[2128924824] 'process raft request' (duration: 2.112636286s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.523865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:37.410243Z","time spent":"2.113322694s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:29:39.524884Z","caller":"traceutil/trace.go:171","msg":"trace[1102045963] transaction","detail":"{read_only:false; response_revision:1227; number_of_response:1; }","duration":"2.114562327s","start":"2026-08-11T07:29:37.410295Z","end":"2026-08-11T07:29:39.524858Z","steps":["trace[1102045963] 'process raft request' (duration: 2.114228707s)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:39.524991Z","caller":"traceutil/trace.go:171","msg":"trace[893772589] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"2.113210912s","start":"2026-08-11T07:29:37.41177Z","end":"2026-08-11T07:29:39.524981Z","steps":["trace[893772589] 'process raft request' (duration: 2.113038858s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.525053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:37.411755Z","time spent":"2.113269263s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:29:39.525116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:37.410239Z","time spent":"2.114720202s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:29:39.525175Z","caller":"traceutil/trace.go:171","msg":"trace[1508270181] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"1.349548266s","start":"2026-08-11T07:29:38.175613Z","end":"2026-08-11T07:29:39.525161Z","steps":["trace[1508270181] 'process raft request' (duration: 1.34932109s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.5253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:38.175576Z","time spent":"1.349638588s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:29:39.525324Z","caller":"traceutil/trace.go:171","msg":"trace[153611839] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1275; }","duration":"1.789709467s","start":"2026-08-11T07:29:37.735606Z","end":"2026-08-11T07:29:39.525315Z","steps":["trace[153611839] 'read index received' (duration: 1.787428326s)","trace[153611839] 'applied index is now lower than readState.Index' (duration: 2.280691ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:29:39.525539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.789927763s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:29:39.525582Z","caller":"traceutil/trace.go:171","msg":"trace[449581506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1230; }","duration":"1.789999635s","start":"2026-08-11T07:29:37.73557Z","end":"2026-08-11T07:29:39.52557Z","steps":["trace[449581506] 'agreement among raft nodes before linearized reading' (duration: 1.78981711s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.525613Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:37.735552Z","time spent":"1.790053556s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:29:39.525742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.205555282s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:39.525819Z","caller":"traceutil/trace.go:171","msg":"trace[418512152] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1230; }","duration":"1.205689046s","start":"2026-08-11T07:29:38.320118Z","end":"2026-08-11T07:29:39.525807Z","steps":["trace[418512152] 'agreement among raft nodes before linearized reading' (duration: 1.205591723s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.525872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.374607084s","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-08-11T07:29:39.525881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:38.320091Z","time spent":"1.205773418s","remote":"127.0.0.1:57818","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-08-11T07:29:39.52596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.33691556s","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":"info","ts":"2026-08-11T07:29:39.525993Z","caller":"traceutil/trace.go:171","msg":"trace[1920176763] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1230; }","duration":"1.336984712s","start":"2026-08-11T07:29:38.188999Z","end":"2026-08-11T07:29:39.525983Z","steps":["trace[1920176763] 'agreement among raft nodes before linearized reading' (duration: 1.33693933s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.526021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:38.188981Z","time spent":"1.337031192s","remote":"127.0.0.1:59766","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-08-11T07:29:39.526103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.787932399s","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-08-11T07:29:39.526177Z","caller":"traceutil/trace.go:171","msg":"trace[1880661472] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1230; }","duration":"1.788640948s","start":"2026-08-11T07:29:37.737524Z","end":"2026-08-11T07:29:39.526165Z","steps":["trace[1880661472] 'agreement among raft nodes before linearized reading' (duration: 1.787871468s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.526228Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:37.737495Z","time spent":"1.78870177s","remote":"127.0.0.1:58078","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-08-11T07:29:39.526243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.618380745s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:39.526287Z","caller":"traceutil/trace.go:171","msg":"trace[951460388] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1230; }","duration":"1.618470997s","start":"2026-08-11T07:29:37.907806Z","end":"2026-08-11T07:29:39.526277Z","steps":["trace[951460388] 'agreement among raft nodes before linearized reading' (duration: 1.618412786s)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:39.525761Z","caller":"traceutil/trace.go:171","msg":"trace[1424410802] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"113.127872ms","start":"2026-08-11T07:29:39.412621Z","end":"2026-08-11T07:29:39.525749Z","steps":["trace[1424410802] 'process raft request' (duration: 112.492096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.526367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.397406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:39.52641Z","caller":"traceutil/trace.go:171","msg":"trace[416376788] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:1230; }","duration":"114.492059ms","start":"2026-08-11T07:29:39.411908Z","end":"2026-08-11T07:29:39.5264Z","steps":["trace[416376788] 'agreement among raft nodes before linearized reading' (duration: 114.421037ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:39.525921Z","caller":"traceutil/trace.go:171","msg":"trace[1105505883] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1230; }","duration":"1.374710977s","start":"2026-08-11T07:29:38.151202Z","end":"2026-08-11T07:29:39.525913Z","steps":["trace[1105505883] 'agreement among raft nodes before linearized reading' (duration: 1.374640295s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:39.526513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:38.15117Z","time spent":"1.375301172s","remote":"127.0.0.1:59884","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-08-11T07:29:39.526309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:37.907772Z","time spent":"1.618530369s","remote":"127.0.0.1:59810","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true "} {"level":"info","ts":"2026-08-11T07:29:54.827067Z","caller":"traceutil/trace.go:171","msg":"trace[1564661208] transaction","detail":"{read_only:false; response_revision:1298; number_of_response:1; }","duration":"125.142273ms","start":"2026-08-11T07:29:54.701893Z","end":"2026-08-11T07:29:54.827035Z","steps":["trace[1564661208] 'process raft request' (duration: 124.948268ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:55.996711Z","caller":"traceutil/trace.go:171","msg":"trace[958294911] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"339.444689ms","start":"2026-08-11T07:29:55.657237Z","end":"2026-08-11T07:29:55.996682Z","steps":["trace[958294911] 'read index received' (duration: 339.421558ms)","trace[958294911] 'applied index is now lower than readState.Index' (duration: 22.101µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:29:55.996828Z","caller":"traceutil/trace.go:171","msg":"trace[653797003] transaction","detail":"{read_only:false; response_revision:1300; number_of_response:1; }","duration":"363.364795ms","start":"2026-08-11T07:29:55.63345Z","end":"2026-08-11T07:29:55.996814Z","steps":["trace[653797003] 'process raft request' (duration: 363.096938ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:55.996941Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:55.63343Z","time spent":"363.426446ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:29:55.997134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.903921ms","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-08-11T07:29:55.997171Z","caller":"traceutil/trace.go:171","msg":"trace[1942559412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1300; }","duration":"339.987644ms","start":"2026-08-11T07:29:55.657171Z","end":"2026-08-11T07:29:55.997158Z","steps":["trace[1942559412] 'agreement among raft nodes before linearized reading' (duration: 339.876791ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:55.997203Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:55.657143Z","time spent":"340.052435ms","remote":"127.0.0.1:58078","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-08-11T07:29:57.371329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.008799943s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-11T07:29:57.371566Z","caller":"traceutil/trace.go:171","msg":"trace[352491330] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"1.374740308s","start":"2026-08-11T07:29:55.996786Z","end":"2026-08-11T07:29:57.371527Z","steps":["trace[352491330] 'read index received' (duration: 365.677288ms)","trace[352491330] 'applied index is now lower than readState.Index' (duration: 1.00906203s)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:29:57.371703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.66923917s","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-08-11T07:29:57.371706Z","caller":"traceutil/trace.go:171","msg":"trace[830385237] transaction","detail":"{read_only:false; response_revision:1301; number_of_response:1; }","duration":"1.369651911s","start":"2026-08-11T07:29:56.002012Z","end":"2026-08-11T07:29:57.371664Z","steps":["trace[830385237] 'process raft request' (duration: 1.369428996s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.371842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.711559346s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:29:57.371867Z","caller":"traceutil/trace.go:171","msg":"trace[256813128] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1301; }","duration":"1.711637038s","start":"2026-08-11T07:29:55.660224Z","end":"2026-08-11T07:29:57.371861Z","steps":["trace[256813128] 'agreement among raft nodes before linearized reading' (duration: 1.711552205s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.371896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:55.660192Z","time spent":"1.711698249s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T07:29:57.371924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:56.00198Z","time spent":"1.369820946s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:29:57.371759Z","caller":"traceutil/trace.go:171","msg":"trace[293028722] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1301; }","duration":"1.669343912s","start":"2026-08-11T07:29:55.702379Z","end":"2026-08-11T07:29:57.371723Z","steps":["trace[293028722] 'agreement among raft nodes before linearized reading' (duration: 1.66926315s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.372259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:55.702345Z","time spent":"1.669887426s","remote":"127.0.0.1:59792","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:29:57.372309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.712047919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:29:57.372348Z","caller":"traceutil/trace.go:171","msg":"trace[687076030] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1301; }","duration":"1.712102s","start":"2026-08-11T07:29:55.660237Z","end":"2026-08-11T07:29:57.372339Z","steps":["trace[687076030] 'agreement among raft nodes before linearized reading' (duration: 1.712009318s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.37238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:55.660221Z","time spent":"1.712151632s","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:29:57.372553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.712353658s","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-08-11T07:29:57.372588Z","caller":"traceutil/trace.go:171","msg":"trace[1869613896] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1301; }","duration":"1.71243492s","start":"2026-08-11T07:29:55.660143Z","end":"2026-08-11T07:29:57.372578Z","steps":["trace[1869613896] 'agreement among raft nodes before linearized reading' (duration: 1.712346658s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.372617Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:55.660115Z","time spent":"1.712491841s","remote":"127.0.0.1:58078","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-08-11T07:29:57.372754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.207858894s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:57.372797Z","caller":"traceutil/trace.go:171","msg":"trace[1686852237] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:1301; }","duration":"1.207935966s","start":"2026-08-11T07:29:56.164849Z","end":"2026-08-11T07:29:57.372785Z","steps":["trace[1686852237] 'agreement among raft nodes before linearized reading' (duration: 1.207866994s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.37289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:56.164829Z","time spent":"1.208048089s","remote":"127.0.0.1:59844","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:29:57.372891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.712891522s","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-08-11T07:29:57.372955Z","caller":"traceutil/trace.go:171","msg":"trace[1486612538] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1301; }","duration":"1.712977284s","start":"2026-08-11T07:29:55.659961Z","end":"2026-08-11T07:29:57.372938Z","steps":["trace[1486612538] 'agreement among raft nodes before linearized reading' (duration: 1.712742938s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.37301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:55.65995Z","time spent":"1.713048477s","remote":"127.0.0.1:58078","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-08-11T07:29:57.373076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.715308ms","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-08-11T07:29:57.373113Z","caller":"traceutil/trace.go:171","msg":"trace[1876853200] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1301; }","duration":"638.777379ms","start":"2026-08-11T07:29:56.734326Z","end":"2026-08-11T07:29:57.373104Z","steps":["trace[1876853200] 'agreement among raft nodes before linearized reading' (duration: 638.720968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.373139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:56.734308Z","time spent":"638.823951ms","remote":"127.0.0.1:58126","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-08-11T07:29:57.373204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.052912777s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:57.373288Z","caller":"traceutil/trace.go:171","msg":"trace[291233894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1301; }","duration":"1.053041771s","start":"2026-08-11T07:29:56.320225Z","end":"2026-08-11T07:29:57.373267Z","steps":["trace[291233894] 'agreement among raft nodes before linearized reading' (duration: 1.052895017s)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:57.373325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:56.320188Z","time spent":"1.053131853s","remote":"127.0.0.1:57818","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-08-11T07:29:58.599412Z","caller":"traceutil/trace.go:171","msg":"trace[691475338] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"596.789001ms","start":"2026-08-11T07:29:58.002588Z","end":"2026-08-11T07:29:58.599377Z","steps":["trace[691475338] 'process raft request' (duration: 596.416761ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:58.599659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:58.002568Z","time spent":"596.963667ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:29:59.775388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.837418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-08-11T07:29:59.775468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.435167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:29:59.775454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.986211ms","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-08-11T07:29:59.775505Z","caller":"traceutil/trace.go:171","msg":"trace[1409233125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1313; }","duration":"455.474479ms","start":"2026-08-11T07:29:59.320023Z","end":"2026-08-11T07:29:59.775498Z","steps":["trace[1409233125] 'range keys from in-memory index tree' (duration: 455.368166ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:59.775479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.120020145s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T07:29:59.775531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.319968Z","time spent":"455.55674ms","remote":"127.0.0.1:57810","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-08-11T07:29:59.775537Z","caller":"traceutil/trace.go:171","msg":"trace[1663365269] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1313; }","duration":"299.129355ms","start":"2026-08-11T07:29:59.476389Z","end":"2026-08-11T07:29:59.775519Z","steps":["trace[1663365269] 'range keys from in-memory index tree' (duration: 298.800716ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:59.775547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.783623ms","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-08-11T07:29:59.775553Z","caller":"traceutil/trace.go:171","msg":"trace[845669071] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:1313; }","duration":"1.120131978s","start":"2026-08-11T07:29:58.655406Z","end":"2026-08-11T07:29:59.775538Z","steps":["trace[845669071] 'count revisions from in-memory index tree' (duration: 1.119932542s)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:59.775572Z","caller":"traceutil/trace.go:171","msg":"trace[381702898] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1313; }","duration":"397.859864ms","start":"2026-08-11T07:29:59.377706Z","end":"2026-08-11T07:29:59.775566Z","steps":["trace[381702898] 'range keys from in-memory index tree' (duration: 397.619609ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:59.775564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.837777ms","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":"warn","ts":"2026-08-11T07:29:59.77559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.377678Z","time spent":"397.907036ms","remote":"127.0.0.1:58078","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-08-11T07:29:59.775594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:58.655383Z","time spent":"1.12020129s","remote":"127.0.0.1:59910","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-08-11T07:29:59.775617Z","caller":"traceutil/trace.go:171","msg":"trace[603939549] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1313; }","duration":"298.933589ms","start":"2026-08-11T07:29:59.476668Z","end":"2026-08-11T07:29:59.775602Z","steps":["trace[603939549] 'range keys from in-memory index tree' (duration: 298.628682ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:29:59.775475Z","caller":"traceutil/trace.go:171","msg":"trace[1239569883] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1313; }","duration":"375.982732ms","start":"2026-08-11T07:29:59.399471Z","end":"2026-08-11T07:29:59.775454Z","steps":["trace[1239569883] 'count revisions from in-memory index tree' (duration: 375.729025ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:59.775743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"327.946573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-11T07:29:59.775774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.399444Z","time spent":"376.319911ms","remote":"127.0.0.1:35084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"info","ts":"2026-08-11T07:29:59.775791Z","caller":"traceutil/trace.go:171","msg":"trace[139239413] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1313; }","duration":"328.031945ms","start":"2026-08-11T07:29:59.447735Z","end":"2026-08-11T07:29:59.775767Z","steps":["trace[139239413] 'range keys from in-memory index tree' (duration: 327.732287ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:59.775813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.447706Z","time spent":"328.100757ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T07:29:59.775886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.127699ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:29:59.775926Z","caller":"traceutil/trace.go:171","msg":"trace[1992467711] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1313; }","duration":"298.205791ms","start":"2026-08-11T07:29:59.477711Z","end":"2026-08-11T07:29:59.775916Z","steps":["trace[1992467711] 'range keys from in-memory index tree' (duration: 297.993665ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:59.7762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"723.994249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:29:59.776229Z","caller":"traceutil/trace.go:171","msg":"trace[360625782] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1313; }","duration":"724.062791ms","start":"2026-08-11T07:29:59.05216Z","end":"2026-08-11T07:29:59.776223Z","steps":["trace[360625782] 'range keys from in-memory index tree' (duration: 723.899377ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:29:59.776248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.052138Z","time spent":"724.105742ms","remote":"127.0.0.1:57818","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-08-11T07:30:00.17083Z","caller":"traceutil/trace.go:171","msg":"trace[745729657] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"508.677945ms","start":"2026-08-11T07:29:59.662123Z","end":"2026-08-11T07:30:00.170801Z","steps":["trace[745729657] 'process raft request' (duration: 508.49722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:00.170989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.662096Z","time spent":"508.818598ms","remote":"127.0.0.1:58078","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-08-11T07:30:00.224583Z","caller":"traceutil/trace.go:171","msg":"trace[1054661754] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"439.988376ms","start":"2026-08-11T07:29:59.784571Z","end":"2026-08-11T07:30:00.224559Z","steps":["trace[1054661754] 'process raft request' (duration: 439.957676ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:00.224726Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.784566Z","time spent":"440.090559ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:30:00.224924Z","caller":"traceutil/trace.go:171","msg":"trace[1022299877] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"444.22333ms","start":"2026-08-11T07:29:59.780648Z","end":"2026-08-11T07:30:00.224872Z","steps":["trace[1022299877] 'process raft request' (duration: 443.798588ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:00.224996Z","caller":"traceutil/trace.go:171","msg":"trace[1635709821] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"440.617274ms","start":"2026-08-11T07:29:59.784373Z","end":"2026-08-11T07:30:00.22499Z","steps":["trace[1635709821] 'process raft request' (duration: 440.130081ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:00.225038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.784362Z","time spent":"440.654884ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:30:00.225122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.780641Z","time spent":"444.364903ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:30:00.225343Z","caller":"traceutil/trace.go:171","msg":"trace[1370871968] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"444.743353ms","start":"2026-08-11T07:29:59.78059Z","end":"2026-08-11T07:30:00.225333Z","steps":["trace[1370871968] 'process raft request' (duration: 401.566012ms)","trace[1370871968] 'compare' (duration: 42.164134ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:30:00.225393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.780568Z","time spent":"444.803005ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T07:30:00.224971Z","caller":"traceutil/trace.go:171","msg":"trace[536956341] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"444.294581ms","start":"2026-08-11T07:29:59.780668Z","end":"2026-08-11T07:30:00.224963Z","steps":["trace[536956341] 'process raft request' (duration: 443.813958ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:00.225471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:29:59.780661Z","time spent":"444.792585ms","remote":"127.0.0.1:58078","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-08-11T07:30:00.743403Z","caller":"traceutil/trace.go:171","msg":"trace[2145166589] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"138.413146ms","start":"2026-08-11T07:30:00.604951Z","end":"2026-08-11T07:30:00.743364Z","steps":["trace[2145166589] 'process raft request' (duration: 138.156649ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:01.243469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:00.895638Z","time spent":"347.826361ms","remote":"127.0.0.1:57840","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-08-11T07:30:01.956388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.459307ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:30:01.956499Z","caller":"traceutil/trace.go:171","msg":"trace[1541203354] linearizableReadLoop","detail":"{readStateIndex:1376; appliedIndex:1375; }","duration":"638.636146ms","start":"2026-08-11T07:30:01.317849Z","end":"2026-08-11T07:30:01.956485Z","steps":["trace[1541203354] 'read index received' (duration: 327.935622ms)","trace[1541203354] 'applied index is now lower than readState.Index' (duration: 310.699634ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:30:01.95661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"638.759539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:30:01.956634Z","caller":"traceutil/trace.go:171","msg":"trace[2145626954] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1321; }","duration":"638.81031ms","start":"2026-08-11T07:30:01.317817Z","end":"2026-08-11T07:30:01.956627Z","steps":["trace[2145626954] 'agreement among raft nodes before linearized reading' (duration: 638.748259ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:01.956616Z","caller":"traceutil/trace.go:171","msg":"trace[1974711595] transaction","detail":"{read_only:false; response_revision:1321; number_of_response:1; }","duration":"711.25667ms","start":"2026-08-11T07:30:01.24526Z","end":"2026-08-11T07:30:01.956516Z","steps":["trace[1974711595] 'process raft request' (duration: 400.620778ms)","trace[1974711595] 'compare' (duration: 310.306093ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:30:01.956788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:01.245237Z","time spent":"711.459475ms","remote":"127.0.0.1:57840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:30:01.95666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:01.317798Z","time spent":"638.857092ms","remote":"127.0.0.1:57810","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-08-11T07:30:05.407193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.135933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:30:05.407304Z","caller":"traceutil/trace.go:171","msg":"trace[1257056320] linearizableReadLoop","detail":"{readStateIndex:1397; appliedIndex:1396; }","duration":"564.646175ms","start":"2026-08-11T07:30:04.842643Z","end":"2026-08-11T07:30:05.407289Z","steps":["trace[1257056320] 'read index received' (duration: 273.438051ms)","trace[1257056320] 'applied index is now lower than readState.Index' (duration: 291.207164ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:05.407382Z","caller":"traceutil/trace.go:171","msg":"trace[1230727102] transaction","detail":"{read_only:false; response_revision:1342; number_of_response:1; }","duration":"650.379809ms","start":"2026-08-11T07:30:04.756993Z","end":"2026-08-11T07:30:05.407373Z","steps":["trace[1230727102] 'process raft request' (duration: 358.98546ms)","trace[1230727102] 'compare' (duration: 291.032149ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:30:05.407421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:04.75697Z","time spent":"650.430719ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T07:30:05.407573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"564.890323ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:30:05.407686Z","caller":"traceutil/trace.go:171","msg":"trace[1683926770] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1342; }","duration":"565.071957ms","start":"2026-08-11T07:30:04.842575Z","end":"2026-08-11T07:30:05.407647Z","steps":["trace[1683926770] 'agreement among raft nodes before linearized reading' (duration: 564.903812ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:05.40774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:04.842545Z","time spent":"565.18367ms","remote":"127.0.0.1:57948","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"warn","ts":"2026-08-11T07:30:06.846419Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":138943015447816280,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-11T07:30:07.23623Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.233971059s","expected-duration":"1s"} {"level":"warn","ts":"2026-08-11T07:30:07.246528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:05.829746Z","time spent":"1.416775317s","remote":"127.0.0.1:57028","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-11T07:30:07.249264Z","caller":"traceutil/trace.go:171","msg":"trace[1235948335] linearizableReadLoop","detail":"{readStateIndex:1398; appliedIndex:1397; }","duration":"903.536309ms","start":"2026-08-11T07:30:06.345695Z","end":"2026-08-11T07:30:07.249231Z","steps":["trace[1235948335] 'read index received' (duration: 890.810961ms)","trace[1235948335] 'applied index is now lower than readState.Index' (duration: 12.723428ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:30:07.249438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"903.732675ms","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-08-11T07:30:07.249503Z","caller":"traceutil/trace.go:171","msg":"trace[1073879914] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1342; }","duration":"903.843297ms","start":"2026-08-11T07:30:06.345636Z","end":"2026-08-11T07:30:07.249479Z","steps":["trace[1073879914] 'agreement among raft nodes before linearized reading' (duration: 903.658183ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:07.249533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:06.345613Z","time spent":"903.913049ms","remote":"127.0.0.1:58078","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-08-11T07:30:07.24956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"870.319065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-08-11T07:30:07.2496Z","caller":"traceutil/trace.go:171","msg":"trace[1285845619] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1342; }","duration":"870.401696ms","start":"2026-08-11T07:30:06.379187Z","end":"2026-08-11T07:30:07.249589Z","steps":["trace[1285845619] 'agreement among raft nodes before linearized reading' (duration: 870.234962ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:07.249638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:06.37917Z","time spent":"870.457038ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-11T07:30:07.249793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.169945ms","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-08-11T07:30:07.249817Z","caller":"traceutil/trace.go:171","msg":"trace[1930495297] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1342; }","duration":"869.201465ms","start":"2026-08-11T07:30:06.380609Z","end":"2026-08-11T07:30:07.249811Z","steps":["trace[1930495297] 'agreement among raft nodes before linearized reading' (duration: 869.138473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:07.249835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:06.380606Z","time spent":"869.224936ms","remote":"127.0.0.1:58078","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-08-11T07:30:07.249871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.247746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-11T07:30:07.249937Z","caller":"traceutil/trace.go:171","msg":"trace[315289542] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1342; }","duration":"869.340298ms","start":"2026-08-11T07:30:06.380583Z","end":"2026-08-11T07:30:07.249923Z","steps":["trace[315289542] 'agreement among raft nodes before linearized reading' (duration: 869.171144ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:07.249966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:06.380578Z","time spent":"869.38283ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-11T07:30:07.249901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.039367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:30:07.250022Z","caller":"traceutil/trace.go:171","msg":"trace[421958321] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1342; }","duration":"259.186861ms","start":"2026-08-11T07:30:06.990815Z","end":"2026-08-11T07:30:07.250002Z","steps":["trace[421958321] 'agreement among raft nodes before linearized reading' (duration: 259.065208ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:07.250225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.171065ms","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-08-11T07:30:07.250289Z","caller":"traceutil/trace.go:171","msg":"trace[501353859] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1342; }","duration":"869.214696ms","start":"2026-08-11T07:30:06.381038Z","end":"2026-08-11T07:30:07.250253Z","steps":["trace[501353859] 'agreement among raft nodes before linearized reading' (duration: 868.430544ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:07.250313Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:30:06.381035Z","time spent":"869.271908ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-08-11T07:30:23.255732Z","caller":"traceutil/trace.go:171","msg":"trace[26538413] linearizableReadLoop","detail":"{readStateIndex:1500; appliedIndex:1499; }","duration":"103.470205ms","start":"2026-08-11T07:30:23.152235Z","end":"2026-08-11T07:30:23.255706Z","steps":["trace[26538413] 'read index received' (duration: 103.27257ms)","trace[26538413] 'applied index is now lower than readState.Index' (duration: 196.895µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:23.255834Z","caller":"traceutil/trace.go:171","msg":"trace[1868688739] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"150.663523ms","start":"2026-08-11T07:30:23.105141Z","end":"2026-08-11T07:30:23.255804Z","steps":["trace[1868688739] 'process raft request' (duration: 150.420357ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:23.255941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.700241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-08-11T07:30:23.255984Z","caller":"traceutil/trace.go:171","msg":"trace[1064202276] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1441; }","duration":"103.792304ms","start":"2026-08-11T07:30:23.152171Z","end":"2026-08-11T07:30:23.255964Z","steps":["trace[1064202276] 'agreement among raft nodes before linearized reading' (duration: 103.64675ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:23.415633Z","caller":"traceutil/trace.go:171","msg":"trace[1160885117] transaction","detail":"{read_only:false; response_revision:1442; number_of_response:1; }","duration":"127.826525ms","start":"2026-08-11T07:30:23.287761Z","end":"2026-08-11T07:30:23.415587Z","steps":["trace[1160885117] 'process raft request' (duration: 125.590864ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:23.547038Z","caller":"traceutil/trace.go:171","msg":"trace[875217853] transaction","detail":"{read_only:false; response_revision:1445; number_of_response:1; }","duration":"126.706273ms","start":"2026-08-11T07:30:23.420296Z","end":"2026-08-11T07:30:23.547002Z","steps":["trace[875217853] 'process raft request' (duration: 126.618961ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:23.547103Z","caller":"traceutil/trace.go:171","msg":"trace[1829796806] transaction","detail":"{read_only:false; response_revision:1444; number_of_response:1; }","duration":"126.864078ms","start":"2026-08-11T07:30:23.42019Z","end":"2026-08-11T07:30:23.547054Z","steps":["trace[1829796806] 'process raft request' (duration: 126.530949ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:23.547318Z","caller":"traceutil/trace.go:171","msg":"trace[1984151789] transaction","detail":"{read_only:false; response_revision:1446; number_of_response:1; }","duration":"126.739745ms","start":"2026-08-11T07:30:23.420552Z","end":"2026-08-11T07:30:23.547292Z","steps":["trace[1984151789] 'process raft request' (duration: 126.406536ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:23.547579Z","caller":"traceutil/trace.go:171","msg":"trace[1052271193] transaction","detail":"{read_only:false; response_revision:1447; number_of_response:1; }","duration":"125.580843ms","start":"2026-08-11T07:30:23.421942Z","end":"2026-08-11T07:30:23.547523Z","steps":["trace[1052271193] 'process raft request' (duration: 125.267005ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:47.788863Z","caller":"traceutil/trace.go:171","msg":"trace[2071131404] linearizableReadLoop","detail":"{readStateIndex:1617; appliedIndex:1616; }","duration":"119.522568ms","start":"2026-08-11T07:30:47.669319Z","end":"2026-08-11T07:30:47.788842Z","steps":["trace[2071131404] 'read index received' (duration: 39.85688ms)","trace[2071131404] 'applied index is now lower than readState.Index' (duration: 79.664718ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:47.789221Z","caller":"traceutil/trace.go:171","msg":"trace[1622923550] transaction","detail":"{read_only:false; response_revision:1553; number_of_response:1; }","duration":"134.416473ms","start":"2026-08-11T07:30:47.654793Z","end":"2026-08-11T07:30:47.789209Z","steps":["trace[1622923550] 'process raft request' (duration: 54.445375ms)","trace[1622923550] 'compare' (duration: 79.480924ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:30:47.789483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.185617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T07:30:47.789531Z","caller":"traceutil/trace.go:171","msg":"trace[708587075] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1553; }","duration":"120.27349ms","start":"2026-08-11T07:30:47.66925Z","end":"2026-08-11T07:30:47.789523Z","steps":["trace[708587075] 'agreement among raft nodes before linearized reading' (duration: 120.129706ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:47.78973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.807281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-11T07:30:47.789797Z","caller":"traceutil/trace.go:171","msg":"trace[451962313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1553; }","duration":"118.891133ms","start":"2026-08-11T07:30:47.670889Z","end":"2026-08-11T07:30:47.789781Z","steps":["trace[451962313] 'agreement among raft nodes before linearized reading' (duration: 118.747089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:47.789844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.06684ms","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-08-11T07:30:47.789879Z","caller":"traceutil/trace.go:171","msg":"trace[254373260] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1553; }","duration":"118.220854ms","start":"2026-08-11T07:30:47.671649Z","end":"2026-08-11T07:30:47.78987Z","steps":["trace[254373260] 'agreement among raft nodes before linearized reading' (duration: 118.125811ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:47.789951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.751101ms","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-08-11T07:30:47.789987Z","caller":"traceutil/trace.go:171","msg":"trace[2116331393] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1553; }","duration":"118.036899ms","start":"2026-08-11T07:30:47.671942Z","end":"2026-08-11T07:30:47.789979Z","steps":["trace[2116331393] 'agreement among raft nodes before linearized reading' (duration: 117.748561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:30:48.012871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.683199ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:30:48.013102Z","caller":"traceutil/trace.go:171","msg":"trace[1749589132] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"220.111236ms","start":"2026-08-11T07:30:47.792954Z","end":"2026-08-11T07:30:48.013066Z","steps":["trace[1749589132] 'process raft request' (duration: 119.123608ms)","trace[1749589132] 'compare' (duration: 100.590706ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:30:48.013161Z","caller":"traceutil/trace.go:171","msg":"trace[600453206] transaction","detail":"{read_only:false; response_revision:1557; number_of_response:1; }","duration":"217.825403ms","start":"2026-08-11T07:30:47.795316Z","end":"2026-08-11T07:30:48.013142Z","steps":["trace[600453206] 'process raft request' (duration: 217.767252ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:30:48.013356Z","caller":"traceutil/trace.go:171","msg":"trace[1791657207] transaction","detail":"{read_only:false; response_revision:1556; number_of_response:1; }","duration":"219.558721ms","start":"2026-08-11T07:30:47.793787Z","end":"2026-08-11T07:30:48.013346Z","steps":["trace[1791657207] 'process raft request' (duration: 219.20245ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:13.918343Z","caller":"traceutil/trace.go:171","msg":"trace[1757732260] transaction","detail":"{read_only:false; response_revision:1673; number_of_response:1; }","duration":"157.517489ms","start":"2026-08-11T07:31:13.760771Z","end":"2026-08-11T07:31:13.918288Z","steps":["trace[1757732260] 'process raft request' (duration: 138.356575ms)","trace[1757732260] 'compare' (duration: 18.956709ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:31:27.951921Z","caller":"traceutil/trace.go:171","msg":"trace[145019901] transaction","detail":"{read_only:false; response_revision:1735; number_of_response:1; }","duration":"117.61117ms","start":"2026-08-11T07:31:27.834282Z","end":"2026-08-11T07:31:27.951893Z","steps":["trace[145019901] 'process raft request' (duration: 117.458216ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:28.163154Z","caller":"traceutil/trace.go:171","msg":"trace[1754526545] linearizableReadLoop","detail":"{readStateIndex:1809; appliedIndex:1808; }","duration":"139.447165ms","start":"2026-08-11T07:31:28.023666Z","end":"2026-08-11T07:31:28.163113Z","steps":["trace[1754526545] 'read index received' (duration: 88.821785ms)","trace[1754526545] 'applied index is now lower than readState.Index' (duration: 50.62365ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:31:28.163247Z","caller":"traceutil/trace.go:171","msg":"trace[1165359177] transaction","detail":"{read_only:false; response_revision:1737; number_of_response:1; }","duration":"151.08089ms","start":"2026-08-11T07:31:28.012125Z","end":"2026-08-11T07:31:28.163206Z","steps":["trace[1165359177] 'process raft request' (duration: 100.418229ms)","trace[1165359177] 'compare' (duration: 50.390064ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:31:28.163476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.788094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-11T07:31:28.163546Z","caller":"traceutil/trace.go:171","msg":"trace[488345965] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1737; }","duration":"139.917377ms","start":"2026-08-11T07:31:28.023612Z","end":"2026-08-11T07:31:28.163529Z","steps":["trace[488345965] 'agreement among raft nodes before linearized reading' (duration: 139.686481ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:31:28.445613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.228019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T07:31:28.445743Z","caller":"traceutil/trace.go:171","msg":"trace[1947337581] linearizableReadLoop","detail":"{readStateIndex:1812; appliedIndex:1811; }","duration":"149.313484ms","start":"2026-08-11T07:31:28.296409Z","end":"2026-08-11T07:31:28.445722Z","steps":["trace[1947337581] 'read index received' (duration: 12.777776ms)","trace[1947337581] 'applied index is now lower than readState.Index' (duration: 136.533728ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:31:28.445748Z","caller":"traceutil/trace.go:171","msg":"trace[1712679282] transaction","detail":"{read_only:false; response_revision:1740; number_of_response:1; }","duration":"206.981439ms","start":"2026-08-11T07:31:28.238745Z","end":"2026-08-11T07:31:28.445726Z","steps":["trace[1712679282] 'process raft request' (duration: 70.550534ms)","trace[1712679282] 'compare' (duration: 135.963912ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T07:31:28.446014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.383614ms","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-08-11T07:31:28.4461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.696664ms","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-08-11T07:31:28.446139Z","caller":"traceutil/trace.go:171","msg":"trace[221271812] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1740; }","duration":"149.774816ms","start":"2026-08-11T07:31:28.296356Z","end":"2026-08-11T07:31:28.446131Z","steps":["trace[221271812] 'agreement among raft nodes before linearized reading' (duration: 149.459188ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:28.446259Z","caller":"traceutil/trace.go:171","msg":"trace[536470645] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1740; }","duration":"144.433106ms","start":"2026-08-11T07:31:28.301594Z","end":"2026-08-11T07:31:28.446028Z","steps":["trace[536470645] 'agreement among raft nodes before linearized reading' (duration: 144.349924ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:28.694678Z","caller":"traceutil/trace.go:171","msg":"trace[1096825351] transaction","detail":"{read_only:false; response_revision:1741; number_of_response:1; }","duration":"244.507995ms","start":"2026-08-11T07:31:28.45013Z","end":"2026-08-11T07:31:28.694638Z","steps":["trace[1096825351] 'process raft request' (duration: 162.428058ms)","trace[1096825351] 'compare' (duration: 81.791549ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:31:28.697081Z","caller":"traceutil/trace.go:171","msg":"trace[986647778] transaction","detail":"{read_only:false; response_revision:1743; number_of_response:1; }","duration":"245.842658ms","start":"2026-08-11T07:31:28.451221Z","end":"2026-08-11T07:31:28.697063Z","steps":["trace[986647778] 'process raft request' (duration: 245.795167ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:28.697431Z","caller":"traceutil/trace.go:171","msg":"trace[241035952] transaction","detail":"{read_only:false; response_revision:1742; number_of_response:1; }","duration":"246.427204ms","start":"2026-08-11T07:31:28.45099Z","end":"2026-08-11T07:31:28.697418Z","steps":["trace[241035952] 'process raft request' (duration: 245.946452ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:31:29.359579Z","caller":"traceutil/trace.go:171","msg":"trace[1151748036] transaction","detail":"{read_only:false; response_revision:1744; number_of_response:1; }","duration":"110.36562ms","start":"2026-08-11T07:31:29.249179Z","end":"2026-08-11T07:31:29.359545Z","steps":["trace[1151748036] 'process raft request' (duration: 110.169685ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:32:57.045873Z","caller":"traceutil/trace.go:171","msg":"trace[186369811] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"138.283359ms","start":"2026-08-11T07:32:56.907556Z","end":"2026-08-11T07:32:57.045839Z","steps":["trace[186369811] 'process raft request' (duration: 135.415522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:33:03.831225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.252822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-11T07:33:03.831347Z","caller":"traceutil/trace.go:171","msg":"trace[1688707877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2195; }","duration":"408.438157ms","start":"2026-08-11T07:33:03.422884Z","end":"2026-08-11T07:33:03.831322Z","steps":["trace[1688707877] 'range keys from in-memory index tree' (duration: 408.044376ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:33:03.831397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:33:03.422869Z","time spent":"408.518298ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-11T07:33:03.831368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.510212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T07:33:03.831461Z","caller":"traceutil/trace.go:171","msg":"trace[995329528] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2195; }","duration":"511.650025ms","start":"2026-08-11T07:33:03.319789Z","end":"2026-08-11T07:33:03.831439Z","steps":["trace[995329528] 'range keys from in-memory index tree' (duration: 511.312645ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:33:03.831514Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:33:03.319776Z","time spent":"511.723807ms","remote":"127.0.0.1:57818","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-08-11T07:33:03.831496Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.474363ms","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-08-11T07:33:03.831579Z","caller":"traceutil/trace.go:171","msg":"trace[1183297973] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:2195; }","duration":"334.597897ms","start":"2026-08-11T07:33:03.496961Z","end":"2026-08-11T07:33:03.831559Z","steps":["trace[1183297973] 'count revisions from in-memory index tree' (duration: 334.426223ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:33:03.831575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.168852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-08-11T07:33:03.831624Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:33:03.496953Z","time spent":"334.660658ms","remote":"127.0.0.1:58126","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":"info","ts":"2026-08-11T07:33:03.831634Z","caller":"traceutil/trace.go:171","msg":"trace[587321469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2195; }","duration":"531.272174ms","start":"2026-08-11T07:33:03.300346Z","end":"2026-08-11T07:33:03.831619Z","steps":["trace[587321469] 'range keys from in-memory index tree' (duration: 530.958856ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:33:03.831678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:33:03.300324Z","time spent":"531.342417ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T07:33:03.831819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.269111ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-08-11T07:33:03.831847Z","caller":"traceutil/trace.go:171","msg":"trace[1533601890] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2195; }","duration":"339.331853ms","start":"2026-08-11T07:33:03.492503Z","end":"2026-08-11T07:33:03.831835Z","steps":["trace[1533601890] 'range keys from in-memory index tree' (duration: 339.166079ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:33:03.831883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T07:33:03.492483Z","time spent":"339.390084ms","remote":"127.0.0.1:58078","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-08-11T07:33:04.017795Z","caller":"traceutil/trace.go:171","msg":"trace[513865547] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"181.28333ms","start":"2026-08-11T07:33:03.836483Z","end":"2026-08-11T07:33:04.017767Z","steps":["trace[513865547] 'process raft request' (duration: 181.122486ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:33:04.020796Z","caller":"traceutil/trace.go:171","msg":"trace[41365786] linearizableReadLoop","detail":"{readStateIndex:2290; appliedIndex:2287; }","duration":"136.641326ms","start":"2026-08-11T07:33:03.884134Z","end":"2026-08-11T07:33:04.020775Z","steps":["trace[41365786] 'read index received' (duration: 133.470291ms)","trace[41365786] 'applied index is now lower than readState.Index' (duration: 3.169765ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T07:33:04.020831Z","caller":"traceutil/trace.go:171","msg":"trace[1827588712] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"184.30148ms","start":"2026-08-11T07:33:03.836496Z","end":"2026-08-11T07:33:04.020797Z","steps":["trace[1827588712] 'process raft request' (duration: 184.124415ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T07:33:04.021007Z","caller":"traceutil/trace.go:171","msg":"trace[795152855] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"184.405892ms","start":"2026-08-11T07:33:03.83659Z","end":"2026-08-11T07:33:04.020996Z","steps":["trace[795152855] 'process raft request' (duration: 184.131065ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T07:33:04.021069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.934623ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-11T07:33:04.02114Z","caller":"traceutil/trace.go:171","msg":"trace[33031514] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2198; }","duration":"137.069527ms","start":"2026-08-11T07:33:03.884051Z","end":"2026-08-11T07:33:04.021121Z","steps":["trace[33031514] 'agreement among raft nodes before linearized reading' (duration: 136.80728ms)"],"step_count":1}