{"level":"warn","ts":"2026-06-20T02:54:58.423059Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-20T02:54:58.423195Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.109:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.109:2380","--initial-cluster=instance=https://199.204.45.109:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.109:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.109:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-20T02:54:58.423294Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-20T02:54:58.423307Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-06-20T02:54:58.423331Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-20T02:54:58.424227Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"]} {"level":"info","ts":"2026-06-20T02:54:58.424349Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.109:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-20T02:54:58.464535Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"39.872673ms"} {"level":"info","ts":"2026-06-20T02:54:58.473061Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"d71a1778b31d4ce","cluster-id":"aaca35652fabf9b2"} {"level":"info","ts":"2026-06-20T02:54:58.473208Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=()"} {"level":"info","ts":"2026-06-20T02:54:58.473247Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 0"} {"level":"info","ts":"2026-06-20T02:54:58.473261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft d71a1778b31d4ce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-20T02:54:58.473285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became follower at term 1"} {"level":"info","ts":"2026-06-20T02:54:58.473348Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"warn","ts":"2026-06-20T02:54:58.478568Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-20T02:54:58.479925Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-20T02:54:58.484157Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-20T02:54:58.486891Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"d71a1778b31d4ce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-20T02:54:58.487247Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-20T02:54:58.487364Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-20T02:54:58.487398Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-20T02:54:58.488448Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"d71a1778b31d4ce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-20T02:54:58.488888Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce switched to configuration voters=(968732929669846222)"} {"level":"info","ts":"2026-06-20T02:54:58.489607Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","added-peer-id":"d71a1778b31d4ce","added-peer-peer-urls":["https://199.204.45.109:2380"]} {"level":"info","ts":"2026-06-20T02:54:58.491443Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-20T02:54:58.491497Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-06-20T02:54:58.49163Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.109:2380"} {"level":"info","ts":"2026-06-20T02:54:58.491834Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"d71a1778b31d4ce","initial-advertise-peer-urls":["https://199.204.45.109:2380"],"listen-peer-urls":["https://199.204.45.109:2380"],"advertise-client-urls":["https://199.204.45.109:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.109:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-20T02:54:58.491899Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-20T02:54:58.773992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce is starting a new election at term 1"} {"level":"info","ts":"2026-06-20T02:54:58.77406Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became pre-candidate at term 1"} {"level":"info","ts":"2026-06-20T02:54:58.774104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgPreVoteResp from d71a1778b31d4ce at term 1"} {"level":"info","ts":"2026-06-20T02:54:58.774126Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became candidate at term 2"} {"level":"info","ts":"2026-06-20T02:54:58.774137Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce received MsgVoteResp from d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-06-20T02:54:58.774153Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"d71a1778b31d4ce became leader at term 2"} {"level":"info","ts":"2026-06-20T02:54:58.774173Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: d71a1778b31d4ce elected leader d71a1778b31d4ce at term 2"} {"level":"info","ts":"2026-06-20T02:54:58.77913Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T02:54:58.800123Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"d71a1778b31d4ce","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.109:2379]}","request-path":"/0/members/d71a1778b31d4ce/attributes","cluster-id":"aaca35652fabf9b2","publish-timeout":"7s"} {"level":"info","ts":"2026-06-20T02:54:58.800292Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-20T02:54:58.800611Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-20T02:54:58.800905Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-20T02:54:58.800723Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aaca35652fabf9b2","local-member-id":"d71a1778b31d4ce","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T02:54:58.801262Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T02:54:58.801411Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-20T02:54:58.800528Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-20T02:54:58.80514Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-20T02:54:58.806552Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.109:2379"} {"level":"warn","ts":"2026-06-20T02:55:00.657459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.322805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-20T02:55:00.657619Z","caller":"traceutil/trace.go:171","msg":"trace[19237833] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:68; }","duration":"156.54663ms","start":"2026-06-20T02:55:00.501038Z","end":"2026-06-20T02:55:00.657585Z","steps":["trace[19237833] 'range keys from in-memory index tree' (duration: 156.234092ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:02.999449Z","caller":"traceutil/trace.go:171","msg":"trace[154198790] transaction","detail":"{read_only:false; response_revision:199; number_of_response:1; }","duration":"144.246843ms","start":"2026-06-20T02:55:02.855128Z","end":"2026-06-20T02:55:02.999375Z","steps":["trace[154198790] 'process raft request' (duration: 45.14509ms)","trace[154198790] 'compare' (duration: 98.812077ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:07.31388Z","caller":"traceutil/trace.go:171","msg":"trace[1190065456] linearizableReadLoop","detail":"{readStateIndex:305; appliedIndex:304; }","duration":"102.722581ms","start":"2026-06-20T02:55:07.211136Z","end":"2026-06-20T02:55:07.313859Z","steps":["trace[1190065456] 'read index received' (duration: 102.535676ms)","trace[1190065456] 'applied index is now lower than readState.Index' (duration: 185.985µs)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:07.31404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.878714ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T02:55:07.314075Z","caller":"traceutil/trace.go:171","msg":"trace[776399933] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:296; }","duration":"102.934516ms","start":"2026-06-20T02:55:07.21113Z","end":"2026-06-20T02:55:07.314064Z","steps":["trace[776399933] 'agreement among raft nodes before linearized reading' (duration: 102.829703ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:07.314366Z","caller":"traceutil/trace.go:171","msg":"trace[348001192] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"117.753814ms","start":"2026-06-20T02:55:07.196601Z","end":"2026-06-20T02:55:07.314355Z","steps":["trace[348001192] 'process raft request' (duration: 117.148039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:07.823984Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368478835616718,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T02:55:08.863802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.01048603s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:55:08.863997Z","caller":"traceutil/trace.go:171","msg":"trace[15530894] linearizableReadLoop","detail":"{readStateIndex:306; appliedIndex:305; }","duration":"1.540883287s","start":"2026-06-20T02:55:07.323083Z","end":"2026-06-20T02:55:08.863966Z","steps":["trace[15530894] 'read index received' (duration: 529.096616ms)","trace[15530894] 'applied index is now lower than readState.Index' (duration: 1.011784721s)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:08.864037Z","caller":"traceutil/trace.go:171","msg":"trace[1081028095] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"1.542963818s","start":"2026-06-20T02:55:07.321034Z","end":"2026-06-20T02:55:08.863998Z","steps":["trace[1081028095] 'process raft request' (duration: 531.206808ms)","trace[1081028095] 'compare' (duration: 1.010263345s)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:08.864212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.541117503s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-20T02:55:08.86428Z","caller":"traceutil/trace.go:171","msg":"trace[1764845983] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:297; }","duration":"1.541195074s","start":"2026-06-20T02:55:07.323057Z","end":"2026-06-20T02:55:08.864253Z","steps":["trace[1764845983] 'agreement among raft nodes before linearized reading' (duration: 1.541075491s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:08.864237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:07.321009Z","time spent":"1.543112131s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:55:08.864359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:07.323047Z","time spent":"1.541298387s","remote":"127.0.0.1:44176","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":374,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-20T02:55:08.864332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.396937201s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-20T02:55:08.864464Z","caller":"traceutil/trace.go:171","msg":"trace[2131839538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:297; }","duration":"1.397105074s","start":"2026-06-20T02:55:07.467324Z","end":"2026-06-20T02:55:08.864429Z","steps":["trace[2131839538] 'agreement among raft nodes before linearized reading' (duration: 1.396890559s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:08.86453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:07.467303Z","time spent":"1.397214928s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-20T02:55:09.576885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.581592ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:55:09.577038Z","caller":"traceutil/trace.go:171","msg":"trace[1522229044] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"707.923694ms","start":"2026-06-20T02:55:08.869073Z","end":"2026-06-20T02:55:09.576996Z","steps":["trace[1522229044] 'process raft request' (duration: 406.156627ms)","trace[1522229044] 'compare' (duration: 299.908532ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:09.577099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:08.869054Z","time spent":"708.022597ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":194,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T02:55:09.578953Z","caller":"traceutil/trace.go:171","msg":"trace[1940404253] linearizableReadLoop","detail":"{readStateIndex:308; appliedIndex:306; }","duration":"675.217794ms","start":"2026-06-20T02:55:08.903717Z","end":"2026-06-20T02:55:09.578934Z","steps":["trace[1940404253] 'read index received' (duration: 371.529612ms)","trace[1940404253] 'applied index is now lower than readState.Index' (duration: 303.687162ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:09.579162Z","caller":"traceutil/trace.go:171","msg":"trace[102678958] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"709.907361ms","start":"2026-06-20T02:55:08.869244Z","end":"2026-06-20T02:55:09.579152Z","steps":["trace[102678958] 'process raft request' (duration: 709.584604ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.579249Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:08.869222Z","time spent":"709.971074ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:55:09.579432Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"582.243849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" ","response":"range_response_count:1 size:4326"} {"level":"info","ts":"2026-06-20T02:55:09.579489Z","caller":"traceutil/trace.go:171","msg":"trace[426618635] range","detail":"{range_begin:/registry/pods/kube-system/kube-scheduler-instance; range_end:; response_count:1; response_revision:299; }","duration":"582.353762ms","start":"2026-06-20T02:55:08.997121Z","end":"2026-06-20T02:55:09.579475Z","steps":["trace[426618635] 'agreement among raft nodes before linearized reading' (duration: 582.234419ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.579549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:08.997094Z","time spent":"582.446434ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":4349,"request content":"key:\"/registry/pods/kube-system/kube-scheduler-instance\" "} {"level":"warn","ts":"2026-06-20T02:55:09.579547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.189198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-20T02:55:09.579651Z","caller":"traceutil/trace.go:171","msg":"trace[1133145086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:299; }","duration":"471.340682ms","start":"2026-06-20T02:55:09.108288Z","end":"2026-06-20T02:55:09.579628Z","steps":["trace[1133145086] 'agreement among raft nodes before linearized reading' (duration: 471.160167ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.579678Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"675.969852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-20T02:55:09.579719Z","caller":"traceutil/trace.go:171","msg":"trace[47765233] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:299; }","duration":"676.011333ms","start":"2026-06-20T02:55:08.903695Z","end":"2026-06-20T02:55:09.579706Z","steps":["trace[47765233] 'agreement among raft nodes before linearized reading' (duration: 675.727337ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.579708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.108261Z","time spent":"471.437134ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T02:55:09.57975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:08.903608Z","time spent":"676.135306ms","remote":"127.0.0.1:44340","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-06-20T02:55:09.948953Z","caller":"traceutil/trace.go:171","msg":"trace[1254588808] transaction","detail":"{read_only:false; response_revision:300; number_of_response:1; }","duration":"366.09223ms","start":"2026-06-20T02:55:09.582823Z","end":"2026-06-20T02:55:09.948916Z","steps":["trace[1254588808] 'process raft request' (duration: 267.066419ms)","trace[1254588808] 'compare' (duration: 98.685373ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:09.949151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.582801Z","time spent":"366.246664ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:55:09.953347Z","caller":"traceutil/trace.go:171","msg":"trace[79243220] transaction","detail":"{read_only:false; response_revision:301; number_of_response:1; }","duration":"366.392338ms","start":"2026-06-20T02:55:09.586926Z","end":"2026-06-20T02:55:09.953318Z","steps":["trace[79243220] 'process raft request' (duration: 366.205873ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:09.953561Z","caller":"traceutil/trace.go:171","msg":"trace[911950044] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:308; }","duration":"348.237148ms","start":"2026-06-20T02:55:09.605276Z","end":"2026-06-20T02:55:09.953513Z","steps":["trace[911950044] 'read index received' (duration: 244.634957ms)","trace[911950044] 'applied index is now lower than readState.Index' (duration: 103.599211ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:09.953841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.339301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-06-20T02:55:09.953722Z","caller":"traceutil/trace.go:171","msg":"trace[300078276] transaction","detail":"{read_only:false; response_revision:302; number_of_response:1; }","duration":"364.087882ms","start":"2026-06-20T02:55:09.58961Z","end":"2026-06-20T02:55:09.953698Z","steps":["trace[300078276] 'process raft request' (duration: 363.656851ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:09.953926Z","caller":"traceutil/trace.go:171","msg":"trace[1741060535] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:302; }","duration":"348.428323ms","start":"2026-06-20T02:55:09.605467Z","end":"2026-06-20T02:55:09.953895Z","steps":["trace[1741060535] 'agreement among raft nodes before linearized reading' (duration: 348.30617ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.954002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.60546Z","time spent":"348.532246ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":237,"request content":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" "} {"level":"warn","ts":"2026-06-20T02:55:09.954019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.589592Z","time spent":"364.318307ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4311,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:55:09.954195Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.916014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" ","response":"range_response_count:1 size:234"} {"level":"info","ts":"2026-06-20T02:55:09.954237Z","caller":"traceutil/trace.go:171","msg":"trace[996619389] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:302; }","duration":"348.986216ms","start":"2026-06-20T02:55:09.605237Z","end":"2026-06-20T02:55:09.954223Z","steps":["trace[996619389] 'agreement among raft nodes before linearized reading' (duration: 348.922635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.954265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.605222Z","time spent":"349.036788ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":257,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-06-20T02:55:09.954413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.243086ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/node-controller\" ","response":"range_response_count:1 size:195"} {"level":"info","ts":"2026-06-20T02:55:09.954449Z","caller":"traceutil/trace.go:171","msg":"trace[301559509] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:302; }","duration":"275.305917ms","start":"2026-06-20T02:55:09.679135Z","end":"2026-06-20T02:55:09.954441Z","steps":["trace[301559509] 'agreement among raft nodes before linearized reading' (duration: 275.247166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.954505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.959312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"warn","ts":"2026-06-20T02:55:09.954595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"332.893449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" ","response":"range_response_count:1 size:203"} {"level":"info","ts":"2026-06-20T02:55:09.954637Z","caller":"traceutil/trace.go:171","msg":"trace[145048635] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpoint-controller; range_end:; response_count:1; response_revision:302; }","duration":"332.95325ms","start":"2026-06-20T02:55:09.621674Z","end":"2026-06-20T02:55:09.954627Z","steps":["trace[145048635] 'agreement among raft nodes before linearized reading' (duration: 332.888257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.954674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.621664Z","time spent":"333.002911ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":226,"request content":"key:\"/registry/serviceaccounts/kube-system/endpoint-controller\" "} {"level":"info","ts":"2026-06-20T02:55:09.954555Z","caller":"traceutil/trace.go:171","msg":"trace[797756519] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:302; }","duration":"295.017134ms","start":"2026-06-20T02:55:09.659522Z","end":"2026-06-20T02:55:09.954539Z","steps":["trace[797756519] 'agreement among raft nodes before linearized reading' (duration: 294.948212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.954815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.022982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-20T02:55:09.954842Z","caller":"traceutil/trace.go:171","msg":"trace[871746215] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/deployment-controller; range_end:; response_count:1; response_revision:302; }","duration":"338.108315ms","start":"2026-06-20T02:55:09.616726Z","end":"2026-06-20T02:55:09.954834Z","steps":["trace[871746215] 'agreement among raft nodes before linearized reading' (duration: 338.060493ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.954878Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.616697Z","time spent":"338.173916ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/deployment-controller\" "} {"level":"warn","ts":"2026-06-20T02:55:09.954967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"347.299387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" ","response":"range_response_count:1 size:207"} {"level":"info","ts":"2026-06-20T02:55:09.954999Z","caller":"traceutil/trace.go:171","msg":"trace[306640085] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/daemon-set-controller; range_end:; response_count:1; response_revision:302; }","duration":"347.368537ms","start":"2026-06-20T02:55:09.607622Z","end":"2026-06-20T02:55:09.954991Z","steps":["trace[306640085] 'agreement among raft nodes before linearized reading' (duration: 347.318876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.955025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.6076Z","time spent":"347.419149ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":230,"request content":"key:\"/registry/serviceaccounts/kube-system/daemon-set-controller\" "} {"level":"warn","ts":"2026-06-20T02:55:09.955167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.449639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-06-20T02:55:09.955212Z","caller":"traceutil/trace.go:171","msg":"trace[1881803505] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:302; }","duration":"301.528541ms","start":"2026-06-20T02:55:09.653672Z","end":"2026-06-20T02:55:09.955201Z","steps":["trace[1881803505] 'agreement among raft nodes before linearized reading' (duration: 301.407178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.955253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.65365Z","time spent":"301.585422ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":216,"request content":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" "} {"level":"warn","ts":"2026-06-20T02:55:09.955389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.72504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-20T02:55:09.95542Z","caller":"traceutil/trace.go:171","msg":"trace[1188294273] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:302; }","duration":"302.772621ms","start":"2026-06-20T02:55:09.65264Z","end":"2026-06-20T02:55:09.955412Z","steps":["trace[1188294273] 'agreement among raft nodes before linearized reading' (duration: 302.72286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.955446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.652629Z","time spent":"302.811382ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/root-ca-cert-publisher\" "} {"level":"warn","ts":"2026-06-20T02:55:09.954442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.365122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" ","response":"range_response_count:1 size:197"} {"level":"warn","ts":"2026-06-20T02:55:09.955529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.153069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" ","response":"range_response_count:1 size:209"} {"level":"info","ts":"2026-06-20T02:55:09.955604Z","caller":"traceutil/trace.go:171","msg":"trace[1674067306] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/certificate-controller; range_end:; response_count:1; response_revision:302; }","duration":"305.255201ms","start":"2026-06-20T02:55:09.650338Z","end":"2026-06-20T02:55:09.955593Z","steps":["trace[1674067306] 'agreement among raft nodes before linearized reading' (duration: 305.139788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.955644Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.650327Z","time spent":"305.309043ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":1,"response size":232,"request content":"key:\"/registry/serviceaccounts/kube-system/certificate-controller\" "} {"level":"info","ts":"2026-06-20T02:55:09.95559Z","caller":"traceutil/trace.go:171","msg":"trace[377948980] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/bootstrap-signer; range_end:; response_count:1; response_revision:302; }","duration":"313.560531ms","start":"2026-06-20T02:55:09.642022Z","end":"2026-06-20T02:55:09.955582Z","steps":["trace[377948980] 'agreement among raft nodes before linearized reading' (duration: 312.368682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:09.955803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.641999Z","time spent":"313.792217ms","remote":"127.0.0.1:44276","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":1,"response size":220,"request content":"key:\"/registry/serviceaccounts/kube-system/bootstrap-signer\" "} {"level":"warn","ts":"2026-06-20T02:55:09.956351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:09.586915Z","time spent":"366.51897ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:55:25.655733Z","caller":"traceutil/trace.go:171","msg":"trace[1663823453] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"196.607388ms","start":"2026-06-20T02:55:25.459101Z","end":"2026-06-20T02:55:25.655709Z","steps":["trace[1663823453] 'process raft request' (duration: 196.525956ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:25.655742Z","caller":"traceutil/trace.go:171","msg":"trace[1739987213] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"199.671271ms","start":"2026-06-20T02:55:25.456039Z","end":"2026-06-20T02:55:25.65571Z","steps":["trace[1739987213] 'process raft request' (duration: 153.579238ms)","trace[1739987213] 'compare' (duration: 45.738064ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:39.971988Z","caller":"traceutil/trace.go:171","msg":"trace[630762823] linearizableReadLoop","detail":"{readStateIndex:510; appliedIndex:509; }","duration":"176.908251ms","start":"2026-06-20T02:55:39.795048Z","end":"2026-06-20T02:55:39.971956Z","steps":["trace[630762823] 'read index received' (duration: 176.144692ms)","trace[630762823] 'applied index is now lower than readState.Index' (duration: 762.109µs)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:39.972301Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.231749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:55:39.972479Z","caller":"traceutil/trace.go:171","msg":"trace[1273187383] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:0; response_revision:494; }","duration":"177.477725ms","start":"2026-06-20T02:55:39.794979Z","end":"2026-06-20T02:55:39.972457Z","steps":["trace[1273187383] 'agreement among raft nodes before linearized reading' (duration: 177.245389ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:39.972368Z","caller":"traceutil/trace.go:171","msg":"trace[617253274] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"191.72217ms","start":"2026-06-20T02:55:39.780631Z","end":"2026-06-20T02:55:39.972353Z","steps":["trace[617253274] 'process raft request' (duration: 190.712515ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:41.954676Z","caller":"traceutil/trace.go:171","msg":"trace[271069613] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:591; }","duration":"138.150296ms","start":"2026-06-20T02:55:41.816477Z","end":"2026-06-20T02:55:41.954627Z","steps":["trace[271069613] 'read index received' (duration: 137.341397ms)","trace[271069613] 'applied index is now lower than readState.Index' (duration: 807.909µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:41.954722Z","caller":"traceutil/trace.go:171","msg":"trace[424081768] transaction","detail":"{read_only:false; response_revision:573; number_of_response:1; }","duration":"141.337953ms","start":"2026-06-20T02:55:41.813356Z","end":"2026-06-20T02:55:41.954694Z","steps":["trace[424081768] 'process raft request' (duration: 140.588205ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:41.955013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.493655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:29476"} {"level":"info","ts":"2026-06-20T02:55:41.955055Z","caller":"traceutil/trace.go:171","msg":"trace[2118615559] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xlistenersets.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:573; }","duration":"138.585847ms","start":"2026-06-20T02:55:41.816454Z","end":"2026-06-20T02:55:41.95504Z","steps":["trace[2118615559] 'agreement among raft nodes before linearized reading' (duration: 138.31454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:42.30322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.617331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-06-20T02:55:42.303303Z","caller":"traceutil/trace.go:171","msg":"trace[1731963713] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:574; }","duration":"245.735954ms","start":"2026-06-20T02:55:42.057548Z","end":"2026-06-20T02:55:42.303284Z","steps":["trace[1731963713] 'range keys from in-memory index tree' (duration: 245.293124ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:46.496397Z","caller":"traceutil/trace.go:171","msg":"trace[815921473] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"139.011587ms","start":"2026-06-20T02:55:46.357354Z","end":"2026-06-20T02:55:46.496365Z","steps":["trace[815921473] 'process raft request' (duration: 138.889605ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:46.644321Z","caller":"traceutil/trace.go:171","msg":"trace[1241444224] transaction","detail":"{read_only:false; response_revision:601; number_of_response:1; }","duration":"145.524264ms","start":"2026-06-20T02:55:46.498776Z","end":"2026-06-20T02:55:46.6443Z","steps":["trace[1241444224] 'process raft request' (duration: 144.448707ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:46.672359Z","caller":"traceutil/trace.go:171","msg":"trace[604514669] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"172.6387ms","start":"2026-06-20T02:55:46.499693Z","end":"2026-06-20T02:55:46.672331Z","steps":["trace[604514669] 'process raft request' (duration: 172.472155ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:47.646319Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368478835617276,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-20T02:55:47.929237Z","caller":"traceutil/trace.go:171","msg":"trace[1356112540] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"1.132603908s","start":"2026-06-20T02:55:46.796604Z","end":"2026-06-20T02:55:47.929208Z","steps":["trace[1356112540] 'process raft request' (duration: 1.051140071s)","trace[1356112540] 'compare' (duration: 81.344475ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:47.929368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:46.796584Z","time spent":"1.132717912s","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:55:47.948131Z","caller":"traceutil/trace.go:171","msg":"trace[1760482123] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"761.888428ms","start":"2026-06-20T02:55:47.186204Z","end":"2026-06-20T02:55:47.948092Z","steps":["trace[1760482123] 'process raft request' (duration: 760.917585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:47.948558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:47.186169Z","time spent":"762.061911ms","remote":"127.0.0.1:44150","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:55:48.855629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.630646ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-20T02:55:48.855818Z","caller":"traceutil/trace.go:171","msg":"trace[1882308564] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:623; }","duration":"1.710478302s","start":"2026-06-20T02:55:47.145321Z","end":"2026-06-20T02:55:48.8558Z","steps":["trace[1882308564] 'read index received' (duration: 702.37412ms)","trace[1882308564] 'applied index is now lower than readState.Index' (duration: 1.008102752s)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:48.856375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.711039395s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T02:55:48.85649Z","caller":"traceutil/trace.go:171","msg":"trace[1163493772] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:605; }","duration":"1.711157818s","start":"2026-06-20T02:55:47.145277Z","end":"2026-06-20T02:55:48.856435Z","steps":["trace[1163493772] 'agreement among raft nodes before linearized reading' (duration: 1.710943873s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:48.856541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:47.145256Z","time spent":"1.711274452s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-20T02:55:49.23201Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999906271s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-20T02:55:49.23213Z","caller":"traceutil/trace.go:171","msg":"trace[1734718314] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000072425s","start":"2026-06-20T02:55:47.232042Z","end":"2026-06-20T02:55:49.232115Z","steps":["trace[1734718314] 'agreement among raft nodes before linearized reading' (duration: 1.999938842s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:49.232239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:47.232023Z","time spent":"2.000205089s","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/20 02:55:49 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-20T02:55:49.35693Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368478835617281,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-20T02:55:49.438011Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.432509201s","expected-duration":"1s"} {"level":"info","ts":"2026-06-20T02:55:49.438574Z","caller":"traceutil/trace.go:171","msg":"trace[78965167] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"1.433151926s","start":"2026-06-20T02:55:48.005393Z","end":"2026-06-20T02:55:49.438545Z","steps":["trace[78965167] 'process raft request' (duration: 1.4329271s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:49.438727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:48.005371Z","time spent":"1.433283709s","remote":"127.0.0.1:44534","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T02:55:49.648901Z","caller":"traceutil/trace.go:171","msg":"trace[1847057392] linearizableReadLoop","detail":"{readStateIndex:628; appliedIndex:626; }","duration":"793.003969ms","start":"2026-06-20T02:55:48.855871Z","end":"2026-06-20T02:55:49.648875Z","steps":["trace[1847057392] 'read index received' (duration: 582.510276ms)","trace[1847057392] 'applied index is now lower than readState.Index' (duration: 210.492583ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:49.649143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.148362709s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-20T02:55:49.649146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"973.010235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-20T02:55:49.649176Z","caller":"traceutil/trace.go:171","msg":"trace[973048711] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"1.148450662s","start":"2026-06-20T02:55:48.500715Z","end":"2026-06-20T02:55:49.649166Z","steps":["trace[973048711] 'agreement among raft nodes before linearized reading' (duration: 1.148297408s)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:49.649194Z","caller":"traceutil/trace.go:171","msg":"trace[1490020175] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:607; }","duration":"973.116097ms","start":"2026-06-20T02:55:48.676065Z","end":"2026-06-20T02:55:49.649182Z","steps":["trace[1490020175] 'agreement among raft nodes before linearized reading' (duration: 972.848381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:49.64921Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:48.500695Z","time spent":"1.148507322s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-20T02:55:49.64923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:48.676045Z","time spent":"973.174619ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-20T02:55:49.649415Z","caller":"traceutil/trace.go:171","msg":"trace[642195449] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"788.10365ms","start":"2026-06-20T02:55:48.861277Z","end":"2026-06-20T02:55:49.649381Z","steps":["trace[642195449] 'process raft request' (duration: 736.436762ms)","trace[642195449] 'compare' (duration: 51.016542ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:49.649522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.657709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T02:55:49.649528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:48.861261Z","time spent":"788.209203ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:55:49.649565Z","caller":"traceutil/trace.go:171","msg":"trace[1386036688] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:607; }","duration":"201.732331ms","start":"2026-06-20T02:55:49.447822Z","end":"2026-06-20T02:55:49.649554Z","steps":["trace[1386036688] 'agreement among raft nodes before linearized reading' (duration: 201.67542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:49.649554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.634236301s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-20T02:55:49.649627Z","caller":"traceutil/trace.go:171","msg":"trace[1847839741] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"1.634362434s","start":"2026-06-20T02:55:48.015246Z","end":"2026-06-20T02:55:49.649609Z","steps":["trace[1847839741] 'agreement among raft nodes before linearized reading' (duration: 1.634134819s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:49.64931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.874606ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T02:55:49.649684Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:48.015221Z","time spent":"1.634441765s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-20T02:55:49.649698Z","caller":"traceutil/trace.go:171","msg":"trace[1622298008] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"417.311267ms","start":"2026-06-20T02:55:49.232373Z","end":"2026-06-20T02:55:49.649684Z","steps":["trace[1622298008] 'agreement among raft nodes before linearized reading' (duration: 416.858046ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:49.64973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:49.232361Z","time spent":"417.360488ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-20T02:55:50.337911Z","caller":"traceutil/trace.go:171","msg":"trace[1431395938] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"104.679537ms","start":"2026-06-20T02:55:50.233205Z","end":"2026-06-20T02:55:50.337885Z","steps":["trace[1431395938] 'read index received' (duration: 69.21984ms)","trace[1431395938] 'applied index is now lower than readState.Index' (duration: 35.458707ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:50.337961Z","caller":"traceutil/trace.go:171","msg":"trace[2130785400] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"119.441114ms","start":"2026-06-20T02:55:50.218497Z","end":"2026-06-20T02:55:50.337938Z","steps":["trace[2130785400] 'process raft request' (duration: 83.951457ms)","trace[2130785400] 'compare' (duration: 35.292353ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:50.338098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.873782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:55:50.33814Z","caller":"traceutil/trace.go:171","msg":"trace[2017529244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"104.952294ms","start":"2026-06-20T02:55:50.233175Z","end":"2026-06-20T02:55:50.338127Z","steps":["trace[2017529244] 'agreement among raft nodes before linearized reading' (duration: 104.813451ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:50.942033Z","caller":"traceutil/trace.go:171","msg":"trace[1721142442] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"164.556364ms","start":"2026-06-20T02:55:50.777447Z","end":"2026-06-20T02:55:50.942004Z","steps":["trace[1721142442] 'process raft request' (duration: 164.40574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:52.09457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"439.984034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T02:55:52.094655Z","caller":"traceutil/trace.go:171","msg":"trace[1793815187] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:626; }","duration":"440.113867ms","start":"2026-06-20T02:55:51.654521Z","end":"2026-06-20T02:55:52.094635Z","steps":["trace[1793815187] 'range keys from in-memory index tree' (duration: 439.82498ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:52.094695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:51.6545Z","time spent":"440.186509ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-20T02:55:52.094888Z","caller":"traceutil/trace.go:171","msg":"trace[632945774] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"439.79461ms","start":"2026-06-20T02:55:51.65508Z","end":"2026-06-20T02:55:52.094874Z","steps":["trace[632945774] 'process raft request' (duration: 430.233269ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:52.09485Z","caller":"traceutil/trace.go:171","msg":"trace[1782908090] linearizableReadLoop","detail":"{readStateIndex:648; appliedIndex:647; }","duration":"413.400162ms","start":"2026-06-20T02:55:51.681407Z","end":"2026-06-20T02:55:52.094807Z","steps":["trace[1782908090] 'read index received' (duration: 403.852922ms)","trace[1782908090] 'applied index is now lower than readState.Index' (duration: 9.54448ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:52.094977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:51.655062Z","time spent":"439.854851ms","remote":"127.0.0.1:44340","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-06-20T02:55:52.095148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.71622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-20T02:55:52.0952Z","caller":"traceutil/trace.go:171","msg":"trace[431835942] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:627; }","duration":"413.847112ms","start":"2026-06-20T02:55:51.681339Z","end":"2026-06-20T02:55:52.095186Z","steps":["trace[431835942] 'agreement among raft nodes before linearized reading' (duration: 413.648877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:52.095197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.34285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-qgn9v\" ","response":"range_response_count:1 size:17524"} {"level":"warn","ts":"2026-06-20T02:55:52.095245Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:51.681316Z","time spent":"413.919644ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-20T02:55:52.095266Z","caller":"traceutil/trace.go:171","msg":"trace[45464334] range","detail":"{range_begin:/registry/pods/kube-system/cilium-qgn9v; range_end:; response_count:1; response_revision:627; }","duration":"326.450953ms","start":"2026-06-20T02:55:51.768795Z","end":"2026-06-20T02:55:52.095246Z","steps":["trace[45464334] 'agreement among raft nodes before linearized reading' (duration: 326.283609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:52.095289Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.556155ms","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-06-20T02:55:52.095305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:51.768777Z","time spent":"326.520844ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":17547,"request content":"key:\"/registry/pods/kube-system/cilium-qgn9v\" "} {"level":"warn","ts":"2026-06-20T02:55:52.095256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.691359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-20T02:55:52.095394Z","caller":"traceutil/trace.go:171","msg":"trace[383961948] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:627; }","duration":"413.914894ms","start":"2026-06-20T02:55:51.681463Z","end":"2026-06-20T02:55:52.095378Z","steps":["trace[383961948] 'agreement among raft nodes before linearized reading' (duration: 413.598896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:52.095487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:51.681455Z","time spent":"414.020537ms","remote":"127.0.0.1:44340","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-06-20T02:55:52.095339Z","caller":"traceutil/trace.go:171","msg":"trace[894156582] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:627; }","duration":"413.655218ms","start":"2026-06-20T02:55:51.681673Z","end":"2026-06-20T02:55:52.095328Z","steps":["trace[894156582] 'agreement among raft nodes before linearized reading' (duration: 413.535265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:52.095738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:51.681663Z","time spent":"414.062109ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-20T02:55:52.284427Z","caller":"traceutil/trace.go:171","msg":"trace[769818639] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"184.717311ms","start":"2026-06-20T02:55:52.099686Z","end":"2026-06-20T02:55:52.284403Z","steps":["trace[769818639] 'process raft request' (duration: 178.208534ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:52.284789Z","caller":"traceutil/trace.go:171","msg":"trace[1900112182] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"185.008417ms","start":"2026-06-20T02:55:52.099758Z","end":"2026-06-20T02:55:52.284767Z","steps":["trace[1900112182] 'process raft request' (duration: 184.602048ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:52.284903Z","caller":"traceutil/trace.go:171","msg":"trace[1644235854] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"185.071839ms","start":"2026-06-20T02:55:52.099817Z","end":"2026-06-20T02:55:52.284889Z","steps":["trace[1644235854] 'process raft request' (duration: 184.835794ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:52.284849Z","caller":"traceutil/trace.go:171","msg":"trace[534111800] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"175.011926ms","start":"2026-06-20T02:55:52.109814Z","end":"2026-06-20T02:55:52.284826Z","steps":["trace[534111800] 'process raft request' (duration: 174.949914ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:52.713327Z","caller":"traceutil/trace.go:171","msg":"trace[90650321] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"169.353129ms","start":"2026-06-20T02:55:52.54395Z","end":"2026-06-20T02:55:52.713303Z","steps":["trace[90650321] 'process raft request' (duration: 169.183895ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:52.915967Z","caller":"traceutil/trace.go:171","msg":"trace[764452472] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"138.724859ms","start":"2026-06-20T02:55:52.777211Z","end":"2026-06-20T02:55:52.915936Z","steps":["trace[764452472] 'process raft request' (duration: 115.728414ms)","trace[764452472] 'compare' (duration: 22.76432ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:52.933704Z","caller":"traceutil/trace.go:171","msg":"trace[1608462295] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"144.963841ms","start":"2026-06-20T02:55:52.788717Z","end":"2026-06-20T02:55:52.93368Z","steps":["trace[1608462295] 'process raft request' (duration: 144.813568ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:53.348458Z","caller":"traceutil/trace.go:171","msg":"trace[1342074368] linearizableReadLoop","detail":"{readStateIndex:660; appliedIndex:659; }","duration":"153.851855ms","start":"2026-06-20T02:55:53.194586Z","end":"2026-06-20T02:55:53.348438Z","steps":["trace[1342074368] 'read index received' (duration: 153.62877ms)","trace[1342074368] 'applied index is now lower than readState.Index' (duration: 222.135µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:53.348479Z","caller":"traceutil/trace.go:171","msg":"trace[159789999] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"163.507608ms","start":"2026-06-20T02:55:53.184948Z","end":"2026-06-20T02:55:53.348456Z","steps":["trace[159789999] 'process raft request' (duration: 163.363495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:53.348613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.012839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-20T02:55:53.348951Z","caller":"traceutil/trace.go:171","msg":"trace[1116246050] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:638; }","duration":"154.370658ms","start":"2026-06-20T02:55:53.194554Z","end":"2026-06-20T02:55:53.348925Z","steps":["trace[1116246050] 'agreement among raft nodes before linearized reading' (duration: 153.974078ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:53.349048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.280326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:55:53.349139Z","caller":"traceutil/trace.go:171","msg":"trace[1385681429] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"118.392078ms","start":"2026-06-20T02:55:53.23073Z","end":"2026-06-20T02:55:53.349122Z","steps":["trace[1385681429] 'agreement among raft nodes before linearized reading' (duration: 118.164573ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:53.549458Z","caller":"traceutil/trace.go:171","msg":"trace[916497448] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"164.381769ms","start":"2026-06-20T02:55:53.385056Z","end":"2026-06-20T02:55:53.549437Z","steps":["trace[916497448] 'process raft request' (duration: 164.329688ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:53.54956Z","caller":"traceutil/trace.go:171","msg":"trace[63497100] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"164.973493ms","start":"2026-06-20T02:55:53.384549Z","end":"2026-06-20T02:55:53.549522Z","steps":["trace[63497100] 'process raft request' (duration: 161.225543ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:53.806421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.627514ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:55:53.806613Z","caller":"traceutil/trace.go:171","msg":"trace[1056000909] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"225.765951ms","start":"2026-06-20T02:55:53.58083Z","end":"2026-06-20T02:55:53.806596Z","steps":["trace[1056000909] 'process raft request' (duration: 225.73003ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:53.806622Z","caller":"traceutil/trace.go:171","msg":"trace[1190306915] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"249.075525ms","start":"2026-06-20T02:55:53.557513Z","end":"2026-06-20T02:55:53.806589Z","steps":["trace[1190306915] 'process raft request' (duration: 147.206005ms)","trace[1190306915] 'compare' (duration: 101.518691ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:53.806657Z","caller":"traceutil/trace.go:171","msg":"trace[1336181692] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"247.337842ms","start":"2026-06-20T02:55:53.559293Z","end":"2026-06-20T02:55:53.806631Z","steps":["trace[1336181692] 'process raft request' (duration: 247.215379ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:53.893638Z","caller":"traceutil/trace.go:171","msg":"trace[1353992825] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"111.511613ms","start":"2026-06-20T02:55:53.782103Z","end":"2026-06-20T02:55:53.893614Z","steps":["trace[1353992825] 'process raft request' (duration: 111.37933ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:54.623747Z","caller":"traceutil/trace.go:171","msg":"trace[574248895] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"810.724096ms","start":"2026-06-20T02:55:53.812998Z","end":"2026-06-20T02:55:54.623722Z","steps":["trace[574248895] 'process raft request' (duration: 776.596882ms)","trace[574248895] 'compare' (duration: 33.665043ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:54.623903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:53.812982Z","time spent":"810.846529ms","remote":"127.0.0.1:44092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5162,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:55:54.624102Z","caller":"traceutil/trace.go:171","msg":"trace[1187304792] transaction","detail":"{read_only:false; response_revision:649; number_of_response:1; }","duration":"810.199423ms","start":"2026-06-20T02:55:53.813893Z","end":"2026-06-20T02:55:54.624092Z","steps":["trace[1187304792] 'process raft request' (duration: 809.749882ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.624162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:53.813879Z","time spent":"810.253125ms","remote":"127.0.0.1:44092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9296,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:55:54.624496Z","caller":"traceutil/trace.go:171","msg":"trace[871968963] linearizableReadLoop","detail":"{readStateIndex:671; appliedIndex:668; }","duration":"740.542731ms","start":"2026-06-20T02:55:53.883929Z","end":"2026-06-20T02:55:54.624472Z","steps":["trace[871968963] 'read index received' (duration: 9.5572ms)","trace[871968963] 'applied index is now lower than readState.Index' (duration: 730.983371ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:54.624513Z","caller":"traceutil/trace.go:171","msg":"trace[1781129145] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"736.863604ms","start":"2026-06-20T02:55:53.887629Z","end":"2026-06-20T02:55:54.624492Z","steps":["trace[1781129145] 'process raft request' (duration: 736.409993ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.624627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:53.887606Z","time spent":"736.958465ms","remote":"127.0.0.1:44134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":700,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T02:55:54.624732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"740.787837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-qwqwg\" ","response":"range_response_count:1 size:4683"} {"level":"info","ts":"2026-06-20T02:55:54.624775Z","caller":"traceutil/trace.go:171","msg":"trace[1219712260] range","detail":"{range_begin:/registry/pods/kube-system/cilium-operator-869df985b8-qwqwg; range_end:; response_count:1; response_revision:650; }","duration":"740.861409ms","start":"2026-06-20T02:55:53.883904Z","end":"2026-06-20T02:55:54.624765Z","steps":["trace[1219712260] 'agreement among raft nodes before linearized reading' (duration: 740.674105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.624805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:53.883894Z","time spent":"740.90374ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":61,"response count":1,"response size":4706,"request content":"key:\"/registry/pods/kube-system/cilium-operator-869df985b8-qwqwg\" "} {"level":"warn","ts":"2026-06-20T02:55:54.632526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.127196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-20T02:55:54.632587Z","caller":"traceutil/trace.go:171","msg":"trace[1612307125] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:654; }","duration":"500.231699ms","start":"2026-06-20T02:55:54.13234Z","end":"2026-06-20T02:55:54.632572Z","steps":["trace[1612307125] 'agreement among raft nodes before linearized reading' (duration: 500.004983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.632616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:54.13232Z","time spent":"500.29009ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-20T02:55:54.632799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.746461ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-20T02:55:54.632817Z","caller":"traceutil/trace.go:171","msg":"trace[239610685] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:654; }","duration":"343.806623ms","start":"2026-06-20T02:55:54.289004Z","end":"2026-06-20T02:55:54.632811Z","steps":["trace[239610685] 'agreement among raft nodes before linearized reading' (duration: 343.751281ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:54.632812Z","caller":"traceutil/trace.go:171","msg":"trace[60523628] transaction","detail":"{read_only:false; response_revision:651; number_of_response:1; }","duration":"650.364154ms","start":"2026-06-20T02:55:53.982429Z","end":"2026-06-20T02:55:54.632793Z","steps":["trace[60523628] 'process raft request' (duration: 649.78299ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.632874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"343.908955ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-20T02:55:54.63289Z","caller":"traceutil/trace.go:171","msg":"trace[1650215388] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:654; }","duration":"343.966456ms","start":"2026-06-20T02:55:54.288919Z","end":"2026-06-20T02:55:54.632886Z","steps":["trace[1650215388] 'agreement among raft nodes before linearized reading' (duration: 343.925035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.632896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:53.982399Z","time spent":"650.452277ms","remote":"127.0.0.1:44092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T02:55:54.632905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:54.288894Z","time spent":"344.007137ms","remote":"127.0.0.1:44340","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-06-20T02:55:54.633008Z","caller":"traceutil/trace.go:171","msg":"trace[1648552800] transaction","detail":"{read_only:false; response_revision:652; number_of_response:1; }","duration":"451.727848ms","start":"2026-06-20T02:55:54.181269Z","end":"2026-06-20T02:55:54.632996Z","steps":["trace[1648552800] 'process raft request' (duration: 451.004281ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.633039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"401.870134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T02:55:54.633052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:54.181243Z","time spent":"451.790349ms","remote":"127.0.0.1:44092","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4580,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-20T02:55:54.633143Z","caller":"traceutil/trace.go:171","msg":"trace[1586385144] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"249.931295ms","start":"2026-06-20T02:55:54.383204Z","end":"2026-06-20T02:55:54.633136Z","steps":["trace[1586385144] 'process raft request' (duration: 249.090065ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.633016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.191911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-20T02:55:54.633216Z","caller":"traceutil/trace.go:171","msg":"trace[2009320375] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:654; }","duration":"344.416927ms","start":"2026-06-20T02:55:54.288793Z","end":"2026-06-20T02:55:54.63321Z","steps":["trace[2009320375] 'agreement among raft nodes before linearized reading' (duration: 344.185922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.633254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:54.288733Z","time spent":"344.498569ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-20T02:55:54.632834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:54.288975Z","time spent":"343.855053ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-20T02:55:54.633057Z","caller":"traceutil/trace.go:171","msg":"trace[1198981875] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:654; }","duration":"401.916185ms","start":"2026-06-20T02:55:54.231135Z","end":"2026-06-20T02:55:54.633051Z","steps":["trace[1198981875] 'agreement among raft nodes before linearized reading' (duration: 401.891765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:54.633551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:54.231119Z","time spent":"402.425197ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T02:55:55.900515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.848113ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:55:55.900664Z","caller":"traceutil/trace.go:171","msg":"trace[1528283966] linearizableReadLoop","detail":"{readStateIndex:704; appliedIndex:703; }","duration":"319.980446ms","start":"2026-06-20T02:55:55.580661Z","end":"2026-06-20T02:55:55.900641Z","steps":["trace[1528283966] 'read index received' (duration: 127.816976ms)","trace[1528283966] 'applied index is now lower than readState.Index' (duration: 192.16176ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:55.900906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.894075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:1 size:4180"} {"level":"info","ts":"2026-06-20T02:55:55.900973Z","caller":"traceutil/trace.go:171","msg":"trace[1686142629] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:1; response_revision:682; }","duration":"119.993588ms","start":"2026-06-20T02:55:55.780958Z","end":"2026-06-20T02:55:55.900951Z","steps":["trace[1686142629] 'agreement among raft nodes before linearized reading' (duration: 119.823844ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:55.900972Z","caller":"traceutil/trace.go:171","msg":"trace[888491056] transaction","detail":"{read_only:false; response_revision:682; number_of_response:1; }","duration":"459.356223ms","start":"2026-06-20T02:55:55.441598Z","end":"2026-06-20T02:55:55.900954Z","steps":["trace[888491056] 'process raft request' (duration: 266.975977ms)","trace[888491056] 'compare' (duration: 191.733871ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:55:55.90113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:55.441583Z","time spent":"459.440684ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:55:55.900918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.246213ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-06-20T02:55:55.901281Z","caller":"traceutil/trace.go:171","msg":"trace[700272060] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:682; }","duration":"320.658732ms","start":"2026-06-20T02:55:55.580605Z","end":"2026-06-20T02:55:55.901264Z","steps":["trace[700272060] 'agreement among raft nodes before linearized reading' (duration: 320.166051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:55.901342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:55:55.580581Z","time spent":"320.744896ms","remote":"127.0.0.1:44092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9343,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" "} {"level":"info","ts":"2026-06-20T02:55:56.338597Z","caller":"traceutil/trace.go:171","msg":"trace[1405835524] linearizableReadLoop","detail":"{readStateIndex:709; appliedIndex:708; }","duration":"105.400805ms","start":"2026-06-20T02:55:56.233156Z","end":"2026-06-20T02:55:56.338557Z","steps":["trace[1405835524] 'read index received' (duration: 105.18954ms)","trace[1405835524] 'applied index is now lower than readState.Index' (duration: 210.225µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:55:56.338682Z","caller":"traceutil/trace.go:171","msg":"trace[1585326582] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"154.204414ms","start":"2026-06-20T02:55:56.184449Z","end":"2026-06-20T02:55:56.338653Z","steps":["trace[1585326582] 'process raft request' (duration: 153.883476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:55:56.338801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.62613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:55:56.338857Z","caller":"traceutil/trace.go:171","msg":"trace[1595275865] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:687; }","duration":"105.738483ms","start":"2026-06-20T02:55:56.233107Z","end":"2026-06-20T02:55:56.338845Z","steps":["trace[1595275865] 'agreement among raft nodes before linearized reading' (duration: 105.565999ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:55:57.763939Z","caller":"traceutil/trace.go:171","msg":"trace[302173884] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"100.552208ms","start":"2026-06-20T02:55:57.663361Z","end":"2026-06-20T02:55:57.763913Z","steps":["trace[302173884] 'process raft request' (duration: 100.331792ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:06.703198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"762.05669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-20T02:56:06.70328Z","caller":"traceutil/trace.go:171","msg":"trace[592373280] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:768; }","duration":"762.177733ms","start":"2026-06-20T02:56:05.941085Z","end":"2026-06-20T02:56:06.703262Z","steps":["trace[592373280] 'range keys from in-memory index tree' (duration: 761.890326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:06.70332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:05.941068Z","time spent":"762.243324ms","remote":"127.0.0.1:44340","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-06-20T02:56:06.703439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.433557ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:56:06.703543Z","caller":"traceutil/trace.go:171","msg":"trace[1731915717] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"472.57678ms","start":"2026-06-20T02:56:06.230943Z","end":"2026-06-20T02:56:06.70352Z","steps":["trace[1731915717] 'range keys from in-memory index tree' (duration: 472.357045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:06.703652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:06.230924Z","time spent":"472.700773ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T02:56:06.703949Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.425457ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wlbtx\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-20T02:56:06.704129Z","caller":"traceutil/trace.go:171","msg":"trace[149240081] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wlbtx; range_end:; response_count:1; response_revision:768; }","duration":"747.658672ms","start":"2026-06-20T02:56:05.956415Z","end":"2026-06-20T02:56:06.704073Z","steps":["trace[149240081] 'range keys from in-memory index tree' (duration: 747.034728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:06.704218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:05.956392Z","time spent":"747.811756ms","remote":"127.0.0.1:44252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3988,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-wlbtx\" "} {"level":"info","ts":"2026-06-20T02:56:06.818753Z","caller":"traceutil/trace.go:171","msg":"trace[1255966123] transaction","detail":"{read_only:false; response_revision:770; number_of_response:1; }","duration":"111.205096ms","start":"2026-06-20T02:56:06.707519Z","end":"2026-06-20T02:56:06.818724Z","steps":["trace[1255966123] 'process raft request' (duration: 111.159755ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:06.818847Z","caller":"traceutil/trace.go:171","msg":"trace[2090370169] transaction","detail":"{read_only:false; response_revision:769; number_of_response:1; }","duration":"111.293978ms","start":"2026-06-20T02:56:06.707519Z","end":"2026-06-20T02:56:06.818813Z","steps":["trace[2090370169] 'process raft request' (duration: 111.004991ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:06.955365Z","caller":"traceutil/trace.go:171","msg":"trace[256360344] transaction","detail":"{read_only:false; response_revision:771; number_of_response:1; }","duration":"247.754194ms","start":"2026-06-20T02:56:06.707578Z","end":"2026-06-20T02:56:06.955333Z","steps":["trace[256360344] 'process raft request' (duration: 247.036467ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:06.955634Z","caller":"traceutil/trace.go:171","msg":"trace[991350074] transaction","detail":"{read_only:false; response_revision:772; number_of_response:1; }","duration":"247.750463ms","start":"2026-06-20T02:56:06.707849Z","end":"2026-06-20T02:56:06.9556Z","steps":["trace[991350074] 'process raft request' (duration: 247.340253ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:06.956698Z","caller":"traceutil/trace.go:171","msg":"trace[1207094515] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"248.244385ms","start":"2026-06-20T02:56:06.708435Z","end":"2026-06-20T02:56:06.956679Z","steps":["trace[1207094515] 'process raft request' (duration: 247.801284ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:06.956806Z","caller":"traceutil/trace.go:171","msg":"trace[133349582] transaction","detail":"{read_only:false; response_revision:774; number_of_response:1; }","duration":"245.970909ms","start":"2026-06-20T02:56:06.71082Z","end":"2026-06-20T02:56:06.956791Z","steps":["trace[133349582] 'process raft request' (duration: 245.785505ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:10.961673Z","caller":"traceutil/trace.go:171","msg":"trace[1551582524] transaction","detail":"{read_only:false; response_revision:791; number_of_response:1; }","duration":"119.184389ms","start":"2026-06-20T02:56:10.841437Z","end":"2026-06-20T02:56:10.960621Z","steps":["trace[1551582524] 'process raft request' (duration: 34.396091ms)","trace[1551582524] 'compare' (duration: 84.659995ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:56:11.31017Z","caller":"traceutil/trace.go:171","msg":"trace[966408963] transaction","detail":"{read_only:false; response_revision:797; number_of_response:1; }","duration":"153.169329ms","start":"2026-06-20T02:56:11.156963Z","end":"2026-06-20T02:56:11.310132Z","steps":["trace[966408963] 'process raft request' (duration: 144.722825ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:15.222979Z","caller":"traceutil/trace.go:171","msg":"trace[644593459] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"149.770296ms","start":"2026-06-20T02:56:15.073181Z","end":"2026-06-20T02:56:15.222952Z","steps":["trace[644593459] 'process raft request' (duration: 103.296504ms)","trace[644593459] 'compare' (duration: 46.147804ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:56:36.586418Z","caller":"traceutil/trace.go:171","msg":"trace[270251047] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"109.808361ms","start":"2026-06-20T02:56:36.476586Z","end":"2026-06-20T02:56:36.586394Z","steps":["trace[270251047] 'process raft request' (duration: 27.904714ms)","trace[270251047] 'compare' (duration: 81.821926ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:56:41.133444Z","caller":"traceutil/trace.go:171","msg":"trace[1526087721] linearizableReadLoop","detail":"{readStateIndex:1016; appliedIndex:1015; }","duration":"117.156238ms","start":"2026-06-20T02:56:41.016267Z","end":"2026-06-20T02:56:41.133423Z","steps":["trace[1526087721] 'read index received' (duration: 116.993054ms)","trace[1526087721] 'applied index is now lower than readState.Index' (duration: 162.444µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:56:41.1336Z","caller":"traceutil/trace.go:171","msg":"trace[931500512] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"121.872933ms","start":"2026-06-20T02:56:41.01169Z","end":"2026-06-20T02:56:41.133563Z","steps":["trace[931500512] 'process raft request' (duration: 121.595096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:41.133647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.365613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:1 size:2897"} {"level":"info","ts":"2026-06-20T02:56:41.133692Z","caller":"traceutil/trace.go:171","msg":"trace[450856781] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:1; response_revision:982; }","duration":"117.457285ms","start":"2026-06-20T02:56:41.016225Z","end":"2026-06-20T02:56:41.133682Z","steps":["trace[450856781] 'agreement among raft nodes before linearized reading' (duration: 117.282421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:43.006688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:42.533565Z","time spent":"473.120635ms","remote":"127.0.0.1:44066","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-06-20T02:56:44.453273Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.446618691s","expected-duration":"1s"} {"level":"info","ts":"2026-06-20T02:56:44.454265Z","caller":"traceutil/trace.go:171","msg":"trace[251972732] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"1.785144045s","start":"2026-06-20T02:56:42.669068Z","end":"2026-06-20T02:56:44.454212Z","steps":["trace[251972732] 'process raft request' (duration: 1.784688485s)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:44.454433Z","caller":"traceutil/trace.go:171","msg":"trace[880388822] linearizableReadLoop","detail":"{readStateIndex:1026; appliedIndex:1025; }","duration":"1.482947519s","start":"2026-06-20T02:56:42.971451Z","end":"2026-06-20T02:56:44.454399Z","steps":["trace[880388822] 'read index received' (duration: 35.287262ms)","trace[880388822] 'applied index is now lower than readState.Index' (duration: 1.447657677s)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:56:44.454535Z","caller":"traceutil/trace.go:171","msg":"trace[338741216] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"1.455691631s","start":"2026-06-20T02:56:42.998775Z","end":"2026-06-20T02:56:44.454466Z","steps":["trace[338741216] 'process raft request' (duration: 1.455284521s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:44.454617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.483141864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-20T02:56:44.454615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:42.669042Z","time spent":"1.785386801s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:56:44.454657Z","caller":"traceutil/trace.go:171","msg":"trace[1254998247] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:992; }","duration":"1.483214756s","start":"2026-06-20T02:56:42.971431Z","end":"2026-06-20T02:56:44.454645Z","steps":["trace[1254998247] 'agreement among raft nodes before linearized reading' (duration: 1.483105833s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:44.454695Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:42.971407Z","time spent":"1.483278837s","remote":"127.0.0.1:44494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":2,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-20T02:56:44.454746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:42.998757Z","time spent":"1.455855955s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:56:44.462135Z","caller":"traceutil/trace.go:171","msg":"trace[964967956] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"1.454348589s","start":"2026-06-20T02:56:43.007761Z","end":"2026-06-20T02:56:44.462109Z","steps":["trace[964967956] 'process raft request' (duration: 1.451702036s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:44.462211Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.437626545s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T02:56:44.462233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.957688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T02:56:44.462278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:43.007749Z","time spent":"1.454453792s","remote":"127.0.0.1:44066","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:56:44.462285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18443482s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T02:56:44.462288Z","caller":"traceutil/trace.go:171","msg":"trace[1017657107] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:993; }","duration":"1.437751648s","start":"2026-06-20T02:56:43.024514Z","end":"2026-06-20T02:56:44.462265Z","steps":["trace[1017657107] 'agreement among raft nodes before linearized reading' (duration: 1.437589774s)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:44.462294Z","caller":"traceutil/trace.go:171","msg":"trace[1523415625] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:993; }","duration":"231.051299ms","start":"2026-06-20T02:56:44.231227Z","end":"2026-06-20T02:56:44.462278Z","steps":["trace[1523415625] 'agreement among raft nodes before linearized reading' (duration: 230.950157ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:44.462332Z","caller":"traceutil/trace.go:171","msg":"trace[1092851718] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:993; }","duration":"1.184500212s","start":"2026-06-20T02:56:43.277817Z","end":"2026-06-20T02:56:44.462318Z","steps":["trace[1092851718] 'agreement among raft nodes before linearized reading' (duration: 1.184321448s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:44.462345Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:43.024504Z","time spent":"1.43782994s","remote":"127.0.0.1:44318","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":0,"response size":28,"request content":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true "} {"level":"warn","ts":"2026-06-20T02:56:44.462361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:43.277807Z","time spent":"1.184546323s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-20T02:56:44.462543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.093512356s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-20T02:56:44.462571Z","caller":"traceutil/trace.go:171","msg":"trace[1072861960] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.093560517s","start":"2026-06-20T02:56:43.369002Z","end":"2026-06-20T02:56:44.462562Z","steps":["trace[1072861960] 'agreement among raft nodes before linearized reading' (duration: 1.093472995s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:44.462545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.184775039s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-20T02:56:44.462626Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.325312263s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-20T02:56:44.462654Z","caller":"traceutil/trace.go:171","msg":"trace[686654444] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:993; }","duration":"1.184969484s","start":"2026-06-20T02:56:43.277659Z","end":"2026-06-20T02:56:44.462629Z","steps":["trace[686654444] 'agreement among raft nodes before linearized reading' (duration: 1.184626066s)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:56:44.462658Z","caller":"traceutil/trace.go:171","msg":"trace[520787622] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.325370503s","start":"2026-06-20T02:56:43.137278Z","end":"2026-06-20T02:56:44.462649Z","steps":["trace[520787622] 'agreement among raft nodes before linearized reading' (duration: 1.325279961s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:44.462701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:43.137265Z","time spent":"1.325429105s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T02:56:44.462718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:43.277647Z","time spent":"1.185056866s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-20T02:56:44.462599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:43.368992Z","time spent":"1.093600328s","remote":"127.0.0.1:44340","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-06-20T02:56:44.462909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.18728991s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-20T02:56:44.464144Z","caller":"traceutil/trace.go:171","msg":"trace[613896342] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:993; }","duration":"1.188655243s","start":"2026-06-20T02:56:43.275476Z","end":"2026-06-20T02:56:44.464132Z","steps":["trace[613896342] 'agreement among raft nodes before linearized reading' (duration: 1.186718046s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:44.464176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:43.275455Z","time spent":"1.188708973s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-20T02:56:57.351335Z","caller":"traceutil/trace.go:171","msg":"trace[667306302] transaction","detail":"{read_only:false; response_revision:1038; number_of_response:1; }","duration":"400.247275ms","start":"2026-06-20T02:56:56.951062Z","end":"2026-06-20T02:56:57.351309Z","steps":["trace[667306302] 'process raft request' (duration: 400.06995ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:56:57.351506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:56:56.951028Z","time spent":"400.389148ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:56:58.691338Z","caller":"traceutil/trace.go:171","msg":"trace[1366468609] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"108.348006ms","start":"2026-06-20T02:56:58.582966Z","end":"2026-06-20T02:56:58.691314Z","steps":["trace[1366468609] 'process raft request' (duration: 97.371771ms)","trace[1366468609] 'compare' (duration: 10.840892ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:56:58.691522Z","caller":"traceutil/trace.go:171","msg":"trace[1515130390] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"105.972799ms","start":"2026-06-20T02:56:58.585526Z","end":"2026-06-20T02:56:58.691499Z","steps":["trace[1515130390] 'process raft request' (duration: 105.749623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:05.093757Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.804378ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:57:05.093958Z","caller":"traceutil/trace.go:171","msg":"trace[320290615] transaction","detail":"{read_only:false; response_revision:1060; number_of_response:1; }","duration":"447.794873ms","start":"2026-06-20T02:57:04.646149Z","end":"2026-06-20T02:57:05.093944Z","steps":["trace[320290615] 'process raft request' (duration: 447.70492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:05.094052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:04.646131Z","time spent":"447.854625ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:57:05.094234Z","caller":"traceutil/trace.go:171","msg":"trace[914402242] transaction","detail":"{read_only:false; response_revision:1059; number_of_response:1; }","duration":"450.489198ms","start":"2026-06-20T02:57:04.64373Z","end":"2026-06-20T02:57:05.094219Z","steps":["trace[914402242] 'process raft request' (duration: 119.147436ms)","trace[914402242] 'compare' (duration: 330.604324ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:05.094291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:04.643714Z","time spent":"450.54987ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:57:05.094377Z","caller":"traceutil/trace.go:171","msg":"trace[1508346159] linearizableReadLoop","detail":"{readStateIndex:1098; appliedIndex:1097; }","duration":"449.27722ms","start":"2026-06-20T02:57:04.645087Z","end":"2026-06-20T02:57:05.094364Z","steps":["trace[1508346159] 'read index received' (duration: 117.801825ms)","trace[1508346159] 'applied index is now lower than readState.Index' (duration: 331.474335ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:05.0945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.407973ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-20T02:57:05.094535Z","caller":"traceutil/trace.go:171","msg":"trace[1232120407] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1060; }","duration":"449.460724ms","start":"2026-06-20T02:57:04.645064Z","end":"2026-06-20T02:57:05.094525Z","steps":["trace[1232120407] 'agreement among raft nodes before linearized reading' (duration: 449.355012ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:05.094564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:04.645053Z","time spent":"449.503295ms","remote":"127.0.0.1:44340","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-06-20T02:57:05.314716Z","caller":"traceutil/trace.go:171","msg":"trace[763104121] linearizableReadLoop","detail":"{readStateIndex:1100; appliedIndex:1099; }","duration":"220.299279ms","start":"2026-06-20T02:57:05.094396Z","end":"2026-06-20T02:57:05.314695Z","steps":["trace[763104121] 'read index received' (duration: 217.86228ms)","trace[763104121] 'applied index is now lower than readState.Index' (duration: 2.436299ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:05.31479Z","caller":"traceutil/trace.go:171","msg":"trace[1766336528] transaction","detail":"{read_only:false; response_revision:1061; number_of_response:1; }","duration":"539.428855ms","start":"2026-06-20T02:57:04.775335Z","end":"2026-06-20T02:57:05.314764Z","steps":["trace[1766336528] 'process raft request' (duration: 536.909244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:05.31487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"596.161275ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-20T02:57:05.314902Z","caller":"traceutil/trace.go:171","msg":"trace[1034639782] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1061; }","duration":"596.251697ms","start":"2026-06-20T02:57:04.718641Z","end":"2026-06-20T02:57:05.314893Z","steps":["trace[1034639782] 'agreement among raft nodes before linearized reading' (duration: 596.124084ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:05.314918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:04.775324Z","time spent":"539.524888ms","remote":"127.0.0.1:44340","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-06-20T02:57:05.314916Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"593.584363ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-20T02:57:05.31493Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:04.718611Z","time spent":"596.311149ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-20T02:57:05.314957Z","caller":"traceutil/trace.go:171","msg":"trace[2006685923] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1061; }","duration":"593.660725ms","start":"2026-06-20T02:57:04.721287Z","end":"2026-06-20T02:57:05.314948Z","steps":["trace[2006685923] 'agreement among raft nodes before linearized reading' (duration: 593.462421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:05.314982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:04.721274Z","time spent":"593.703086ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-20T02:57:05.315144Z","caller":"traceutil/trace.go:171","msg":"trace[123353825] transaction","detail":"{read_only:false; response_revision:1062; number_of_response:1; }","duration":"216.558449ms","start":"2026-06-20T02:57:05.098557Z","end":"2026-06-20T02:57:05.315116Z","steps":["trace[123353825] 'process raft request' (duration: 216.416576ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:06.799963Z","caller":"traceutil/trace.go:171","msg":"trace[702970695] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"200.268025ms","start":"2026-06-20T02:57:06.599674Z","end":"2026-06-20T02:57:06.799942Z","steps":["trace[702970695] 'process raft request' (duration: 200.136032ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:08.452249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.55056ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-20T02:57:09.353694Z","caller":"traceutil/trace.go:171","msg":"trace[1079088672] linearizableReadLoop","detail":"{readStateIndex:1113; appliedIndex:1112; }","duration":"207.945371ms","start":"2026-06-20T02:57:09.145728Z","end":"2026-06-20T02:57:09.353674Z","steps":["trace[1079088672] 'read index received' (duration: 207.739046ms)","trace[1079088672] 'applied index is now lower than readState.Index' (duration: 205.335µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:09.353789Z","caller":"traceutil/trace.go:171","msg":"trace[653982371] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"235.391315ms","start":"2026-06-20T02:57:09.11837Z","end":"2026-06-20T02:57:09.353762Z","steps":["trace[653982371] 'process raft request' (duration: 235.140629ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:09.353999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.249229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T02:57:09.354068Z","caller":"traceutil/trace.go:171","msg":"trace[1609425838] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1073; }","duration":"208.362761ms","start":"2026-06-20T02:57:09.145686Z","end":"2026-06-20T02:57:09.354048Z","steps":["trace[1609425838] 'agreement among raft nodes before linearized reading' (duration: 208.110475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:09.354052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.319759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:09.354144Z","caller":"traceutil/trace.go:171","msg":"trace[1754743925] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"121.562755ms","start":"2026-06-20T02:57:09.232558Z","end":"2026-06-20T02:57:09.35412Z","steps":["trace[1754743925] 'agreement among raft nodes before linearized reading' (duration: 121.306659ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:09.567498Z","caller":"traceutil/trace.go:171","msg":"trace[931672660] transaction","detail":"{read_only:false; response_revision:1074; number_of_response:1; }","duration":"208.30126ms","start":"2026-06-20T02:57:09.359171Z","end":"2026-06-20T02:57:09.567473Z","steps":["trace[931672660] 'process raft request' (duration: 182.052976ms)","trace[931672660] 'compare' (duration: 26.033808ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:09.583699Z","caller":"traceutil/trace.go:171","msg":"trace[2021388492] transaction","detail":"{read_only:false; response_revision:1075; number_of_response:1; }","duration":"224.354587ms","start":"2026-06-20T02:57:09.359261Z","end":"2026-06-20T02:57:09.583616Z","steps":["trace[2021388492] 'process raft request' (duration: 224.208504ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:09.583953Z","caller":"traceutil/trace.go:171","msg":"trace[1585660688] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"224.598093ms","start":"2026-06-20T02:57:09.359334Z","end":"2026-06-20T02:57:09.583932Z","steps":["trace[1585660688] 'process raft request' (duration: 224.251885ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:09.584308Z","caller":"traceutil/trace.go:171","msg":"trace[429898589] transaction","detail":"{read_only:false; response_revision:1077; number_of_response:1; }","duration":"223.350123ms","start":"2026-06-20T02:57:09.360949Z","end":"2026-06-20T02:57:09.584299Z","steps":["trace[429898589] 'process raft request' (duration: 222.903952ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:25.20942Z","caller":"traceutil/trace.go:171","msg":"trace[1301525850] linearizableReadLoop","detail":"{readStateIndex:1220; appliedIndex:1219; }","duration":"118.247585ms","start":"2026-06-20T02:57:25.091155Z","end":"2026-06-20T02:57:25.209402Z","steps":["trace[1301525850] 'read index received' (duration: 117.981149ms)","trace[1301525850] 'applied index is now lower than readState.Index' (duration: 265.776µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:25.209496Z","caller":"traceutil/trace.go:171","msg":"trace[337801740] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"298.121319ms","start":"2026-06-20T02:57:24.911348Z","end":"2026-06-20T02:57:25.209469Z","steps":["trace[337801740] 'process raft request' (duration: 297.942254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:25.20953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.341237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:25.209564Z","caller":"traceutil/trace.go:171","msg":"trace[343212835] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1175; }","duration":"118.45307ms","start":"2026-06-20T02:57:25.091104Z","end":"2026-06-20T02:57:25.209557Z","steps":["trace[343212835] 'agreement among raft nodes before linearized reading' (duration: 118.365748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:27.360196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"728.516692ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-20T02:57:27.360267Z","caller":"traceutil/trace.go:171","msg":"trace[1935271223] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:1181; }","duration":"728.648195ms","start":"2026-06-20T02:57:26.631606Z","end":"2026-06-20T02:57:27.360254Z","steps":["trace[1935271223] 'count revisions from in-memory index tree' (duration: 728.421409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:27.360297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:26.631584Z","time spent":"728.705306ms","remote":"127.0.0.1:44388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":17,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-20T02:57:27.36052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"526.34443ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-20T02:57:27.360555Z","caller":"traceutil/trace.go:171","msg":"trace[713137280] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:0; response_revision:1181; }","duration":"526.407982ms","start":"2026-06-20T02:57:26.834138Z","end":"2026-06-20T02:57:27.360546Z","steps":["trace[713137280] 'count revisions from in-memory index tree' (duration: 526.293519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:27.360577Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:26.834123Z","time spent":"526.447802ms","remote":"127.0.0.1:44236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":30,"request content":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" count_only:true "} {"level":"info","ts":"2026-06-20T02:57:27.361835Z","caller":"traceutil/trace.go:171","msg":"trace[1997117593] linearizableReadLoop","detail":"{readStateIndex:1227; appliedIndex:1226; }","duration":"122.338613ms","start":"2026-06-20T02:57:27.239481Z","end":"2026-06-20T02:57:27.36182Z","steps":["trace[1997117593] 'read index received' (duration: 121.977165ms)","trace[1997117593] 'applied index is now lower than readState.Index' (duration: 360.838µs)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:27.361936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.458147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:27.361973Z","caller":"traceutil/trace.go:171","msg":"trace[774914424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1182; }","duration":"122.537649ms","start":"2026-06-20T02:57:27.239426Z","end":"2026-06-20T02:57:27.361964Z","steps":["trace[774914424] 'agreement among raft nodes before linearized reading' (duration: 122.454437ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:27.362002Z","caller":"traceutil/trace.go:171","msg":"trace[1227472466] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"147.304796ms","start":"2026-06-20T02:57:27.214631Z","end":"2026-06-20T02:57:27.361936Z","steps":["trace[1227472466] 'process raft request' (duration: 147.112101ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:44.057016Z","caller":"traceutil/trace.go:171","msg":"trace[1091894729] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"218.304651ms","start":"2026-06-20T02:57:43.838703Z","end":"2026-06-20T02:57:44.057008Z","steps":["trace[1091894729] 'process raft request' (duration: 218.117187ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:44.056949Z","caller":"traceutil/trace.go:171","msg":"trace[365857752] linearizableReadLoop","detail":"{readStateIndex:1306; appliedIndex:1305; }","duration":"193.502363ms","start":"2026-06-20T02:57:43.863428Z","end":"2026-06-20T02:57:44.056931Z","steps":["trace[365857752] 'read index received' (duration: 193.351529ms)","trace[365857752] 'applied index is now lower than readState.Index' (duration: 150.214µs)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:44.057272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.849901ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-20T02:57:44.057345Z","caller":"traceutil/trace.go:171","msg":"trace[954044806] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1257; }","duration":"193.975024ms","start":"2026-06-20T02:57:43.863354Z","end":"2026-06-20T02:57:44.057329Z","steps":["trace[954044806] 'agreement among raft nodes before linearized reading' (duration: 193.759119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:44.057366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.1917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-20T02:57:44.057388Z","caller":"traceutil/trace.go:171","msg":"trace[2041791001] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1257; }","duration":"180.248612ms","start":"2026-06-20T02:57:43.877131Z","end":"2026-06-20T02:57:44.05738Z","steps":["trace[2041791001] 'agreement among raft nodes before linearized reading' (duration: 180.045257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:44.057297Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.818397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-20T02:57:44.05744Z","caller":"traceutil/trace.go:171","msg":"trace[1560179949] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1257; }","duration":"115.98643ms","start":"2026-06-20T02:57:43.941435Z","end":"2026-06-20T02:57:44.057422Z","steps":["trace[1560179949] 'agreement among raft nodes before linearized reading' (duration: 115.778735ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:44.165754Z","caller":"traceutil/trace.go:171","msg":"trace[510940282] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"104.064343ms","start":"2026-06-20T02:57:44.061668Z","end":"2026-06-20T02:57:44.165732Z","steps":["trace[510940282] 'process raft request' (duration: 104.018302ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:44.165998Z","caller":"traceutil/trace.go:171","msg":"trace[894202518] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"105.008376ms","start":"2026-06-20T02:57:44.060973Z","end":"2026-06-20T02:57:44.165981Z","steps":["trace[894202518] 'process raft request' (duration: 93.779045ms)","trace[894202518] 'compare' (duration: 10.827981ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:45.842438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.367373669s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-20T02:57:45.842516Z","caller":"traceutil/trace.go:171","msg":"trace[1768172659] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1260; }","duration":"1.367502592s","start":"2026-06-20T02:57:44.474995Z","end":"2026-06-20T02:57:45.842498Z","steps":["trace[1768172659] 'count revisions from in-memory index tree' (duration: 1.367297717s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:45.842568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:44.474977Z","time spent":"1.367574133s","remote":"127.0.0.1:44534","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":30,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-20T02:57:45.842629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.227968ms","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-06-20T02:57:45.842712Z","caller":"traceutil/trace.go:171","msg":"trace[1404249654] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:1260; }","duration":"319.359622ms","start":"2026-06-20T02:57:45.52333Z","end":"2026-06-20T02:57:45.842689Z","steps":["trace[1404249654] 'count revisions from in-memory index tree' (duration: 319.137896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:45.842756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:45.523312Z","time spent":"319.433443ms","remote":"127.0.0.1:57460","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-06-20T02:57:46.16906Z","caller":"traceutil/trace.go:171","msg":"trace[334044545] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"495.434274ms","start":"2026-06-20T02:57:45.6736Z","end":"2026-06-20T02:57:46.169034Z","steps":["trace[334044545] 'read index received' (duration: 495.243899ms)","trace[334044545] 'applied index is now lower than readState.Index' (duration: 189.504µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:46.169185Z","caller":"traceutil/trace.go:171","msg":"trace[1454267279] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"560.189757ms","start":"2026-06-20T02:57:45.608982Z","end":"2026-06-20T02:57:46.169172Z","steps":["trace[1454267279] 'process raft request' (duration: 559.91771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:46.169291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:45.608944Z","time spent":"560.267239ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:57:46.169422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.524383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:46.16951Z","caller":"traceutil/trace.go:171","msg":"trace[760842322] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1261; }","duration":"239.657616ms","start":"2026-06-20T02:57:45.92983Z","end":"2026-06-20T02:57:46.169488Z","steps":["trace[760842322] 'agreement among raft nodes before linearized reading' (duration: 239.522203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:46.169836Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.741416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-20T02:57:46.169882Z","caller":"traceutil/trace.go:171","msg":"trace[675853951] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1261; }","duration":"108.825798ms","start":"2026-06-20T02:57:46.061044Z","end":"2026-06-20T02:57:46.16987Z","steps":["trace[675853951] 'agreement among raft nodes before linearized reading' (duration: 108.685675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:46.169902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"496.297884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-20T02:57:46.169943Z","caller":"traceutil/trace.go:171","msg":"trace[1444552391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1261; }","duration":"496.371836ms","start":"2026-06-20T02:57:45.67356Z","end":"2026-06-20T02:57:46.169931Z","steps":["trace[1444552391] 'agreement among raft nodes before linearized reading' (duration: 496.273364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:46.169985Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:45.673538Z","time spent":"496.440297ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-20T02:57:46.576053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.285609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:57:46.576271Z","caller":"traceutil/trace.go:171","msg":"trace[2091245076] transaction","detail":"{read_only:false; response_revision:1263; number_of_response:1; }","duration":"402.029347ms","start":"2026-06-20T02:57:46.174217Z","end":"2026-06-20T02:57:46.576246Z","steps":["trace[2091245076] 'process raft request' (duration: 256.35251ms)","trace[2091245076] 'compare' (duration: 145.177986ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:46.576347Z","caller":"traceutil/trace.go:171","msg":"trace[1870028601] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"401.006633ms","start":"2026-06-20T02:57:46.175322Z","end":"2026-06-20T02:57:46.576329Z","steps":["trace[1870028601] 'process raft request' (duration: 400.87642ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:46.57641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.17421Z","time spent":"402.114459ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:57:46.576423Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.175306Z","time spent":"401.082885ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:57:46.576416Z","caller":"traceutil/trace.go:171","msg":"trace[1595017492] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"402.062749ms","start":"2026-06-20T02:57:46.174326Z","end":"2026-06-20T02:57:46.576389Z","steps":["trace[1595017492] 'process raft request' (duration: 401.816363ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:46.576508Z","caller":"traceutil/trace.go:171","msg":"trace[705838609] linearizableReadLoop","detail":"{readStateIndex:1315; appliedIndex:1311; }","duration":"344.824897ms","start":"2026-06-20T02:57:46.231668Z","end":"2026-06-20T02:57:46.576493Z","steps":["trace[705838609] 'read index received' (duration: 198.994786ms)","trace[705838609] 'applied index is now lower than readState.Index' (duration: 145.828131ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:46.576533Z","caller":"traceutil/trace.go:171","msg":"trace[669134530] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"400.741117ms","start":"2026-06-20T02:57:46.175772Z","end":"2026-06-20T02:57:46.576513Z","steps":["trace[669134530] 'process raft request' (duration: 400.517611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:46.576597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.929359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T02:57:46.576595Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.174292Z","time spent":"402.185241ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:57:46.576621Z","caller":"traceutil/trace.go:171","msg":"trace[837748808] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1266; }","duration":"344.98111ms","start":"2026-06-20T02:57:46.231633Z","end":"2026-06-20T02:57:46.576614Z","steps":["trace[837748808] 'agreement among raft nodes before linearized reading' (duration: 344.927009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:46.57664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.231621Z","time spent":"345.015242ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T02:57:46.576638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.175762Z","time spent":"400.815469ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:57:47.077409Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":15334368478835618773,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-20T02:57:47.157699Z","caller":"traceutil/trace.go:171","msg":"trace[455608973] linearizableReadLoop","detail":"{readStateIndex:1316; appliedIndex:1315; }","duration":"581.136064ms","start":"2026-06-20T02:57:46.576536Z","end":"2026-06-20T02:57:47.157672Z","steps":["trace[455608973] 'read index received' (duration: 508.624533ms)","trace[455608973] 'applied index is now lower than readState.Index' (duration: 72.510301ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:47.157859Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.144899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:47.157883Z","caller":"traceutil/trace.go:171","msg":"trace[117794015] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1267; }","duration":"580.201721ms","start":"2026-06-20T02:57:46.577676Z","end":"2026-06-20T02:57:47.157878Z","steps":["trace[117794015] 'agreement among raft nodes before linearized reading' (duration: 580.15039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:47.1579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.577665Z","time spent":"580.231711ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T02:57:47.157867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"621.534069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-20T02:57:47.157722Z","caller":"traceutil/trace.go:171","msg":"trace[321004822] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"746.886016ms","start":"2026-06-20T02:57:46.410814Z","end":"2026-06-20T02:57:47.1577Z","steps":["trace[321004822] 'process raft request' (duration: 674.340404ms)","trace[321004822] 'compare' (duration: 72.120231ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:47.158258Z","caller":"traceutil/trace.go:171","msg":"trace[1804884878] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1267; }","duration":"621.961779ms","start":"2026-06-20T02:57:46.536264Z","end":"2026-06-20T02:57:47.158226Z","steps":["trace[1804884878] 'agreement among raft nodes before linearized reading' (duration: 621.538249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:47.158308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.536243Z","time spent":"622.049151ms","remote":"127.0.0.1:57618","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-06-20T02:57:47.158327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:46.410793Z","time spent":"747.4913ms","remote":"127.0.0.1:44340","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-06-20T02:57:49.731771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.233650361s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-20T02:57:49.732398Z","caller":"traceutil/trace.go:171","msg":"trace[198871504] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"1.557260534s","start":"2026-06-20T02:57:48.175112Z","end":"2026-06-20T02:57:49.732372Z","steps":["trace[198871504] 'process raft request' (duration: 1.556752892s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.732556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.175091Z","time spent":"1.557380017s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:57:49.973789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.322677ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:57:49.97417Z","caller":"traceutil/trace.go:171","msg":"trace[329474276] linearizableReadLoop","detail":"{readStateIndex:1318; appliedIndex:1316; }","duration":"1.742461127s","start":"2026-06-20T02:57:48.231417Z","end":"2026-06-20T02:57:49.973878Z","steps":["trace[329474276] 'read index received' (duration: 266.67164ms)","trace[329474276] 'applied index is now lower than readState.Index' (duration: 1.475787277s)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:49.974315Z","caller":"traceutil/trace.go:171","msg":"trace[1160516712] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"1.612444716s","start":"2026-06-20T02:57:48.361848Z","end":"2026-06-20T02:57:49.974292Z","steps":["trace[1160516712] 'process raft request' (duration: 1.370505054s)","trace[1160516712] 'compare' (duration: 241.02197ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:49.97445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.361818Z","time spent":"1.612574829s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:57:49.97455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.743132423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:49.974605Z","caller":"traceutil/trace.go:171","msg":"trace[409005571] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1269; }","duration":"1.743226215s","start":"2026-06-20T02:57:48.231365Z","end":"2026-06-20T02:57:49.974592Z","steps":["trace[409005571] 'agreement among raft nodes before linearized reading' (duration: 1.743143503s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.974653Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.231343Z","time spent":"1.743302266s","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-20T02:57:49.975154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.743350919s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-20T02:57:49.975387Z","caller":"traceutil/trace.go:171","msg":"trace[307867086] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1269; }","duration":"1.743451781s","start":"2026-06-20T02:57:48.23175Z","end":"2026-06-20T02:57:49.975202Z","steps":["trace[307867086] 'agreement among raft nodes before linearized reading' (duration: 1.743281067s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.975623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394283669s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-20T02:57:49.975649Z","caller":"traceutil/trace.go:171","msg":"trace[113332976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1269; }","duration":"1.39431137s","start":"2026-06-20T02:57:48.581331Z","end":"2026-06-20T02:57:49.975642Z","steps":["trace[113332976] 'agreement among raft nodes before linearized reading' (duration: 1.394210638s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.975668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.581262Z","time spent":"1.394401521s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-20T02:57:49.975612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.231732Z","time spent":"1.743859931s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T02:57:49.975804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.39391566s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-20T02:57:49.975899Z","caller":"traceutil/trace.go:171","msg":"trace[1186677614] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1269; }","duration":"1.394344451s","start":"2026-06-20T02:57:48.581536Z","end":"2026-06-20T02:57:49.975881Z","steps":["trace[1186677614] 'agreement among raft nodes before linearized reading' (duration: 1.393759347s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.976045Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.581525Z","time spent":"1.394506474s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-20T02:57:49.976293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.125234543s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-20T02:57:49.975956Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.370403742s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-20T02:57:49.976375Z","caller":"traceutil/trace.go:171","msg":"trace[2055892404] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1269; }","duration":"1.125363016s","start":"2026-06-20T02:57:48.850991Z","end":"2026-06-20T02:57:49.976354Z","steps":["trace[2055892404] 'agreement among raft nodes before linearized reading' (duration: 1.124400013s)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:49.976419Z","caller":"traceutil/trace.go:171","msg":"trace[1051065015] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:1269; }","duration":"1.370883703s","start":"2026-06-20T02:57:48.605514Z","end":"2026-06-20T02:57:49.976397Z","steps":["trace[1051065015] 'agreement among raft nodes before linearized reading' (duration: 1.370413442s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.976433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.850971Z","time spent":"1.125443687s","remote":"127.0.0.1:44092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":31,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-06-20T02:57:49.976482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.605499Z","time spent":"1.370964565s","remote":"127.0.0.1:52682","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true "} {"level":"warn","ts":"2026-06-20T02:57:49.976531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394953035s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-20T02:57:49.976557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.395299633s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-06-20T02:57:49.976644Z","caller":"traceutil/trace.go:171","msg":"trace[155918149] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1269; }","duration":"1.395435046s","start":"2026-06-20T02:57:48.58119Z","end":"2026-06-20T02:57:49.976625Z","steps":["trace[155918149] 'agreement among raft nodes before linearized reading' (duration: 1.394452683s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.976691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.581173Z","time spent":"1.395508989s","remote":"127.0.0.1:44340","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-06-20T02:57:49.976631Z","caller":"traceutil/trace.go:171","msg":"trace[1192704989] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1269; }","duration":"1.39516966s","start":"2026-06-20T02:57:48.581444Z","end":"2026-06-20T02:57:49.976613Z","steps":["trace[1192704989] 'agreement among raft nodes before linearized reading' (duration: 1.394151686s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:49.976761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:48.581437Z","time spent":"1.395311003s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-20T02:57:50.44933Z","caller":"traceutil/trace.go:171","msg":"trace[475180942] transaction","detail":"{read_only:false; response_revision:1271; number_of_response:1; }","duration":"467.357865ms","start":"2026-06-20T02:57:49.981948Z","end":"2026-06-20T02:57:50.449306Z","steps":["trace[475180942] 'process raft request' (duration: 467.1477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:50.449488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:49.981926Z","time spent":"467.480509ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:57:50.449863Z","caller":"traceutil/trace.go:171","msg":"trace[1386993757] transaction","detail":"{read_only:false; response_revision:1272; number_of_response:1; }","duration":"467.762015ms","start":"2026-06-20T02:57:49.982088Z","end":"2026-06-20T02:57:50.44985Z","steps":["trace[1386993757] 'process raft request' (duration: 467.178531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:50.449932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:49.98208Z","time spent":"467.815236ms","remote":"127.0.0.1:44340","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-06-20T02:57:50.449935Z","caller":"traceutil/trace.go:171","msg":"trace[1825248391] linearizableReadLoop","detail":"{readStateIndex:1324; appliedIndex:1319; }","duration":"465.766257ms","start":"2026-06-20T02:57:49.984154Z","end":"2026-06-20T02:57:50.44992Z","steps":["trace[1825248391] 'read index received' (duration: 88.353643ms)","trace[1825248391] 'applied index is now lower than readState.Index' (duration: 377.411684ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:50.450036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.873029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:50.45007Z","caller":"traceutil/trace.go:171","msg":"trace[689036567] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1275; }","duration":"465.92163ms","start":"2026-06-20T02:57:49.984135Z","end":"2026-06-20T02:57:50.450057Z","steps":["trace[689036567] 'agreement among raft nodes before linearized reading' (duration: 465.842018ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:50.450097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:49.984127Z","time spent":"465.963831ms","remote":"127.0.0.1:44044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-20T02:57:50.450183Z","caller":"traceutil/trace.go:171","msg":"trace[2060003534] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"468.017942ms","start":"2026-06-20T02:57:49.982142Z","end":"2026-06-20T02:57:50.45016Z","steps":["trace[2060003534] 'process raft request' (duration: 467.326705ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:50.450247Z","caller":"traceutil/trace.go:171","msg":"trace[1625765972] transaction","detail":"{read_only:false; response_revision:1274; number_of_response:1; }","duration":"466.733479ms","start":"2026-06-20T02:57:49.983457Z","end":"2026-06-20T02:57:50.450191Z","steps":["trace[1625765972] 'process raft request' (duration: 466.388051ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:50.450263Z","caller":"traceutil/trace.go:171","msg":"trace[1477838024] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"409.024077ms","start":"2026-06-20T02:57:50.041228Z","end":"2026-06-20T02:57:50.450252Z","steps":["trace[1477838024] 'process raft request' (duration: 408.651868ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:50.45031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:49.982135Z","time spent":"468.107994ms","remote":"127.0.0.1:44340","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-06-20T02:57:50.450322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:50.041201Z","time spent":"409.086739ms","remote":"127.0.0.1:44134","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":892,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-20T02:57:50.450328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:49.983451Z","time spent":"466.830592ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T02:57:50.742014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.857175ms","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-06-20T02:57:50.742096Z","caller":"traceutil/trace.go:171","msg":"trace[1563260873] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1275; }","duration":"171.01848ms","start":"2026-06-20T02:57:50.571061Z","end":"2026-06-20T02:57:50.742079Z","steps":["trace[1563260873] 'count revisions from in-memory index tree' (duration: 170.729333ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:51.955092Z","caller":"traceutil/trace.go:171","msg":"trace[784787841] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"215.77757ms","start":"2026-06-20T02:57:51.739283Z","end":"2026-06-20T02:57:51.95506Z","steps":["trace[784787841] 'process raft request' (duration: 215.583316ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:54.306532Z","caller":"traceutil/trace.go:171","msg":"trace[1134057054] transaction","detail":"{read_only:false; response_revision:1290; number_of_response:1; }","duration":"124.549268ms","start":"2026-06-20T02:57:54.181957Z","end":"2026-06-20T02:57:54.306506Z","steps":["trace[1134057054] 'process raft request' (duration: 124.316723ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:56.284677Z","caller":"traceutil/trace.go:171","msg":"trace[1102441085] linearizableReadLoop","detail":"{readStateIndex:1353; appliedIndex:1352; }","duration":"109.429503ms","start":"2026-06-20T02:57:56.17522Z","end":"2026-06-20T02:57:56.284649Z","steps":["trace[1102441085] 'read index received' (duration: 109.201797ms)","trace[1102441085] 'applied index is now lower than readState.Index' (duration: 226.086µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:56.284819Z","caller":"traceutil/trace.go:171","msg":"trace[2137127047] transaction","detail":"{read_only:false; response_revision:1302; number_of_response:1; }","duration":"290.453595ms","start":"2026-06-20T02:57:55.994322Z","end":"2026-06-20T02:57:56.284776Z","steps":["trace[2137127047] 'process raft request' (duration: 290.115427ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:56.284928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.672758ms","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-06-20T02:57:56.28498Z","caller":"traceutil/trace.go:171","msg":"trace[1531209938] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1302; }","duration":"109.807691ms","start":"2026-06-20T02:57:56.175158Z","end":"2026-06-20T02:57:56.284966Z","steps":["trace[1531209938] 'agreement among raft nodes before linearized reading' (duration: 109.684728ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:56.716839Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.091171ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T02:57:56.717002Z","caller":"traceutil/trace.go:171","msg":"trace[292400519] linearizableReadLoop","detail":"{readStateIndex:1354; appliedIndex:1353; }","duration":"228.388375ms","start":"2026-06-20T02:57:56.488588Z","end":"2026-06-20T02:57:56.716976Z","steps":["trace[292400519] 'read index received' (duration: 110.044927ms)","trace[292400519] 'applied index is now lower than readState.Index' (duration: 118.341678ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:56.717516Z","caller":"traceutil/trace.go:171","msg":"trace[468642130] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"401.69508ms","start":"2026-06-20T02:57:56.31579Z","end":"2026-06-20T02:57:56.717485Z","steps":["trace[468642130] 'process raft request' (duration: 282.81964ms)","trace[468642130] 'compare' (duration: 117.872666ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:57:56.717576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.976178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-20T02:57:56.717659Z","caller":"traceutil/trace.go:171","msg":"trace[1669353185] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1303; }","duration":"229.110322ms","start":"2026-06-20T02:57:56.488529Z","end":"2026-06-20T02:57:56.717639Z","steps":["trace[1669353185] 'agreement among raft nodes before linearized reading' (duration: 228.686652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:56.717747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.080658ms","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-06-20T02:57:56.717779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T02:57:56.315766Z","time spent":"401.817202ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T02:57:56.717795Z","caller":"traceutil/trace.go:171","msg":"trace[1659959654] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1303; }","duration":"199.128559ms","start":"2026-06-20T02:57:56.518653Z","end":"2026-06-20T02:57:56.717781Z","steps":["trace[1659959654] 'agreement among raft nodes before linearized reading' (duration: 198.614336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:56.717869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.029479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-20T02:57:56.717985Z","caller":"traceutil/trace.go:171","msg":"trace[301052829] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1303; }","duration":"207.227383ms","start":"2026-06-20T02:57:56.510737Z","end":"2026-06-20T02:57:56.717965Z","steps":["trace[301052829] 'agreement among raft nodes before linearized reading' (duration: 206.524026ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:56.718283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.768482ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-20T02:57:56.718451Z","caller":"traceutil/trace.go:171","msg":"trace[1853376619] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1303; }","duration":"206.968037ms","start":"2026-06-20T02:57:56.511468Z","end":"2026-06-20T02:57:56.718436Z","steps":["trace[1853376619] 'agreement among raft nodes before linearized reading' (duration: 206.048355ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:56.969207Z","caller":"traceutil/trace.go:171","msg":"trace[1451588459] transaction","detail":"{read_only:false; response_revision:1304; number_of_response:1; }","duration":"246.627705ms","start":"2026-06-20T02:57:56.72244Z","end":"2026-06-20T02:57:56.969068Z","steps":["trace[1451588459] 'process raft request' (duration: 243.906179ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:56.969394Z","caller":"traceutil/trace.go:171","msg":"trace[165985600] transaction","detail":"{read_only:false; response_revision:1305; number_of_response:1; }","duration":"246.481942ms","start":"2026-06-20T02:57:56.72289Z","end":"2026-06-20T02:57:56.969372Z","steps":["trace[165985600] 'process raft request' (duration: 246.126043ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:56.969672Z","caller":"traceutil/trace.go:171","msg":"trace[743739572] linearizableReadLoop","detail":"{readStateIndex:1358; appliedIndex:1354; }","duration":"123.306918ms","start":"2026-06-20T02:57:56.84634Z","end":"2026-06-20T02:57:56.969647Z","steps":["trace[743739572] 'read index received' (duration: 119.734362ms)","trace[743739572] 'applied index is now lower than readState.Index' (duration: 3.570996ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:57:56.969857Z","caller":"traceutil/trace.go:171","msg":"trace[298269364] transaction","detail":"{read_only:false; response_revision:1307; number_of_response:1; }","duration":"245.929308ms","start":"2026-06-20T02:57:56.723912Z","end":"2026-06-20T02:57:56.969841Z","steps":["trace[298269364] 'process raft request' (duration: 245.62033ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:56.969953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.598196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:56.97Z","caller":"traceutil/trace.go:171","msg":"trace[1585274814] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1307; }","duration":"123.699478ms","start":"2026-06-20T02:57:56.846288Z","end":"2026-06-20T02:57:56.969988Z","steps":["trace[1585274814] 'agreement among raft nodes before linearized reading' (duration: 123.604936ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:56.970124Z","caller":"traceutil/trace.go:171","msg":"trace[2053855402] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"246.39616ms","start":"2026-06-20T02:57:56.723694Z","end":"2026-06-20T02:57:56.970091Z","steps":["trace[2053855402] 'process raft request' (duration: 245.569679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:57:58.433365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.635706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:57:58.433486Z","caller":"traceutil/trace.go:171","msg":"trace[1132175282] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1316; }","duration":"200.863421ms","start":"2026-06-20T02:57:58.232597Z","end":"2026-06-20T02:57:58.43346Z","steps":["trace[1132175282] 'range keys from in-memory index tree' (duration: 200.441691ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:57:58.435852Z","caller":"traceutil/trace.go:171","msg":"trace[1420809129] transaction","detail":"{read_only:false; response_revision:1317; number_of_response:1; }","duration":"144.021588ms","start":"2026-06-20T02:57:58.291812Z","end":"2026-06-20T02:57:58.435834Z","steps":["trace[1420809129] 'process raft request' (duration: 143.472885ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:58:04.583418Z","caller":"traceutil/trace.go:171","msg":"trace[536898253] transaction","detail":"{read_only:false; response_revision:1361; number_of_response:1; }","duration":"128.455182ms","start":"2026-06-20T02:58:04.454929Z","end":"2026-06-20T02:58:04.583384Z","steps":["trace[536898253] 'process raft request' (duration: 128.260447ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T02:59:40.919762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.278505ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T02:59:40.919934Z","caller":"traceutil/trace.go:171","msg":"trace[1518145264] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1803; }","duration":"125.47065ms","start":"2026-06-20T02:59:40.794437Z","end":"2026-06-20T02:59:40.919908Z","steps":["trace[1518145264] 'range keys from in-memory index tree' (duration: 125.255025ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:59:41.708904Z","caller":"traceutil/trace.go:171","msg":"trace[606409690] linearizableReadLoop","detail":"{readStateIndex:1879; appliedIndex:1878; }","duration":"112.812149ms","start":"2026-06-20T02:59:41.596063Z","end":"2026-06-20T02:59:41.708875Z","steps":["trace[606409690] 'read index received' (duration: 72.05499ms)","trace[606409690] 'applied index is now lower than readState.Index' (duration: 40.755969ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T02:59:41.709006Z","caller":"traceutil/trace.go:171","msg":"trace[1516406438] transaction","detail":"{read_only:false; response_revision:1807; number_of_response:1; }","duration":"113.826974ms","start":"2026-06-20T02:59:41.595135Z","end":"2026-06-20T02:59:41.708962Z","steps":["trace[1516406438] 'process raft request' (duration: 73.102786ms)","trace[1516406438] 'compare' (duration: 40.524773ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T02:59:41.709287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.209798ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-20T02:59:41.70938Z","caller":"traceutil/trace.go:171","msg":"trace[395140073] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1807; }","duration":"113.350601ms","start":"2026-06-20T02:59:41.596006Z","end":"2026-06-20T02:59:41.709357Z","steps":["trace[395140073] 'agreement among raft nodes before linearized reading' (duration: 112.969862ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T02:59:41.921465Z","caller":"traceutil/trace.go:171","msg":"trace[86142582] transaction","detail":"{read_only:false; response_revision:1809; number_of_response:1; }","duration":"207.066027ms","start":"2026-06-20T02:59:41.714356Z","end":"2026-06-20T02:59:41.921422Z","steps":["trace[86142582] 'process raft request' (duration: 154.865417ms)","trace[86142582] 'compare' (duration: 52.047537ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T03:02:05.695376Z","caller":"traceutil/trace.go:171","msg":"trace[703492422] linearizableReadLoop","detail":"{readStateIndex:2604; appliedIndex:2603; }","duration":"253.899484ms","start":"2026-06-20T03:02:05.441451Z","end":"2026-06-20T03:02:05.69535Z","steps":["trace[703492422] 'read index received' (duration: 253.73553ms)","trace[703492422] 'applied index is now lower than readState.Index' (duration: 162.544µs)"],"step_count":2} {"level":"info","ts":"2026-06-20T03:02:05.69546Z","caller":"traceutil/trace.go:171","msg":"trace[1180176883] transaction","detail":"{read_only:false; response_revision:2501; number_of_response:1; }","duration":"272.417413ms","start":"2026-06-20T03:02:05.422989Z","end":"2026-06-20T03:02:05.695407Z","steps":["trace[1180176883] 'process raft request' (duration: 272.193068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:05.695543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.074268ms","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-06-20T03:02:05.695618Z","caller":"traceutil/trace.go:171","msg":"trace[402665624] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:2501; }","duration":"254.17156ms","start":"2026-06-20T03:02:05.441433Z","end":"2026-06-20T03:02:05.695604Z","steps":["trace[402665624] 'agreement among raft nodes before linearized reading' (duration: 254.048587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:05.701946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.224315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:route-controller\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-06-20T03:02:05.702042Z","caller":"traceutil/trace.go:171","msg":"trace[2123788101] range","detail":"{range_begin:/registry/clusterroles/system:controller:route-controller; range_end:; response_count:1; response_revision:2502; }","duration":"236.377599ms","start":"2026-06-20T03:02:05.465643Z","end":"2026-06-20T03:02:05.702021Z","steps":["trace[2123788101] 'agreement among raft nodes before linearized reading' (duration: 236.190045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:05.702132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.84036ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-06-20T03:02:05.702138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.091958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" ","response":"range_response_count:1 size:743"} {"level":"info","ts":"2026-06-20T03:02:05.702198Z","caller":"traceutil/trace.go:171","msg":"trace[2081447755] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:2502; }","duration":"204.944113ms","start":"2026-06-20T03:02:05.497233Z","end":"2026-06-20T03:02:05.702177Z","steps":["trace[2081447755] 'agreement among raft nodes before linearized reading' (duration: 204.723777ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:05.702251Z","caller":"traceutil/trace.go:171","msg":"trace[465895376] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:expand-controller; range_end:; response_count:1; response_revision:2502; }","duration":"224.236271ms","start":"2026-06-20T03:02:05.477984Z","end":"2026-06-20T03:02:05.70222Z","steps":["trace[465895376] 'agreement among raft nodes before linearized reading' (duration: 224.028996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.343947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.902771ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T03:02:06.344127Z","caller":"traceutil/trace.go:171","msg":"trace[1684433368] transaction","detail":"{read_only:false; response_revision:2503; number_of_response:1; }","duration":"636.127833ms","start":"2026-06-20T03:02:05.707961Z","end":"2026-06-20T03:02:06.344089Z","steps":["trace[1684433368] 'process raft request' (duration: 363.948585ms)","trace[1684433368] 'compare' (duration: 271.388909ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T03:02:06.344235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:05.707932Z","time spent":"636.256796ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T03:02:06.939963Z","caller":"traceutil/trace.go:171","msg":"trace[892000525] transaction","detail":"{read_only:false; response_revision:2504; number_of_response:1; }","duration":"1.231233365s","start":"2026-06-20T03:02:05.708696Z","end":"2026-06-20T03:02:06.939929Z","steps":["trace[892000525] 'process raft request' (duration: 1.230527897s)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:06.940119Z","caller":"traceutil/trace.go:171","msg":"trace[1509342612] linearizableReadLoop","detail":"{readStateIndex:2607; appliedIndex:2605; }","duration":"1.15811409s","start":"2026-06-20T03:02:05.781972Z","end":"2026-06-20T03:02:06.940086Z","steps":["trace[1509342612] 'read index received' (duration: 289.955241ms)","trace[1509342612] 'applied index is now lower than readState.Index' (duration: 868.151689ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T03:02:06.940156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:05.708675Z","time spent":"1.231385039s","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":494,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T03:02:06.940221Z","caller":"traceutil/trace.go:171","msg":"trace[1167204818] transaction","detail":"{read_only:false; response_revision:2505; number_of_response:1; }","duration":"994.501857ms","start":"2026-06-20T03:02:05.94569Z","end":"2026-06-20T03:02:06.940192Z","steps":["trace[1167204818] 'process raft request' (duration: 994.154939ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.940285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.158309635s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" ","response":"range_response_count:1 size:743"} {"level":"info","ts":"2026-06-20T03:02:06.940324Z","caller":"traceutil/trace.go:171","msg":"trace[1574315421] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:expand-controller; range_end:; response_count:1; response_revision:2505; }","duration":"1.158384476s","start":"2026-06-20T03:02:05.781926Z","end":"2026-06-20T03:02:06.94031Z","steps":["trace[1574315421] 'agreement among raft nodes before linearized reading' (duration: 1.158284964s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.940368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:05.94566Z","time spent":"994.62778ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T03:02:06.940371Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:05.781901Z","time spent":"1.158454497s","remote":"127.0.0.1:44414","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":766,"request content":"key:\"/registry/clusterrolebindings/system:controller:expand-controller\" "} {"level":"warn","ts":"2026-06-20T03:02:06.940557Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.155834105s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:route-controller\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-06-20T03:02:06.940635Z","caller":"traceutil/trace.go:171","msg":"trace[387840946] range","detail":"{range_begin:/registry/clusterroles/system:controller:route-controller; range_end:; response_count:1; response_revision:2505; }","duration":"1.155938388s","start":"2026-06-20T03:02:05.784677Z","end":"2026-06-20T03:02:06.940615Z","steps":["trace[387840946] 'agreement among raft nodes before linearized reading' (duration: 1.155787024s)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.940688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:05.78467Z","time spent":"1.156008129s","remote":"127.0.0.1:44402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":698,"request content":"key:\"/registry/clusterroles/system:controller:route-controller\" "} {"level":"warn","ts":"2026-06-20T03:02:06.940704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.869656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-20T03:02:06.94076Z","caller":"traceutil/trace.go:171","msg":"trace[825343087] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2505; }","duration":"157.963209ms","start":"2026-06-20T03:02:06.78278Z","end":"2026-06-20T03:02:06.940744Z","steps":["trace[825343087] 'agreement among raft nodes before linearized reading' (duration: 157.775004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.940783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.463829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-20T03:02:06.940843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"709.341581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-20T03:02:06.940865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.295817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-20T03:02:06.940889Z","caller":"traceutil/trace.go:171","msg":"trace[2036293686] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2505; }","duration":"709.415023ms","start":"2026-06-20T03:02:06.231461Z","end":"2026-06-20T03:02:06.940876Z","steps":["trace[2036293686] 'agreement among raft nodes before linearized reading' (duration: 709.346691ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:06.940913Z","caller":"traceutil/trace.go:171","msg":"trace[931675538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2505; }","duration":"499.366889ms","start":"2026-06-20T03:02:06.441533Z","end":"2026-06-20T03:02:06.9409Z","steps":["trace[931675538] 'agreement among raft nodes before linearized reading' (duration: 499.203505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.940923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.231443Z","time spent":"709.473404ms","remote":"127.0.0.1:44032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-20T03:02:06.940933Z","caller":"traceutil/trace.go:171","msg":"trace[281611085] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2505; }","duration":"528.640214ms","start":"2026-06-20T03:02:06.412231Z","end":"2026-06-20T03:02:06.940871Z","steps":["trace[281611085] 'agreement among raft nodes before linearized reading' (duration: 528.307696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.940946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.441518Z","time spent":"499.4214ms","remote":"127.0.0.1:44340","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-06-20T03:02:06.941001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"814.928446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-20T03:02:06.941005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.41221Z","time spent":"528.775707ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-20T03:02:06.94104Z","caller":"traceutil/trace.go:171","msg":"trace[1438853664] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2505; }","duration":"815.013478ms","start":"2026-06-20T03:02:06.126015Z","end":"2026-06-20T03:02:06.941028Z","steps":["trace[1438853664] 'agreement among raft nodes before linearized reading' (duration: 814.878115ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.941073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.125986Z","time spent":"815.07973ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-20T03:02:06.94114Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"654.770277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-20T03:02:06.941173Z","caller":"traceutil/trace.go:171","msg":"trace[593837086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2505; }","duration":"654.842298ms","start":"2026-06-20T03:02:06.286321Z","end":"2026-06-20T03:02:06.941163Z","steps":["trace[593837086] 'agreement among raft nodes before linearized reading' (duration: 654.742416ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:06.941202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.2863Z","time spent":"654.89479ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-20T03:02:07.363515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.399769ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-20T03:02:07.363801Z","caller":"traceutil/trace.go:171","msg":"trace[1071201888] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"416.556044ms","start":"2026-06-20T03:02:06.947221Z","end":"2026-06-20T03:02:07.363777Z","steps":["trace[1071201888] 'process raft request' (duration: 416.450671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:07.36388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.947205Z","time spent":"416.636745ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T03:02:07.363929Z","caller":"traceutil/trace.go:171","msg":"trace[1960000518] linearizableReadLoop","detail":"{readStateIndex:2613; appliedIndex:2609; }","duration":"353.739443ms","start":"2026-06-20T03:02:07.010167Z","end":"2026-06-20T03:02:07.363907Z","steps":["trace[1960000518] 'read index received' (duration: 135.7305ms)","trace[1960000518] 'applied index is now lower than readState.Index' (duration: 218.007703ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T03:02:07.36406Z","caller":"traceutil/trace.go:171","msg":"trace[398687439] transaction","detail":"{read_only:false; response_revision:2510; number_of_response:1; }","duration":"416.629646ms","start":"2026-06-20T03:02:06.947393Z","end":"2026-06-20T03:02:07.364023Z","steps":["trace[398687439] 'process raft request' (duration: 416.429921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:07.364141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"417.172688ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:route-controller\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-06-20T03:02:07.364194Z","caller":"traceutil/trace.go:171","msg":"trace[452178507] range","detail":"{range_begin:/registry/clusterroles/system:controller:route-controller; range_end:; response_count:1; response_revision:2510; }","duration":"417.25264ms","start":"2026-06-20T03:02:06.946925Z","end":"2026-06-20T03:02:07.364177Z","steps":["trace[452178507] 'agreement among raft nodes before linearized reading' (duration: 417.132907ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:07.364246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.946914Z","time spent":"417.320341ms","remote":"127.0.0.1:44402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":698,"request content":"key:\"/registry/clusterroles/system:controller:route-controller\" "} {"level":"warn","ts":"2026-06-20T03:02:07.364331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.730977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:service-account-controller\" ","response":"range_response_count:1 size:675"} {"level":"info","ts":"2026-06-20T03:02:07.364377Z","caller":"traceutil/trace.go:171","msg":"trace[1203106378] range","detail":"{range_begin:/registry/clusterroles/system:controller:service-account-controller; range_end:; response_count:1; response_revision:2510; }","duration":"268.828848ms","start":"2026-06-20T03:02:07.095534Z","end":"2026-06-20T03:02:07.364363Z","steps":["trace[1203106378] 'agreement among raft nodes before linearized reading' (duration: 268.753187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:07.364355Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.947379Z","time spent":"416.791489ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-20T03:02:07.364475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.891009ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-20T03:02:07.364504Z","caller":"traceutil/trace.go:171","msg":"trace[1488858650] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2510; }","duration":"131.955651ms","start":"2026-06-20T03:02:07.23254Z","end":"2026-06-20T03:02:07.364496Z","steps":["trace[1488858650] 'agreement among raft nodes before linearized reading' (duration: 131.91022ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:07.363948Z","caller":"traceutil/trace.go:171","msg":"trace[551129345] transaction","detail":"{read_only:false; response_revision:2509; number_of_response:1; }","duration":"416.616566ms","start":"2026-06-20T03:02:06.947288Z","end":"2026-06-20T03:02:07.363905Z","steps":["trace[551129345] 'process raft request' (duration: 416.444712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:07.365003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.94725Z","time spent":"417.653149ms","remote":"127.0.0.1:44340","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-20T03:02:07.364816Z","caller":"traceutil/trace.go:171","msg":"trace[2052641291] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"416.986594ms","start":"2026-06-20T03:02:06.947025Z","end":"2026-06-20T03:02:07.364012Z","steps":["trace[2052641291] 'process raft request' (duration: 198.970441ms)","trace[2052641291] 'compare' (duration: 217.240565ms)"],"step_count":2} {"level":"warn","ts":"2026-06-20T03:02:07.365204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-20T03:02:06.947006Z","time spent":"418.134781ms","remote":"127.0.0.1:44340","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-06-20T03:02:09.62162Z","caller":"traceutil/trace.go:171","msg":"trace[1046302399] transaction","detail":"{read_only:false; response_revision:2517; number_of_response:1; }","duration":"248.023865ms","start":"2026-06-20T03:02:09.37356Z","end":"2026-06-20T03:02:09.621584Z","steps":["trace[1046302399] 'process raft request' (duration: 247.959884ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:09.621685Z","caller":"traceutil/trace.go:171","msg":"trace[2050794090] transaction","detail":"{read_only:false; response_revision:2516; number_of_response:1; }","duration":"248.124487ms","start":"2026-06-20T03:02:09.373513Z","end":"2026-06-20T03:02:09.621637Z","steps":["trace[2050794090] 'process raft request' (duration: 247.81909ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:09.622803Z","caller":"traceutil/trace.go:171","msg":"trace[575246527] linearizableReadLoop","detail":"{readStateIndex:2623; appliedIndex:2619; }","duration":"239.176204ms","start":"2026-06-20T03:02:09.383604Z","end":"2026-06-20T03:02:09.62278Z","steps":["trace[575246527] 'read index received' (duration: 237.69635ms)","trace[575246527] 'applied index is now lower than readState.Index' (duration: 1.478734ms)"],"step_count":2} {"level":"info","ts":"2026-06-20T03:02:09.622876Z","caller":"traceutil/trace.go:171","msg":"trace[1976900393] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"248.736341ms","start":"2026-06-20T03:02:09.374119Z","end":"2026-06-20T03:02:09.622855Z","steps":["trace[1976900393] 'process raft request' (duration: 248.618328ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:09.622984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.362258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kube-scheduler\" ","response":"range_response_count:1 size:1381"} {"level":"info","ts":"2026-06-20T03:02:09.622936Z","caller":"traceutil/trace.go:171","msg":"trace[300942339] transaction","detail":"{read_only:false; response_revision:2518; number_of_response:1; }","duration":"249.123281ms","start":"2026-06-20T03:02:09.373736Z","end":"2026-06-20T03:02:09.622859Z","steps":["trace[300942339] 'process raft request' (duration: 248.855525ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:09.623019Z","caller":"traceutil/trace.go:171","msg":"trace[505420955] range","detail":"{range_begin:/registry/clusterroles/system:kube-scheduler; range_end:; response_count:1; response_revision:2519; }","duration":"239.433971ms","start":"2026-06-20T03:02:09.383575Z","end":"2026-06-20T03:02:09.623008Z","steps":["trace[505420955] 'agreement among raft nodes before linearized reading' (duration: 239.343098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:09.623089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.089733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-06-20T03:02:09.623142Z","caller":"traceutil/trace.go:171","msg":"trace[635715512] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:root-ca-cert-publisher; range_end:; response_count:1; response_revision:2519; }","duration":"207.187535ms","start":"2026-06-20T03:02:09.415939Z","end":"2026-06-20T03:02:09.623127Z","steps":["trace[635715512] 'agreement among raft nodes before linearized reading' (duration: 207.087323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:09.88014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.464624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:root-ca-cert-publisher\" ","response":"range_response_count:1 size:763"} {"level":"info","ts":"2026-06-20T03:02:09.880219Z","caller":"traceutil/trace.go:171","msg":"trace[524779380] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:root-ca-cert-publisher; range_end:; response_count:1; response_revision:2519; }","duration":"178.592037ms","start":"2026-06-20T03:02:09.701609Z","end":"2026-06-20T03:02:09.880201Z","steps":["trace[524779380] 'range keys from in-memory index tree' (duration: 178.368591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:09.880659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.745815ms","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:531"} {"level":"info","ts":"2026-06-20T03:02:09.880661Z","caller":"traceutil/trace.go:171","msg":"trace[1369875028] transaction","detail":"{read_only:false; response_revision:2520; number_of_response:1; }","duration":"164.364348ms","start":"2026-06-20T03:02:09.716272Z","end":"2026-06-20T03:02:09.880636Z","steps":["trace[1369875028] 'process raft request' (duration: 160.944007ms)"],"step_count":1} {"level":"info","ts":"2026-06-20T03:02:09.880722Z","caller":"traceutil/trace.go:171","msg":"trace[171948346] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2519; }","duration":"166.824657ms","start":"2026-06-20T03:02:09.713883Z","end":"2026-06-20T03:02:09.880708Z","steps":["trace[171948346] 'range keys from in-memory index tree' (duration: 166.628573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-20T03:02:09.880504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.588753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:kubelet-api-admin\" ","response":"range_response_count:1 size:662"} {"level":"info","ts":"2026-06-20T03:02:09.880895Z","caller":"traceutil/trace.go:171","msg":"trace[203090594] range","detail":"{range_begin:/registry/clusterroles/system:kubelet-api-admin; range_end:; response_count:1; response_revision:2519; }","duration":"170.040195ms","start":"2026-06-20T03:02:09.710845Z","end":"2026-06-20T03:02:09.880885Z","steps":["trace[203090594] 'range keys from in-memory index tree' (duration: 169.395389ms)"],"step_count":1}