{"level":"warn","ts":"2026-06-24T13:10:48.877064Z","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-24T13:10:48.877187Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.139:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.139:2380","--initial-cluster=instance=https://199.19.213.139:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.139:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.139: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-24T13:10:48.877268Z","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-24T13:10:48.87728Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.139:2380"]} {"level":"info","ts":"2026-06-24T13:10:48.877299Z","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-24T13:10:48.878227Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"]} {"level":"info","ts":"2026-06-24T13:10:48.878363Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.139:2380"],"listen-peer-urls":["https://199.19.213.139:2380"],"advertise-client-urls":["https://199.19.213.139:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.139: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-24T13:10:48.887268Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.823814ms"} {"level":"info","ts":"2026-06-24T13:10:48.900808Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"cb257ce137899862","cluster-id":"9913588efaa998c1"} {"level":"info","ts":"2026-06-24T13:10:48.900942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T13:10:48.90098Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became follower at term 0"} {"level":"info","ts":"2026-06-24T13:10:48.901Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft cb257ce137899862 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T13:10:48.901022Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became follower at term 1"} {"level":"info","ts":"2026-06-24T13:10:48.901318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=(14638243470578915426)"} {"level":"warn","ts":"2026-06-24T13:10:48.925206Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T13:10:48.933226Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T13:10:48.946617Z","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-24T13:10:48.949547Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"cb257ce137899862","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T13:10:48.94973Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"cb257ce137899862","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T13:10:48.949782Z","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-24T13:10:48.953529Z","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-24T13:10:48.953607Z","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-24T13:10:48.958477Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 switched to configuration voters=(14638243470578915426)"} {"level":"info","ts":"2026-06-24T13:10:48.958646Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9913588efaa998c1","local-member-id":"cb257ce137899862","added-peer-id":"cb257ce137899862","added-peer-peer-urls":["https://199.19.213.139:2380"]} {"level":"info","ts":"2026-06-24T13:10:48.959029Z","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-24T13:10:48.95934Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"cb257ce137899862","initial-advertise-peer-urls":["https://199.19.213.139:2380"],"listen-peer-urls":["https://199.19.213.139:2380"],"advertise-client-urls":["https://199.19.213.139:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.139:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T13:10:48.959291Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.139:2380"} {"level":"info","ts":"2026-06-24T13:10:48.959489Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.139:2380"} {"level":"info","ts":"2026-06-24T13:10:48.959368Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T13:10:49.60245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T13:10:49.602543Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T13:10:49.602578Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 received MsgPreVoteResp from cb257ce137899862 at term 1"} {"level":"info","ts":"2026-06-24T13:10:49.602594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became candidate at term 2"} {"level":"info","ts":"2026-06-24T13:10:49.6026Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 received MsgVoteResp from cb257ce137899862 at term 2"} {"level":"info","ts":"2026-06-24T13:10:49.60261Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"cb257ce137899862 became leader at term 2"} {"level":"info","ts":"2026-06-24T13:10:49.60262Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: cb257ce137899862 elected leader cb257ce137899862 at term 2"} {"level":"info","ts":"2026-06-24T13:10:49.629539Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T13:10:49.661221Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T13:10:49.661201Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"cb257ce137899862","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.139:2379]}","request-path":"/0/members/cb257ce137899862/attributes","cluster-id":"9913588efaa998c1","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T13:10:49.661653Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T13:10:49.661671Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T13:10:49.661252Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T13:10:49.664531Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T13:10:49.677022Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.139:2379"} {"level":"info","ts":"2026-06-24T13:10:49.694166Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9913588efaa998c1","local-member-id":"cb257ce137899862","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T13:10:49.694333Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T13:10:49.694374Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T13:10:52.312001Z","caller":"traceutil/trace.go:171","msg":"trace[1443024773] transaction","detail":"{read_only:false; response_revision:80; number_of_response:1; }","duration":"262.695672ms","start":"2026-06-24T13:10:52.049253Z","end":"2026-06-24T13:10:52.311949Z","steps":["trace[1443024773] 'process raft request' (duration: 239.879775ms)","trace[1443024773] 'compare' (duration: 22.530384ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:10:52.312082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.856028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-24T13:10:52.312241Z","caller":"traceutil/trace.go:171","msg":"trace[1540948105] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:80; }","duration":"162.085171ms","start":"2026-06-24T13:10:52.150134Z","end":"2026-06-24T13:10:52.312219Z","steps":["trace[1540948105] 'agreement among raft nodes before linearized reading' (duration: 161.875399ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:52.312003Z","caller":"traceutil/trace.go:171","msg":"trace[978640639] linearizableReadLoop","detail":"{readStateIndex:85; appliedIndex:83; }","duration":"161.752307ms","start":"2026-06-24T13:10:52.150197Z","end":"2026-06-24T13:10:52.311949Z","steps":["trace[978640639] 'read index received' (duration: 138.93327ms)","trace[978640639] 'applied index is now lower than readState.Index' (duration: 22.817807ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:10:52.526425Z","caller":"traceutil/trace.go:171","msg":"trace[2012457588] transaction","detail":"{read_only:false; response_revision:84; number_of_response:1; }","duration":"141.403002ms","start":"2026-06-24T13:10:52.384989Z","end":"2026-06-24T13:10:52.526392Z","steps":["trace[2012457588] 'process raft request' (duration: 78.212769ms)","trace[2012457588] 'compare' (duration: 63.047011ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:10:52.540605Z","caller":"traceutil/trace.go:171","msg":"trace[1994246302] transaction","detail":"{read_only:false; response_revision:85; number_of_response:1; }","duration":"154.896036ms","start":"2026-06-24T13:10:52.385681Z","end":"2026-06-24T13:10:52.540577Z","steps":["trace[1994246302] 'process raft request' (duration: 154.786665ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:52.769851Z","caller":"traceutil/trace.go:171","msg":"trace[1976778966] transaction","detail":"{read_only:false; response_revision:91; number_of_response:1; }","duration":"152.983852ms","start":"2026-06-24T13:10:52.616836Z","end":"2026-06-24T13:10:52.76982Z","steps":["trace[1976778966] 'process raft request' (duration: 152.935811ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:52.770114Z","caller":"traceutil/trace.go:171","msg":"trace[1692580728] transaction","detail":"{read_only:false; response_revision:90; number_of_response:1; }","duration":"153.458388ms","start":"2026-06-24T13:10:52.616606Z","end":"2026-06-24T13:10:52.770064Z","steps":["trace[1692580728] 'process raft request' (duration: 82.598156ms)","trace[1692580728] 'compare' (duration: 70.422437ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:10:54.756542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.888605ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:10:54.75671Z","caller":"traceutil/trace.go:171","msg":"trace[539905838] linearizableReadLoop","detail":"{readStateIndex:259; appliedIndex:258; }","duration":"289.586062ms","start":"2026-06-24T13:10:54.467103Z","end":"2026-06-24T13:10:54.756689Z","steps":["trace[539905838] 'read index received' (duration: 183.209717ms)","trace[539905838] 'applied index is now lower than readState.Index' (duration: 106.374855ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:10:54.756758Z","caller":"traceutil/trace.go:171","msg":"trace[922938460] transaction","detail":"{read_only:false; response_revision:253; number_of_response:1; }","duration":"314.073578ms","start":"2026-06-24T13:10:54.442647Z","end":"2026-06-24T13:10:54.756721Z","steps":["trace[922938460] 'process raft request' (duration: 207.787825ms)","trace[922938460] 'compare' (duration: 104.756843ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:10:54.75681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.704993ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:10:54.756853Z","caller":"traceutil/trace.go:171","msg":"trace[1886703469] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:253; }","duration":"289.790974ms","start":"2026-06-24T13:10:54.467052Z","end":"2026-06-24T13:10:54.756843Z","steps":["trace[1886703469] 'agreement among raft nodes before linearized reading' (duration: 289.689563ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:10:54.756922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:10:54.44263Z","time spent":"314.21961ms","remote":"127.0.0.1:36438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11436,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T13:10:54.895782Z","caller":"traceutil/trace.go:171","msg":"trace[2126518479] transaction","detail":"{read_only:false; response_revision:256; number_of_response:1; }","duration":"116.027768ms","start":"2026-06-24T13:10:54.779712Z","end":"2026-06-24T13:10:54.89574Z","steps":["trace[2126518479] 'process raft request' (duration: 99.445535ms)","trace[2126518479] 'compare' (duration: 16.411681ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:10:54.895873Z","caller":"traceutil/trace.go:171","msg":"trace[1029650811] linearizableReadLoop","detail":"{readStateIndex:262; appliedIndex:261; }","duration":"104.303138ms","start":"2026-06-24T13:10:54.791553Z","end":"2026-06-24T13:10:54.895856Z","steps":["trace[1029650811] 'read index received' (duration: 87.47468ms)","trace[1029650811] 'applied index is now lower than readState.Index' (duration: 16.827608ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:10:54.896219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.865241ms","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-24T13:10:54.8958Z","caller":"traceutil/trace.go:171","msg":"trace[155088459] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"100.167324ms","start":"2026-06-24T13:10:54.795609Z","end":"2026-06-24T13:10:54.895776Z","steps":["trace[155088459] 'process raft request' (duration: 100.126323ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:54.896258Z","caller":"traceutil/trace.go:171","msg":"trace[504106043] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:257; }","duration":"116.945492ms","start":"2026-06-24T13:10:54.779305Z","end":"2026-06-24T13:10:54.89625Z","steps":["trace[504106043] 'agreement among raft nodes before linearized reading' (duration: 116.81392ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:10:56.081778Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.952996ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:10:56.082094Z","caller":"traceutil/trace.go:171","msg":"trace[1666778036] transaction","detail":"{read_only:false; number_of_response:0; response_revision:295; }","duration":"161.564506ms","start":"2026-06-24T13:10:55.920503Z","end":"2026-06-24T13:10:56.082068Z","steps":["trace[1666778036] 'process raft request' (duration: 161.511726ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:56.082229Z","caller":"traceutil/trace.go:171","msg":"trace[964400314] linearizableReadLoop","detail":"{readStateIndex:300; appliedIndex:299; }","duration":"281.54663ms","start":"2026-06-24T13:10:55.80056Z","end":"2026-06-24T13:10:56.082107Z","steps":["trace[964400314] 'read index received' (duration: 123.973055ms)","trace[964400314] 'applied index is now lower than readState.Index' (duration: 157.570365ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:10:56.082381Z","caller":"traceutil/trace.go:171","msg":"trace[1430120536] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"262.524606ms","start":"2026-06-24T13:10:55.819838Z","end":"2026-06-24T13:10:56.082362Z","steps":["trace[1430120536] 'process raft request' (duration: 262.098871ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:10:56.082592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.025995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/namespace-controller\" ","response":"range_response_count:1 size:205"} {"level":"info","ts":"2026-06-24T13:10:56.083316Z","caller":"traceutil/trace.go:171","msg":"trace[1067824182] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/namespace-controller; range_end:; response_count:1; response_revision:295; }","duration":"282.798416ms","start":"2026-06-24T13:10:55.800495Z","end":"2026-06-24T13:10:56.083294Z","steps":["trace[1067824182] 'agreement among raft nodes before linearized reading' (duration: 281.981615ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:56.08269Z","caller":"traceutil/trace.go:171","msg":"trace[77421660] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"303.30264ms","start":"2026-06-24T13:10:55.779263Z","end":"2026-06-24T13:10:56.082565Z","steps":["trace[77421660] 'process raft request' (duration: 145.232889ms)","trace[77421660] 'compare' (duration: 156.568192ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:10:56.08349Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:10:55.779249Z","time spent":"304.163622ms","remote":"127.0.0.1:36450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1934,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T13:10:56.085985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.439076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:1 size:664"} {"level":"info","ts":"2026-06-24T13:10:56.086066Z","caller":"traceutil/trace.go:171","msg":"trace[187582543] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:1; response_revision:298; }","duration":"266.613059ms","start":"2026-06-24T13:10:55.819433Z","end":"2026-06-24T13:10:56.086046Z","steps":["trace[187582543] 'agreement among raft nodes before linearized reading' (duration: 266.413505ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:56.086235Z","caller":"traceutil/trace.go:171","msg":"trace[660205496] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"152.259207ms","start":"2026-06-24T13:10:55.933942Z","end":"2026-06-24T13:10:56.086201Z","steps":["trace[660205496] 'process raft request' (duration: 150.317921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:10:56.086286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.907072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-node-lease/instance\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:10:56.086332Z","caller":"traceutil/trace.go:171","msg":"trace[2133150608] range","detail":"{range_begin:/registry/leases/kube-node-lease/instance; range_end:; response_count:0; response_revision:298; }","duration":"266.972093ms","start":"2026-06-24T13:10:55.819347Z","end":"2026-06-24T13:10:56.086319Z","steps":["trace[2133150608] 'agreement among raft nodes before linearized reading' (duration: 266.901982ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:56.086468Z","caller":"traceutil/trace.go:171","msg":"trace[429770157] transaction","detail":"{read_only:false; number_of_response:0; response_revision:296; }","duration":"152.468489ms","start":"2026-06-24T13:10:55.93399Z","end":"2026-06-24T13:10:56.086459Z","steps":["trace[429770157] 'process raft request' (duration: 150.344661ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:56.08654Z","caller":"traceutil/trace.go:171","msg":"trace[1281987618] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"152.414979ms","start":"2026-06-24T13:10:55.934118Z","end":"2026-06-24T13:10:56.086533Z","steps":["trace[1281987618] 'process raft request' (duration: 150.25209ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:56.086604Z","caller":"traceutil/trace.go:171","msg":"trace[551184551] transaction","detail":"{read_only:false; number_of_response:0; response_revision:297; }","duration":"151.04596ms","start":"2026-06-24T13:10:55.935552Z","end":"2026-06-24T13:10:56.086598Z","steps":["trace[551184551] 'process raft request' (duration: 148.858122ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:10:56.086663Z","caller":"traceutil/trace.go:171","msg":"trace[716364978] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"150.567905ms","start":"2026-06-24T13:10:55.936088Z","end":"2026-06-24T13:10:56.086656Z","steps":["trace[716364978] 'process raft request' (duration: 148.342516ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:00.013852Z","caller":"traceutil/trace.go:171","msg":"trace[641904584] transaction","detail":"{read_only:false; response_revision:354; number_of_response:1; }","duration":"141.008577ms","start":"2026-06-24T13:10:59.87281Z","end":"2026-06-24T13:11:00.013819Z","steps":["trace[641904584] 'process raft request' (duration: 130.298091ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:00.013955Z","caller":"traceutil/trace.go:171","msg":"trace[1171046318] transaction","detail":"{read_only:false; response_revision:355; number_of_response:1; }","duration":"139.66978ms","start":"2026-06-24T13:10:59.87423Z","end":"2026-06-24T13:11:00.0139Z","steps":["trace[1171046318] 'process raft request' (duration: 139.505798ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:00.013911Z","caller":"traceutil/trace.go:171","msg":"trace[1442077058] linearizableReadLoop","detail":"{readStateIndex:369; appliedIndex:365; }","duration":"113.787611ms","start":"2026-06-24T13:10:59.90008Z","end":"2026-06-24T13:11:00.013868Z","steps":["trace[1442077058] 'read index received' (duration: 21.184558ms)","trace[1442077058] 'applied index is now lower than readState.Index' (duration: 92.600743ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:00.01422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.115085ms","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-24T13:11:00.014294Z","caller":"traceutil/trace.go:171","msg":"trace[2024115536] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/root-ca-cert-publisher; range_end:; response_count:1; response_revision:356; }","duration":"114.231527ms","start":"2026-06-24T13:10:59.900041Z","end":"2026-06-24T13:11:00.014272Z","steps":["trace[2024115536] 'agreement among raft nodes before linearized reading' (duration: 114.077055ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:00.014016Z","caller":"traceutil/trace.go:171","msg":"trace[1975038730] transaction","detail":"{read_only:false; response_revision:356; number_of_response:1; }","duration":"137.433271ms","start":"2026-06-24T13:10:59.876519Z","end":"2026-06-24T13:11:00.013952Z","steps":["trace[1975038730] 'process raft request' (duration: 137.292ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:00.392539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.493429ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:11:00.392834Z","caller":"traceutil/trace.go:171","msg":"trace[1783641937] transaction","detail":"{read_only:false; response_revision:358; number_of_response:1; }","duration":"370.124966ms","start":"2026-06-24T13:11:00.022671Z","end":"2026-06-24T13:11:00.392795Z","steps":["trace[1783641937] 'process raft request' (duration: 246.241972ms)","trace[1783641937] 'compare' (duration: 123.146805ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:00.392929Z","caller":"traceutil/trace.go:171","msg":"trace[1452007629] transaction","detail":"{read_only:false; response_revision:359; number_of_response:1; }","duration":"369.801163ms","start":"2026-06-24T13:11:00.023093Z","end":"2026-06-24T13:11:00.392894Z","steps":["trace[1452007629] 'process raft request' (duration: 369.59826ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:00.39292Z","caller":"traceutil/trace.go:171","msg":"trace[748150733] linearizableReadLoop","detail":"{readStateIndex:372; appliedIndex:369; }","duration":"342.600859ms","start":"2026-06-24T13:11:00.050267Z","end":"2026-06-24T13:11:00.392868Z","steps":["trace[748150733] 'read index received' (duration: 35.490038ms)","trace[748150733] 'applied index is now lower than readState.Index' (duration: 307.108951ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:00.39297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:00.022648Z","time spent":"370.253678ms","remote":"127.0.0.1:36450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1723,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T13:11:00.393134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:00.02308Z","time spent":"369.934165ms","remote":"127.0.0.1:36814","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2150,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T13:11:00.393167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"342.875192ms","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-24T13:11:00.393302Z","caller":"traceutil/trace.go:171","msg":"trace[156005200] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller; range_end:; response_count:1; response_revision:359; }","duration":"343.044134ms","start":"2026-06-24T13:11:00.050222Z","end":"2026-06-24T13:11:00.393266Z","steps":["trace[156005200] 'agreement among raft nodes before linearized reading' (duration: 342.74713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:00.393361Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:00.050208Z","time spent":"343.144006ms","remote":"127.0.0.1:36542","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":258,"request content":"key:\"/registry/serviceaccounts/kube-system/clusterrole-aggregation-controller\" "} {"level":"warn","ts":"2026-06-24T13:11:00.39338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.777839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/service-account-controller\" ","response":"range_response_count:1 size:218"} {"level":"info","ts":"2026-06-24T13:11:00.393447Z","caller":"traceutil/trace.go:171","msg":"trace[776927977] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/service-account-controller; range_end:; response_count:1; response_revision:359; }","duration":"292.853549ms","start":"2026-06-24T13:11:00.100573Z","end":"2026-06-24T13:11:00.393427Z","steps":["trace[776927977] 'agreement among raft nodes before linearized reading' (duration: 292.707368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:00.393512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.595164ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/replicaset-controller\" ","response":"range_response_count:1 size:207"} {"level":"warn","ts":"2026-06-24T13:11:00.393523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.555477ms","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-24T13:11:00.39356Z","caller":"traceutil/trace.go:171","msg":"trace[1315690294] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/replicaset-controller; range_end:; response_count:1; response_revision:359; }","duration":"242.674706ms","start":"2026-06-24T13:11:00.150874Z","end":"2026-06-24T13:11:00.393549Z","steps":["trace[1315690294] 'agreement among raft nodes before linearized reading' (duration: 242.571965ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:00.393576Z","caller":"traceutil/trace.go:171","msg":"trace[1129821178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:359; }","duration":"228.640288ms","start":"2026-06-24T13:11:00.164919Z","end":"2026-06-24T13:11:00.393559Z","steps":["trace[1129821178] 'agreement among raft nodes before linearized reading' (duration: 228.523067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:00.393708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.423536ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-24T13:11:00.393766Z","caller":"traceutil/trace.go:171","msg":"trace[118606669] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:359; }","duration":"228.505186ms","start":"2026-06-24T13:11:00.165247Z","end":"2026-06-24T13:11:00.393753Z","steps":["trace[118606669] 'agreement among raft nodes before linearized reading' (duration: 228.405385ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:09.253249Z","caller":"traceutil/trace.go:171","msg":"trace[1938313957] linearizableReadLoop","detail":"{readStateIndex:440; appliedIndex:439; }","duration":"262.78528ms","start":"2026-06-24T13:11:08.990435Z","end":"2026-06-24T13:11:09.25322Z","steps":["trace[1938313957] 'read index received' (duration: 250.920364ms)","trace[1938313957] 'applied index is now lower than readState.Index' (duration: 11.863506ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:09.253417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.966652ms","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-24T13:11:09.253453Z","caller":"traceutil/trace.go:171","msg":"trace[1877952817] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:424; }","duration":"263.078144ms","start":"2026-06-24T13:11:08.990364Z","end":"2026-06-24T13:11:09.253442Z","steps":["trace[1877952817] 'agreement among raft nodes before linearized reading' (duration: 262.968593ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:13.987784Z","caller":"traceutil/trace.go:171","msg":"trace[1995356180] linearizableReadLoop","detail":"{readStateIndex:450; appliedIndex:449; }","duration":"235.299976ms","start":"2026-06-24T13:11:13.75245Z","end":"2026-06-24T13:11:13.98775Z","steps":["trace[1995356180] 'read index received' (duration: 235.072913ms)","trace[1995356180] 'applied index is now lower than readState.Index' (duration: 226.113µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:13.987888Z","caller":"traceutil/trace.go:171","msg":"trace[1244598066] transaction","detail":"{read_only:false; response_revision:434; number_of_response:1; }","duration":"705.833317ms","start":"2026-06-24T13:11:13.282022Z","end":"2026-06-24T13:11:13.987855Z","steps":["trace[1244598066] 'process raft request' (duration: 705.568754ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:13.988094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.758823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:13.988152Z","caller":"traceutil/trace.go:171","msg":"trace[1105316430] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:434; }","duration":"169.942447ms","start":"2026-06-24T13:11:13.818195Z","end":"2026-06-24T13:11:13.988137Z","steps":["trace[1105316430] 'agreement among raft nodes before linearized reading' (duration: 169.732133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:13.988344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.788223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.139\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T13:11:13.988519Z","caller":"traceutil/trace.go:171","msg":"trace[1915545338] range","detail":"{range_begin:/registry/masterleases/199.19.213.139; range_end:; response_count:1; response_revision:434; }","duration":"236.078847ms","start":"2026-06-24T13:11:13.752408Z","end":"2026-06-24T13:11:13.988487Z","steps":["trace[1915545338] 'agreement among raft nodes before linearized reading' (duration: 235.502519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:13.989295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:13.282005Z","time spent":"705.96079ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T13:11:14.21433Z","caller":"traceutil/trace.go:171","msg":"trace[1558683535] transaction","detail":"{read_only:false; response_revision:436; number_of_response:1; }","duration":"213.09264ms","start":"2026-06-24T13:11:14.001214Z","end":"2026-06-24T13:11:14.214306Z","steps":["trace[1558683535] 'process raft request' (duration: 213.04551ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:14.214368Z","caller":"traceutil/trace.go:171","msg":"trace[1544069213] transaction","detail":"{read_only:false; response_revision:435; number_of_response:1; }","duration":"220.874875ms","start":"2026-06-24T13:11:13.993467Z","end":"2026-06-24T13:11:14.214342Z","steps":["trace[1544069213] 'process raft request' (duration: 220.646532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:15.876775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.541223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:11:15.876935Z","caller":"traceutil/trace.go:171","msg":"trace[1648141102] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"150.42647ms","start":"2026-06-24T13:11:15.726497Z","end":"2026-06-24T13:11:15.876924Z","steps":["trace[1648141102] 'process raft request' (duration: 150.377789ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:15.877067Z","caller":"traceutil/trace.go:171","msg":"trace[720525071] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"151.448351ms","start":"2026-06-24T13:11:15.725613Z","end":"2026-06-24T13:11:15.877062Z","steps":["trace[720525071] 'compare' (duration: 142.31876ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:15.877253Z","caller":"traceutil/trace.go:171","msg":"trace[909645897] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"151.482621ms","start":"2026-06-24T13:11:15.72575Z","end":"2026-06-24T13:11:15.877233Z","steps":["trace[909645897] 'process raft request' (duration: 151.100107ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:15.878941Z","caller":"traceutil/trace.go:171","msg":"trace[1315958249] linearizableReadLoop","detail":"{readStateIndex:483; appliedIndex:478; }","duration":"144.962752ms","start":"2026-06-24T13:11:15.733969Z","end":"2026-06-24T13:11:15.878932Z","steps":["trace[1315958249] 'read index received' (duration: 207.292µs)","trace[1315958249] 'applied index is now lower than readState.Index' (duration: 144.7549ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:15.87899Z","caller":"traceutil/trace.go:171","msg":"trace[1963349721] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"150.346077ms","start":"2026-06-24T13:11:15.728638Z","end":"2026-06-24T13:11:15.878984Z","steps":["trace[1963349721] 'process raft request' (duration: 150.232126ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:15.879135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.151995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-06-24T13:11:15.879217Z","caller":"traceutil/trace.go:171","msg":"trace[1861944053] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:466; }","duration":"145.276876ms","start":"2026-06-24T13:11:15.733919Z","end":"2026-06-24T13:11:15.879196Z","steps":["trace[1861944053] 'agreement among raft nodes before linearized reading' (duration: 145.138765ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:15.879262Z","caller":"traceutil/trace.go:171","msg":"trace[369970104] transaction","detail":"{read_only:false; response_revision:466; number_of_response:1; }","duration":"149.517058ms","start":"2026-06-24T13:11:15.729737Z","end":"2026-06-24T13:11:15.879254Z","steps":["trace[369970104] 'process raft request' (duration: 149.170554ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:16.033758Z","caller":"traceutil/trace.go:171","msg":"trace[1748551438] transaction","detail":"{read_only:false; response_revision:468; number_of_response:1; }","duration":"146.052176ms","start":"2026-06-24T13:11:15.887675Z","end":"2026-06-24T13:11:16.033727Z","steps":["trace[1748551438] 'process raft request' (duration: 123.390344ms)","trace[1748551438] 'compare' (duration: 22.333407ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:18.585223Z","caller":"traceutil/trace.go:171","msg":"trace[1938072743] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"290.322429ms","start":"2026-06-24T13:11:18.294872Z","end":"2026-06-24T13:11:18.585195Z","steps":["trace[1938072743] 'process raft request' (duration: 290.135877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:18.7707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.886826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:18.770792Z","caller":"traceutil/trace.go:171","msg":"trace[1531034219] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:476; }","duration":"129.034628ms","start":"2026-06-24T13:11:18.641736Z","end":"2026-06-24T13:11:18.770771Z","steps":["trace[1531034219] 'range keys from in-memory index tree' (duration: 128.796485ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:18.771033Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.564671ms","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-24T13:11:18.771078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.551801ms","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-24T13:11:18.771141Z","caller":"traceutil/trace.go:171","msg":"trace[9276601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:476; }","duration":"143.714663ms","start":"2026-06-24T13:11:18.627388Z","end":"2026-06-24T13:11:18.771103Z","steps":["trace[9276601] 'range keys from in-memory index tree' (duration: 143.411589ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:18.771223Z","caller":"traceutil/trace.go:171","msg":"trace[35762035] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:476; }","duration":"143.629362ms","start":"2026-06-24T13:11:18.627475Z","end":"2026-06-24T13:11:18.771104Z","steps":["trace[35762035] 'range keys from in-memory index tree' (duration: 143.296858ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:18.892891Z","caller":"traceutil/trace.go:171","msg":"trace[33263440] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"117.263688ms","start":"2026-06-24T13:11:18.775599Z","end":"2026-06-24T13:11:18.892862Z","steps":["trace[33263440] 'process raft request' (duration: 117.086566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:19.143563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.748439ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:11:19.143671Z","caller":"traceutil/trace.go:171","msg":"trace[1045386274] linearizableReadLoop","detail":"{readStateIndex:495; appliedIndex:493; }","duration":"325.182671ms","start":"2026-06-24T13:11:18.818471Z","end":"2026-06-24T13:11:19.143653Z","steps":["trace[1045386274] 'read index received' (duration: 74.144243ms)","trace[1045386274] 'applied index is now lower than readState.Index' (duration: 251.037328ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:19.143789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.328632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:19.143823Z","caller":"traceutil/trace.go:171","msg":"trace[450254122] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:478; }","duration":"325.400194ms","start":"2026-06-24T13:11:18.818413Z","end":"2026-06-24T13:11:19.143813Z","steps":["trace[450254122] 'agreement among raft nodes before linearized reading' (duration: 325.286093ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:19.143857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:18.818393Z","time spent":"325.456774ms","remote":"127.0.0.1:36334","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T13:11:19.144263Z","caller":"traceutil/trace.go:171","msg":"trace[20351796] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"368.310245ms","start":"2026-06-24T13:11:18.77594Z","end":"2026-06-24T13:11:19.14425Z","steps":["trace[20351796] 'process raft request' (duration: 265.792057ms)","trace[20351796] 'compare' (duration: 101.624778ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:19.144335Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:18.775922Z","time spent":"368.379665ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T13:11:25.025065Z","caller":"traceutil/trace.go:171","msg":"trace[118374424] linearizableReadLoop","detail":"{readStateIndex:509; appliedIndex:508; }","duration":"207.747764ms","start":"2026-06-24T13:11:24.817293Z","end":"2026-06-24T13:11:25.025041Z","steps":["trace[118374424] 'read index received' (duration: 207.579032ms)","trace[118374424] 'applied index is now lower than readState.Index' (duration: 167.582µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:25.025227Z","caller":"traceutil/trace.go:171","msg":"trace[1716253983] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"412.348072ms","start":"2026-06-24T13:11:24.612869Z","end":"2026-06-24T13:11:25.025217Z","steps":["trace[1716253983] 'process raft request' (duration: 412.025518ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:25.025331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:24.61285Z","time spent":"412.404393ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:11:25.025331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.431881ms","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-24T13:11:25.025384Z","caller":"traceutil/trace.go:171","msg":"trace[1111115498] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:490; }","duration":"102.530322ms","start":"2026-06-24T13:11:24.922841Z","end":"2026-06-24T13:11:25.025372Z","steps":["trace[1111115498] 'agreement among raft nodes before linearized reading' (duration: 102.440821ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:25.025475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.183739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:25.025498Z","caller":"traceutil/trace.go:171","msg":"trace[2054839003] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:490; }","duration":"208.25103ms","start":"2026-06-24T13:11:24.817233Z","end":"2026-06-24T13:11:25.025485Z","steps":["trace[2054839003] 'agreement among raft nodes before linearized reading' (duration: 208.22818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:27.434157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.173664ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:11:27.434377Z","caller":"traceutil/trace.go:171","msg":"trace[1041471460] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"157.739884ms","start":"2026-06-24T13:11:27.276617Z","end":"2026-06-24T13:11:27.434357Z","steps":["trace[1041471460] 'process raft request' (duration: 157.665893ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:27.43438Z","caller":"traceutil/trace.go:171","msg":"trace[1602264157] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"157.974757ms","start":"2026-06-24T13:11:27.276368Z","end":"2026-06-24T13:11:27.434343Z","steps":["trace[1602264157] 'process raft request' (duration: 45.53882ms)","trace[1602264157] 'compare' (duration: 111.982862ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:29.182765Z","caller":"traceutil/trace.go:171","msg":"trace[1741141360] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"137.674363ms","start":"2026-06-24T13:11:29.045061Z","end":"2026-06-24T13:11:29.182735Z","steps":["trace[1741141360] 'process raft request' (duration: 137.36382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.112999Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513637008099752,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T13:11:30.343981Z","caller":"traceutil/trace.go:171","msg":"trace[449526006] transaction","detail":"{read_only:false; response_revision:569; number_of_response:1; }","duration":"900.446967ms","start":"2026-06-24T13:11:29.443509Z","end":"2026-06-24T13:11:30.343956Z","steps":["trace[449526006] 'process raft request' (duration: 899.908241ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:30.344012Z","caller":"traceutil/trace.go:171","msg":"trace[1415056246] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"888.808572ms","start":"2026-06-24T13:11:29.455174Z","end":"2026-06-24T13:11:30.343983Z","steps":["trace[1415056246] 'process raft request' (duration: 888.334827ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:30.344077Z","caller":"traceutil/trace.go:171","msg":"trace[1362546016] transaction","detail":"{read_only:false; response_revision:568; number_of_response:1; }","duration":"901.915934ms","start":"2026-06-24T13:11:29.442122Z","end":"2026-06-24T13:11:30.344038Z","steps":["trace[1362546016] 'process raft request' (duration: 886.042221ms)","trace[1362546016] 'compare' (duration: 15.089994ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:30.344218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.443489Z","time spent":"900.552699ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29461,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:11:30.34425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.442099Z","time spent":"902.058946ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31121,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:11:30.34435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.455155Z","time spent":"888.918154ms","remote":"127.0.0.1:36394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T13:11:30.359966Z","caller":"traceutil/trace.go:171","msg":"trace[1292530736] linearizableReadLoop","detail":"{readStateIndex:594; appliedIndex:590; }","duration":"748.029064ms","start":"2026-06-24T13:11:29.611911Z","end":"2026-06-24T13:11:30.35994Z","steps":["trace[1292530736] 'read index received' (duration: 716.173486ms)","trace[1292530736] 'applied index is now lower than readState.Index' (duration: 31.854078ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:30.360143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.193226ms","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:5"} {"level":"info","ts":"2026-06-24T13:11:30.360261Z","caller":"traceutil/trace.go:171","msg":"trace[725579362] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:570; }","duration":"748.369518ms","start":"2026-06-24T13:11:29.61188Z","end":"2026-06-24T13:11:30.360249Z","steps":["trace[725579362] 'agreement among raft nodes before linearized reading' (duration: 748.193696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.360294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.611857Z","time spent":"748.427569ms","remote":"127.0.0.1:53260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"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-24T13:11:30.360664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"748.747832ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.360696Z","caller":"traceutil/trace.go:171","msg":"trace[920003912] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:570; }","duration":"748.819723ms","start":"2026-06-24T13:11:29.611868Z","end":"2026-06-24T13:11:30.360687Z","steps":["trace[920003912] 'agreement among raft nodes before linearized reading' (duration: 748.765013ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.360839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.611847Z","time spent":"748.865094ms","remote":"127.0.0.1:53260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-06-24T13:11:30.373362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.540666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.373434Z","caller":"traceutil/trace.go:171","msg":"trace[738464101] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:572; }","duration":"746.653907ms","start":"2026-06-24T13:11:29.626765Z","end":"2026-06-24T13:11:30.373419Z","steps":["trace[738464101] 'agreement among raft nodes before linearized reading' (duration: 746.524256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.373533Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.626755Z","time spent":"746.769218ms","remote":"127.0.0.1:53262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 "} {"level":"warn","ts":"2026-06-24T13:11:30.373837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.008747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.373891Z","caller":"traceutil/trace.go:171","msg":"trace[474200932] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:572; }","duration":"687.056648ms","start":"2026-06-24T13:11:29.686816Z","end":"2026-06-24T13:11:30.373873Z","steps":["trace[474200932] 'agreement among raft nodes before linearized reading' (duration: 686.985587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.374303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.686768Z","time spent":"687.524114ms","remote":"127.0.0.1:53272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:500 "} {"level":"warn","ts":"2026-06-24T13:11:30.373969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.058941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.374491Z","caller":"traceutil/trace.go:171","msg":"trace[1764266833] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:572; }","duration":"555.524666ms","start":"2026-06-24T13:11:29.818891Z","end":"2026-06-24T13:11:30.374416Z","steps":["trace[1764266833] 'agreement among raft nodes before linearized reading' (duration: 555.055631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.374526Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.818883Z","time spent":"555.635697ms","remote":"127.0.0.1:36342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T13:11:30.373992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.204571ms","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-24T13:11:30.37468Z","caller":"traceutil/trace.go:171","msg":"trace[573449295] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:572; }","duration":"688.92822ms","start":"2026-06-24T13:11:29.685743Z","end":"2026-06-24T13:11:30.374671Z","steps":["trace[573449295] 'agreement among raft nodes before linearized reading' (duration: 688.217942ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.374841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.685722Z","time spent":"689.108931ms","remote":"127.0.0.1:53274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T13:11:30.374025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"688.405494ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.374917Z","caller":"traceutil/trace.go:171","msg":"trace[1062758396] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:572; }","duration":"689.302653ms","start":"2026-06-24T13:11:29.685601Z","end":"2026-06-24T13:11:30.374903Z","steps":["trace[1062758396] 'agreement among raft nodes before linearized reading' (duration: 688.409003ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.374953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.685593Z","time spent":"689.349644ms","remote":"127.0.0.1:53274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-24T13:11:30.374051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.07661ms","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-24T13:11:30.375014Z","caller":"traceutil/trace.go:171","msg":"trace[2041340562] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:572; }","duration":"714.0537ms","start":"2026-06-24T13:11:29.660955Z","end":"2026-06-24T13:11:30.375008Z","steps":["trace[2041340562] 'agreement among raft nodes before linearized reading' (duration: 713.08216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.37504Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.66095Z","time spent":"714.083621ms","remote":"127.0.0.1:53272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-24T13:11:30.374128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.231531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.375119Z","caller":"traceutil/trace.go:171","msg":"trace[1623202670] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:572; }","duration":"714.274563ms","start":"2026-06-24T13:11:29.660839Z","end":"2026-06-24T13:11:30.375114Z","steps":["trace[1623202670] 'agreement among raft nodes before linearized reading' (duration: 713.222611ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.375145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.660825Z","time spent":"714.313024ms","remote":"127.0.0.1:53272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 "} {"level":"warn","ts":"2026-06-24T13:11:30.374112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.758472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.375242Z","caller":"traceutil/trace.go:171","msg":"trace[860803697] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:572; }","duration":"667.920007ms","start":"2026-06-24T13:11:29.707314Z","end":"2026-06-24T13:11:30.375234Z","steps":["trace[860803697] 'agreement among raft nodes before linearized reading' (duration: 666.750253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.375273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.707306Z","time spent":"667.958597ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 "} {"level":"warn","ts":"2026-06-24T13:11:30.374165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"666.995566ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:30.375394Z","caller":"traceutil/trace.go:171","msg":"trace[1558873638] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:572; }","duration":"668.261721ms","start":"2026-06-24T13:11:29.707125Z","end":"2026-06-24T13:11:30.375387Z","steps":["trace[1558873638] 'agreement among raft nodes before linearized reading' (duration: 667.022597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.375422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.707102Z","time spent":"668.312732ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true "} {"level":"warn","ts":"2026-06-24T13:11:30.374187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"667.018636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T13:11:30.374164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"746.395084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T13:11:30.374251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.325915ms","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:5"} {"level":"warn","ts":"2026-06-24T13:11:30.374258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.561548ms","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-24T13:11:30.376337Z","caller":"traceutil/trace.go:171","msg":"trace[695208790] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:572; }","duration":"133.685613ms","start":"2026-06-24T13:11:30.24264Z","end":"2026-06-24T13:11:30.376325Z","steps":["trace[695208790] 'agreement among raft nodes before linearized reading' (duration: 131.549578ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:30.376445Z","caller":"traceutil/trace.go:171","msg":"trace[1528525937] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:572; }","duration":"669.301843ms","start":"2026-06-24T13:11:29.707132Z","end":"2026-06-24T13:11:30.376434Z","steps":["trace[1528525937] 'agreement among raft nodes before linearized reading' (duration: 667.042827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.376744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.707109Z","time spent":"669.624507ms","remote":"127.0.0.1:53290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 "} {"level":"info","ts":"2026-06-24T13:11:30.376598Z","caller":"traceutil/trace.go:171","msg":"trace[482046272] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:572; }","duration":"748.876173ms","start":"2026-06-24T13:11:29.627715Z","end":"2026-06-24T13:11:30.376591Z","steps":["trace[482046272] 'agreement among raft nodes before linearized reading' (duration: 746.429665ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.376846Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.627693Z","time spent":"749.144676ms","remote":"127.0.0.1:53260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":109,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 "} {"level":"info","ts":"2026-06-24T13:11:30.376625Z","caller":"traceutil/trace.go:171","msg":"trace[1884624472] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:572; }","duration":"749.748394ms","start":"2026-06-24T13:11:29.626872Z","end":"2026-06-24T13:11:30.37662Z","steps":["trace[1884624472] 'agreement among raft nodes before linearized reading' (duration: 747.364996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:30.376959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:29.626836Z","time spent":"750.115707ms","remote":"127.0.0.1:53262","response type":"/etcdserverpb.KV/Range","request count":0,"request size":108,"response count":0,"response size":29,"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-24T13:11:36.758322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.20088ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:11:36.758461Z","caller":"traceutil/trace.go:171","msg":"trace[1482074780] linearizableReadLoop","detail":"{readStateIndex:668; appliedIndex:667; }","duration":"341.765988ms","start":"2026-06-24T13:11:36.416673Z","end":"2026-06-24T13:11:36.758439Z","steps":["trace[1482074780] 'read index received' (duration: 70.5µs)","trace[1482074780] 'applied index is now lower than readState.Index' (duration: 341.694088ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:36.758666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.992961ms","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-24T13:11:36.758715Z","caller":"traceutil/trace.go:171","msg":"trace[1443513769] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:643; }","duration":"342.088932ms","start":"2026-06-24T13:11:36.416612Z","end":"2026-06-24T13:11:36.758701Z","steps":["trace[1443513769] 'agreement among raft nodes before linearized reading' (duration: 341.885909ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:36.75876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:36.416591Z","time spent":"342.158522ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T13:11:36.758762Z","caller":"traceutil/trace.go:171","msg":"trace[26592511] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"498.544712ms","start":"2026-06-24T13:11:36.260169Z","end":"2026-06-24T13:11:36.758714Z","steps":["trace[26592511] 'process raft request' (duration: 113.839085ms)","trace[26592511] 'compare' (duration: 384.031179ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:36.758896Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:36.260144Z","time spent":"498.686224ms","remote":"127.0.0.1:36832","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T13:11:38.348682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.262779436s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:11:38.348998Z","caller":"traceutil/trace.go:171","msg":"trace[1070305446] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:668; }","duration":"1.580493058s","start":"2026-06-24T13:11:36.768475Z","end":"2026-06-24T13:11:38.348968Z","steps":["trace[1070305446] 'read index received' (duration: 317.291277ms)","trace[1070305446] 'applied index is now lower than readState.Index' (duration: 1.263199811s)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:38.349022Z","caller":"traceutil/trace.go:171","msg":"trace[1174130833] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"1.585869229s","start":"2026-06-24T13:11:36.763016Z","end":"2026-06-24T13:11:38.348885Z","steps":["trace[1174130833] 'process raft request' (duration: 322.780229ms)","trace[1174130833] 'compare' (duration: 1.261960137s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:38.349206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.58070001s","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":"info","ts":"2026-06-24T13:11:38.349316Z","caller":"traceutil/trace.go:171","msg":"trace[1234149736] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:644; }","duration":"1.580848662s","start":"2026-06-24T13:11:36.768433Z","end":"2026-06-24T13:11:38.349281Z","steps":["trace[1234149736] 'agreement among raft nodes before linearized reading' (duration: 1.58066945s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:38.349347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.531058306s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T13:11:38.349533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.037279946s","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-24T13:11:38.349574Z","caller":"traceutil/trace.go:171","msg":"trace[605510365] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:645; }","duration":"1.037345026s","start":"2026-06-24T13:11:37.312218Z","end":"2026-06-24T13:11:38.349563Z","steps":["trace[605510365] 'agreement among raft nodes before linearized reading' (duration: 1.037197855s)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:38.349567Z","caller":"traceutil/trace.go:171","msg":"trace[823728495] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:645; }","duration":"1.531215448s","start":"2026-06-24T13:11:36.818233Z","end":"2026-06-24T13:11:38.349448Z","steps":["trace[823728495] 'agreement among raft nodes before linearized reading' (duration: 1.531036236s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:38.349606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:37.312201Z","time spent":"1.037398167s","remote":"127.0.0.1:36606","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-24T13:11:38.349642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:36.818216Z","time spent":"1.53141013s","remote":"127.0.0.1:36342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T13:11:38.349769Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:36.762998Z","time spent":"1.586283794s","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:11:38.349912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.116858139s","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-24T13:11:38.349918Z","caller":"traceutil/trace.go:171","msg":"trace[1486763692] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"1.315676196s","start":"2026-06-24T13:11:37.034185Z","end":"2026-06-24T13:11:38.349861Z","steps":["trace[1486763692] 'process raft request' (duration: 1.314860367s)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:38.350088Z","caller":"traceutil/trace.go:171","msg":"trace[606762313] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:645; }","duration":"1.11703267s","start":"2026-06-24T13:11:37.232984Z","end":"2026-06-24T13:11:38.350016Z","steps":["trace[606762313] 'agreement among raft nodes before linearized reading' (duration: 1.116662136s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:38.35018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:37.03416Z","time spent":"1.315888718s","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:11:38.34938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:36.768419Z","time spent":"1.580950393s","remote":"127.0.0.1:36572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" "} {"level":"warn","ts":"2026-06-24T13:11:38.350199Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:37.232962Z","time spent":"1.117217543s","remote":"127.0.0.1:36606","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-24T13:11:38.350095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.4014292s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-szd2v\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-24T13:11:38.350461Z","caller":"traceutil/trace.go:171","msg":"trace[1900328613] range","detail":"{range_begin:/registry/pods/kube-system/cilium-szd2v; range_end:; response_count:1; response_revision:645; }","duration":"1.401809056s","start":"2026-06-24T13:11:36.948637Z","end":"2026-06-24T13:11:38.350446Z","steps":["trace[1900328613] 'agreement among raft nodes before linearized reading' (duration: 1.401248779s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:38.350549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:36.94863Z","time spent":"1.401905627s","remote":"127.0.0.1:36514","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16989,"request content":"key:\"/registry/pods/kube-system/cilium-szd2v\" "} {"level":"warn","ts":"2026-06-24T13:11:38.351209Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.110659898s","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-24T13:11:38.35139Z","caller":"traceutil/trace.go:171","msg":"trace[36918619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:645; }","duration":"1.111327326s","start":"2026-06-24T13:11:37.239973Z","end":"2026-06-24T13:11:38.351301Z","steps":["trace[36918619] 'agreement among raft nodes before linearized reading' (duration: 1.109701488s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:38.351479Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:37.239949Z","time spent":"1.111518288s","remote":"127.0.0.1:36606","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-24T13:11:39.868503Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.130525754s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T13:11:39.869531Z","caller":"traceutil/trace.go:171","msg":"trace[740298822] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"1.132992822s","start":"2026-06-24T13:11:38.736511Z","end":"2026-06-24T13:11:39.869504Z","steps":["trace[740298822] 'process raft request' (duration: 1.132422884s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:39.869719Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:38.736485Z","time spent":"1.133127874s","remote":"127.0.0.1:36438","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T13:11:39.981837Z","caller":"traceutil/trace.go:171","msg":"trace[688875157] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:674; }","duration":"164.170505ms","start":"2026-06-24T13:11:39.817643Z","end":"2026-06-24T13:11:39.981813Z","steps":["trace[688875157] 'read index received' (duration: 51.115987ms)","trace[688875157] 'applied index is now lower than readState.Index' (duration: 113.052708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:11:40.004913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.252895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:40.005006Z","caller":"traceutil/trace.go:171","msg":"trace[303165967] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:651; }","duration":"187.388297ms","start":"2026-06-24T13:11:39.817598Z","end":"2026-06-24T13:11:40.004986Z","steps":["trace[303165967] 'agreement among raft nodes before linearized reading' (duration: 164.302177ms)","trace[303165967] 'range keys from in-memory index tree' (duration: 22.959659ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:45.354065Z","caller":"traceutil/trace.go:171","msg":"trace[1941992908] transaction","detail":"{read_only:false; response_revision:730; number_of_response:1; }","duration":"130.398014ms","start":"2026-06-24T13:11:45.223643Z","end":"2026-06-24T13:11:45.354041Z","steps":["trace[1941992908] 'process raft request' (duration: 130.257673ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:52.666634Z","caller":"traceutil/trace.go:171","msg":"trace[1489271943] linearizableReadLoop","detail":"{readStateIndex:823; appliedIndex:822; }","duration":"188.146982ms","start":"2026-06-24T13:11:52.478473Z","end":"2026-06-24T13:11:52.66662Z","steps":["trace[1489271943] 'read index received' (duration: 187.98432ms)","trace[1489271943] 'applied index is now lower than readState.Index' (duration: 162.142µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:52.666679Z","caller":"traceutil/trace.go:171","msg":"trace[2076895688] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"208.148442ms","start":"2026-06-24T13:11:52.458517Z","end":"2026-06-24T13:11:52.666665Z","steps":["trace[2076895688] 'process raft request' (duration: 208.016511ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:52.666769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.283403ms","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-24T13:11:52.666787Z","caller":"traceutil/trace.go:171","msg":"trace[1614668108] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:794; }","duration":"188.331815ms","start":"2026-06-24T13:11:52.47845Z","end":"2026-06-24T13:11:52.666782Z","steps":["trace[1614668108] 'agreement among raft nodes before linearized reading' (duration: 188.246904ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:52.666927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.581143ms","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-24T13:11:52.66693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.001013ms","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-24T13:11:52.667182Z","caller":"traceutil/trace.go:171","msg":"trace[445903592] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:794; }","duration":"184.867546ms","start":"2026-06-24T13:11:52.482298Z","end":"2026-06-24T13:11:52.667165Z","steps":["trace[445903592] 'agreement among raft nodes before linearized reading' (duration: 184.449171ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:52.667197Z","caller":"traceutil/trace.go:171","msg":"trace[1524502898] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:794; }","duration":"181.327016ms","start":"2026-06-24T13:11:52.485852Z","end":"2026-06-24T13:11:52.667179Z","steps":["trace[1524502898] 'agreement among raft nodes before linearized reading' (duration: 180.934582ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.156304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.338494065s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:57.15639Z","caller":"traceutil/trace.go:171","msg":"trace[1651292324] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:813; }","duration":"1.338635906s","start":"2026-06-24T13:11:55.817735Z","end":"2026-06-24T13:11:57.156371Z","steps":["trace[1651292324] 'range keys from in-memory index tree' (duration: 1.338395783s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.156383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.257911831s","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-24T13:11:57.156437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:55.817715Z","time spent":"1.338712896s","remote":"127.0.0.1:36342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T13:11:57.156442Z","caller":"traceutil/trace.go:171","msg":"trace[523587911] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:813; }","duration":"1.258020282s","start":"2026-06-24T13:11:55.898408Z","end":"2026-06-24T13:11:57.156428Z","steps":["trace[523587911] 'range keys from in-memory index tree' (duration: 1.25775387s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.156478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:55.898387Z","time spent":"1.258080963s","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T13:11:57.156472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.503043525s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T13:11:57.156511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.949649846s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:57.156527Z","caller":"traceutil/trace.go:171","msg":"trace[957347650] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:813; }","duration":"1.503166227s","start":"2026-06-24T13:11:55.653349Z","end":"2026-06-24T13:11:57.156515Z","steps":["trace[957347650] 'count revisions from in-memory index tree' (duration: 1.502918264s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.156553Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:55.653324Z","time spent":"1.503223307s","remote":"127.0.0.1:36506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":2,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"info","ts":"2026-06-24T13:11:57.156556Z","caller":"traceutil/trace.go:171","msg":"trace[723984452] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:813; }","duration":"1.949737547s","start":"2026-06-24T13:11:55.206805Z","end":"2026-06-24T13:11:57.156543Z","steps":["trace[723984452] 'count revisions from in-memory index tree' (duration: 1.949573696s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.156593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:55.206784Z","time spent":"1.949799498s","remote":"127.0.0.1:36504","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true "} {"level":"warn","ts":"2026-06-24T13:11:57.17201Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.100899213s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T13:11:57.172332Z","caller":"traceutil/trace.go:171","msg":"trace[1562221644] linearizableReadLoop","detail":"{readStateIndex:845; appliedIndex:844; }","duration":"494.864127ms","start":"2026-06-24T13:11:56.677454Z","end":"2026-06-24T13:11:57.172318Z","steps":["trace[1562221644] 'read index received' (duration: 494.754856ms)","trace[1562221644] 'applied index is now lower than readState.Index' (duration: 108.241µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:57.172406Z","caller":"traceutil/trace.go:171","msg":"trace[839340270] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"1.101436589s","start":"2026-06-24T13:11:56.070963Z","end":"2026-06-24T13:11:57.172399Z","steps":["trace[839340270] 'process raft request' (duration: 1.101204047s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.172519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:56.070934Z","time spent":"1.10152015s","remote":"127.0.0.1:36572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:11:57.17268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"495.16742ms","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-24T13:11:57.172781Z","caller":"traceutil/trace.go:171","msg":"trace[1957144419] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:814; }","duration":"495.360743ms","start":"2026-06-24T13:11:56.677402Z","end":"2026-06-24T13:11:57.172763Z","steps":["trace[1957144419] 'agreement among raft nodes before linearized reading' (duration: 495.05132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.172866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:56.677381Z","time spent":"495.471594ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T13:11:57.194182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.230725ms","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-24T13:11:57.194264Z","caller":"traceutil/trace.go:171","msg":"trace[1806335462] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:815; }","duration":"511.364417ms","start":"2026-06-24T13:11:56.682882Z","end":"2026-06-24T13:11:57.194246Z","steps":["trace[1806335462] 'agreement among raft nodes before linearized reading' (duration: 511.137465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.194302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:56.682858Z","time spent":"511.435967ms","remote":"127.0.0.1:36606","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":"warn","ts":"2026-06-24T13:11:57.194552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"505.902578ms","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-24T13:11:57.194636Z","caller":"traceutil/trace.go:171","msg":"trace[580505216] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:815; }","duration":"506.01702ms","start":"2026-06-24T13:11:56.688602Z","end":"2026-06-24T13:11:57.194619Z","steps":["trace[580505216] 'agreement among raft nodes before linearized reading' (duration: 505.707236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.194673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:56.688591Z","time spent":"506.07314ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T13:11:57.195088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"502.351038ms","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-24T13:11:57.195223Z","caller":"traceutil/trace.go:171","msg":"trace[1797738231] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:815; }","duration":"502.508301ms","start":"2026-06-24T13:11:56.692695Z","end":"2026-06-24T13:11:57.195203Z","steps":["trace[1797738231] 'agreement among raft nodes before linearized reading' (duration: 501.401218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.19527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:11:56.692682Z","time spent":"502.574521ms","remote":"127.0.0.1:36606","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-24T13:11:57.310973Z","caller":"traceutil/trace.go:171","msg":"trace[1016249722] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:846; }","duration":"108.768317ms","start":"2026-06-24T13:11:57.202183Z","end":"2026-06-24T13:11:57.310951Z","steps":["trace[1016249722] 'read index received' (duration: 33.118772ms)","trace[1016249722] 'applied index is now lower than readState.Index' (duration: 75.648615ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:11:57.311212Z","caller":"traceutil/trace.go:171","msg":"trace[737810008] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"112.223704ms","start":"2026-06-24T13:11:57.198956Z","end":"2026-06-24T13:11:57.311179Z","steps":["trace[737810008] 'process raft request' (duration: 111.81356ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:57.311278Z","caller":"traceutil/trace.go:171","msg":"trace[1364204069] transaction","detail":"{read_only:false; response_revision:819; number_of_response:1; }","duration":"110.759608ms","start":"2026-06-24T13:11:57.200501Z","end":"2026-06-24T13:11:57.31126Z","steps":["trace[1364204069] 'process raft request' (duration: 110.419765ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:57.311264Z","caller":"traceutil/trace.go:171","msg":"trace[988147214] transaction","detail":"{read_only:false; response_revision:818; number_of_response:1; }","duration":"111.097382ms","start":"2026-06-24T13:11:57.200138Z","end":"2026-06-24T13:11:57.311235Z","steps":["trace[988147214] 'process raft request' (duration: 110.747788ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:11:57.311435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.896938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:11:57.311469Z","caller":"traceutil/trace.go:171","msg":"trace[1827293442] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:819; }","duration":"109.292992ms","start":"2026-06-24T13:11:57.202165Z","end":"2026-06-24T13:11:57.311458Z","steps":["trace[1827293442] 'agreement among raft nodes before linearized reading' (duration: 108.875468ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:11:58.084562Z","caller":"traceutil/trace.go:171","msg":"trace[920168600] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"293.775695ms","start":"2026-06-24T13:11:57.790738Z","end":"2026-06-24T13:11:58.084513Z","steps":["trace[920168600] 'process raft request' (duration: 293.558382ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:12:11.45068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.676159ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T13:12:11.450747Z","caller":"traceutil/trace.go:171","msg":"trace[733483670] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:974; }","duration":"180.786041ms","start":"2026-06-24T13:12:11.269948Z","end":"2026-06-24T13:12:11.450734Z","steps":["trace[733483670] 'range keys from in-memory index tree' (duration: 180.548818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:12:11.450897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.730311ms","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-24T13:12:11.450951Z","caller":"traceutil/trace.go:171","msg":"trace[966818735] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:974; }","duration":"138.831823ms","start":"2026-06-24T13:12:11.312102Z","end":"2026-06-24T13:12:11.450934Z","steps":["trace[966818735] 'range keys from in-memory index tree' (duration: 138.606251ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:22.431063Z","caller":"traceutil/trace.go:171","msg":"trace[719315866] transaction","detail":"{read_only:false; response_revision:1026; number_of_response:1; }","duration":"120.498479ms","start":"2026-06-24T13:12:22.310533Z","end":"2026-06-24T13:12:22.431031Z","steps":["trace[719315866] 'process raft request' (duration: 120.286907ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:33.857994Z","caller":"traceutil/trace.go:171","msg":"trace[1189346354] linearizableReadLoop","detail":"{readStateIndex:1103; appliedIndex:1102; }","duration":"221.952028ms","start":"2026-06-24T13:12:33.636023Z","end":"2026-06-24T13:12:33.857975Z","steps":["trace[1189346354] 'read index received' (duration: 221.914138ms)","trace[1189346354] 'applied index is now lower than readState.Index' (duration: 36.92µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:12:33.858143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.115821ms","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-24T13:12:33.858096Z","caller":"traceutil/trace.go:171","msg":"trace[1231678461] transaction","detail":"{read_only:false; response_revision:1065; number_of_response:1; }","duration":"222.715737ms","start":"2026-06-24T13:12:33.63535Z","end":"2026-06-24T13:12:33.858065Z","steps":["trace[1231678461] 'process raft request' (duration: 222.511774ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:33.858165Z","caller":"traceutil/trace.go:171","msg":"trace[674914492] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1065; }","duration":"222.191941ms","start":"2026-06-24T13:12:33.635966Z","end":"2026-06-24T13:12:33.858158Z","steps":["trace[674914492] 'agreement among raft nodes before linearized reading' (duration: 222.0896ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:33.950306Z","caller":"traceutil/trace.go:171","msg":"trace[521501738] transaction","detail":"{read_only:false; response_revision:1066; number_of_response:1; }","duration":"273.777987ms","start":"2026-06-24T13:12:33.676499Z","end":"2026-06-24T13:12:33.950277Z","steps":["trace[521501738] 'process raft request' (duration: 238.195868ms)","trace[521501738] 'compare' (duration: 35.351197ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:12:33.950518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.481552ms","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-24T13:12:33.950581Z","caller":"traceutil/trace.go:171","msg":"trace[738312627] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1067; }","duration":"268.586413ms","start":"2026-06-24T13:12:33.681977Z","end":"2026-06-24T13:12:33.950563Z","steps":["trace[738312627] 'agreement among raft nodes before linearized reading' (duration: 268.3534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:12:33.950656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.965907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.139\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T13:12:33.950708Z","caller":"traceutil/trace.go:171","msg":"trace[853715210] range","detail":"{range_begin:/registry/masterleases/199.19.213.139; range_end:; response_count:1; response_revision:1067; }","duration":"193.052897ms","start":"2026-06-24T13:12:33.75764Z","end":"2026-06-24T13:12:33.950693Z","steps":["trace[853715210] 'agreement among raft nodes before linearized reading' (duration: 192.903496ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:12:33.950727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.839752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:12:33.950765Z","caller":"traceutil/trace.go:171","msg":"trace[1581999558] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1067; }","duration":"132.902843ms","start":"2026-06-24T13:12:33.817851Z","end":"2026-06-24T13:12:33.950753Z","steps":["trace[1581999558] 'agreement among raft nodes before linearized reading' (duration: 132.844822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:12:33.950872Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.86313ms","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-24T13:12:33.950908Z","caller":"traceutil/trace.go:171","msg":"trace[2100519599] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1067; }","duration":"202.93591ms","start":"2026-06-24T13:12:33.747959Z","end":"2026-06-24T13:12:33.950895Z","steps":["trace[2100519599] 'agreement among raft nodes before linearized reading' (duration: 202.842459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:12:33.951029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.696424ms","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-24T13:12:33.951061Z","caller":"traceutil/trace.go:171","msg":"trace[95336505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1067; }","duration":"267.751025ms","start":"2026-06-24T13:12:33.683301Z","end":"2026-06-24T13:12:33.951052Z","steps":["trace[95336505] 'agreement among raft nodes before linearized reading' (duration: 267.663414ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:34.070362Z","caller":"traceutil/trace.go:171","msg":"trace[1828220953] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"115.49294ms","start":"2026-06-24T13:12:33.954838Z","end":"2026-06-24T13:12:34.070331Z","steps":["trace[1828220953] 'process raft request' (duration: 115.366239ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:34.070509Z","caller":"traceutil/trace.go:171","msg":"trace[418803724] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"114.993615ms","start":"2026-06-24T13:12:33.955499Z","end":"2026-06-24T13:12:34.070492Z","steps":["trace[418803724] 'process raft request' (duration: 114.761493ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:34.070386Z","caller":"traceutil/trace.go:171","msg":"trace[1568484825] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"116.35853ms","start":"2026-06-24T13:12:33.953999Z","end":"2026-06-24T13:12:34.070357Z","steps":["trace[1568484825] 'process raft request' (duration: 112.47529ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:56.516997Z","caller":"traceutil/trace.go:171","msg":"trace[921066993] transaction","detail":"{read_only:false; response_revision:1141; number_of_response:1; }","duration":"132.14378ms","start":"2026-06-24T13:12:56.384828Z","end":"2026-06-24T13:12:56.516972Z","steps":["trace[921066993] 'process raft request' (duration: 132.008587ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:56.519023Z","caller":"traceutil/trace.go:171","msg":"trace[2067326433] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"133.482022ms","start":"2026-06-24T13:12:56.385519Z","end":"2026-06-24T13:12:56.519001Z","steps":["trace[2067326433] 'process raft request' (duration: 133.44157ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:12:56.51905Z","caller":"traceutil/trace.go:171","msg":"trace[1125230770] transaction","detail":"{read_only:false; response_revision:1142; number_of_response:1; }","duration":"134.150177ms","start":"2026-06-24T13:12:56.384885Z","end":"2026-06-24T13:12:56.519035Z","steps":["trace[1125230770] 'process raft request' (duration: 133.955301ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:04.81389Z","caller":"traceutil/trace.go:171","msg":"trace[959439758] linearizableReadLoop","detail":"{readStateIndex:1213; appliedIndex:1212; }","duration":"239.276749ms","start":"2026-06-24T13:13:04.574587Z","end":"2026-06-24T13:13:04.813863Z","steps":["trace[959439758] 'read index received' (duration: 239.110946ms)","trace[959439758] 'applied index is now lower than readState.Index' (duration: 162.513µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:04.814198Z","caller":"traceutil/trace.go:171","msg":"trace[2089344559] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"240.324462ms","start":"2026-06-24T13:13:04.573854Z","end":"2026-06-24T13:13:04.814179Z","steps":["trace[2089344559] 'process raft request' (duration: 239.822702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:04.814319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.689728ms","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-24T13:13:04.814414Z","caller":"traceutil/trace.go:171","msg":"trace[1200566094] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1168; }","duration":"239.831621ms","start":"2026-06-24T13:13:04.574564Z","end":"2026-06-24T13:13:04.814395Z","steps":["trace[1200566094] 'agreement among raft nodes before linearized reading' (duration: 239.489214ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:04.823613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.374311ms","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-24T13:13:04.823777Z","caller":"traceutil/trace.go:171","msg":"trace[1949302555] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1169; }","duration":"213.592996ms","start":"2026-06-24T13:13:04.610171Z","end":"2026-06-24T13:13:04.823764Z","steps":["trace[1949302555] 'agreement among raft nodes before linearized reading' (duration: 213.277799ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:18.654227Z","caller":"traceutil/trace.go:171","msg":"trace[410443238] linearizableReadLoop","detail":"{readStateIndex:1258; appliedIndex:1257; }","duration":"122.075601ms","start":"2026-06-24T13:13:18.532126Z","end":"2026-06-24T13:13:18.654202Z","steps":["trace[410443238] 'read index received' (duration: 121.849266ms)","trace[410443238] 'applied index is now lower than readState.Index' (duration: 225.325µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:18.654366Z","caller":"traceutil/trace.go:171","msg":"trace[456711064] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"204.806843ms","start":"2026-06-24T13:13:18.449517Z","end":"2026-06-24T13:13:18.654324Z","steps":["trace[456711064] 'process raft request' (duration: 204.514197ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:18.654542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.302265ms","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-24T13:13:18.654699Z","caller":"traceutil/trace.go:171","msg":"trace[1381525426] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1211; }","duration":"122.53624ms","start":"2026-06-24T13:13:18.532082Z","end":"2026-06-24T13:13:18.654618Z","steps":["trace[1381525426] 'agreement among raft nodes before linearized reading' (duration: 122.235644ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:19.026256Z","caller":"traceutil/trace.go:171","msg":"trace[1044471579] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"114.986402ms","start":"2026-06-24T13:13:18.911249Z","end":"2026-06-24T13:13:19.026235Z","steps":["trace[1044471579] 'process raft request' (duration: 114.488772ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:19.045991Z","caller":"traceutil/trace.go:171","msg":"trace[822859752] transaction","detail":"{read_only:false; response_revision:1215; number_of_response:1; }","duration":"134.476587ms","start":"2026-06-24T13:13:18.911492Z","end":"2026-06-24T13:13:19.045968Z","steps":["trace[822859752] 'process raft request' (duration: 134.286573ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:19.046391Z","caller":"traceutil/trace.go:171","msg":"trace[1201898780] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"134.341924ms","start":"2026-06-24T13:13:18.912036Z","end":"2026-06-24T13:13:19.046378Z","steps":["trace[1201898780] 'process raft request' (duration: 133.864034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:22.806096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.608795ms","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-24T13:13:22.806226Z","caller":"traceutil/trace.go:171","msg":"trace[1640830510] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1224; }","duration":"120.787359ms","start":"2026-06-24T13:13:22.685399Z","end":"2026-06-24T13:13:22.806186Z","steps":["trace[1640830510] 'range keys from in-memory index tree' (duration: 120.416172ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:22.989454Z","caller":"traceutil/trace.go:171","msg":"trace[2133935856] transaction","detail":"{read_only:false; response_revision:1225; number_of_response:1; }","duration":"179.35845ms","start":"2026-06-24T13:13:22.810074Z","end":"2026-06-24T13:13:22.989433Z","steps":["trace[2133935856] 'process raft request' (duration: 179.233238ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:23.380867Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.447291ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:13:23.380983Z","caller":"traceutil/trace.go:171","msg":"trace[844867165] linearizableReadLoop","detail":"{readStateIndex:1274; appliedIndex:1273; }","duration":"344.033546ms","start":"2026-06-24T13:13:23.036928Z","end":"2026-06-24T13:13:23.380961Z","steps":["trace[844867165] 'read index received' (duration: 206.37561ms)","trace[844867165] 'applied index is now lower than readState.Index' (duration: 137.656126ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:23.380988Z","caller":"traceutil/trace.go:171","msg":"trace[1469233530] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"454.558581ms","start":"2026-06-24T13:13:22.926402Z","end":"2026-06-24T13:13:23.380961Z","steps":["trace[1469233530] 'process raft request' (duration: 316.900395ms)","trace[1469233530] 'compare' (duration: 137.183165ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:13:23.381248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.794032ms","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-24T13:13:23.381301Z","caller":"traceutil/trace.go:171","msg":"trace[1325169909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1226; }","duration":"324.895253ms","start":"2026-06-24T13:13:23.056393Z","end":"2026-06-24T13:13:23.381288Z","steps":["trace[1325169909] 'agreement among raft nodes before linearized reading' (duration: 324.7389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:23.381322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.380972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-06-24T13:13:23.381336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:23.056371Z","time spent":"324.957095ms","remote":"127.0.0.1:36606","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-24T13:13:23.38138Z","caller":"traceutil/trace.go:171","msg":"trace[1497054886] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1226; }","duration":"344.461823ms","start":"2026-06-24T13:13:23.036898Z","end":"2026-06-24T13:13:23.38136Z","steps":["trace[1497054886] 'agreement among raft nodes before linearized reading' (duration: 344.222719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:23.381424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:23.036885Z","time spent":"344.526804ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T13:13:23.381514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.210809ms","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-24T13:13:23.381568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:22.926369Z","time spent":"454.664402ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T13:13:23.381592Z","caller":"traceutil/trace.go:171","msg":"trace[438865638] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1226; }","duration":"323.317192ms","start":"2026-06-24T13:13:23.058257Z","end":"2026-06-24T13:13:23.381574Z","steps":["trace[438865638] 'agreement among raft nodes before linearized reading' (duration: 323.087267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:23.381702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:23.058248Z","time spent":"323.439734ms","remote":"127.0.0.1:36606","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-24T13:13:23.537551Z","caller":"traceutil/trace.go:171","msg":"trace[852078879] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"150.577079ms","start":"2026-06-24T13:13:23.386955Z","end":"2026-06-24T13:13:23.537532Z","steps":["trace[852078879] 'process raft request' (duration: 104.790263ms)","trace[852078879] 'compare' (duration: 45.661393ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:23.537647Z","caller":"traceutil/trace.go:171","msg":"trace[790755715] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"150.60079ms","start":"2026-06-24T13:13:23.387028Z","end":"2026-06-24T13:13:23.537628Z","steps":["trace[790755715] 'process raft request' (duration: 150.477468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:24.071422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.207648ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:13:24.071555Z","caller":"traceutil/trace.go:171","msg":"trace[634205472] linearizableReadLoop","detail":"{readStateIndex:1279; appliedIndex:1278; }","duration":"219.324029ms","start":"2026-06-24T13:13:23.852199Z","end":"2026-06-24T13:13:24.071523Z","steps":["trace[634205472] 'read index received' (duration: 87.941158ms)","trace[634205472] 'applied index is now lower than readState.Index' (duration: 131.381881ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:24.071587Z","caller":"traceutil/trace.go:171","msg":"trace[2139494092] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"219.461522ms","start":"2026-06-24T13:13:23.852093Z","end":"2026-06-24T13:13:24.071554Z","steps":["trace[2139494092] 'process raft request' (duration: 88.03158ms)","trace[2139494092] 'compare' (duration: 131.067105ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:13:24.071703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.509293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:13:24.071737Z","caller":"traceutil/trace.go:171","msg":"trace[816870983] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1230; }","duration":"219.569745ms","start":"2026-06-24T13:13:23.852159Z","end":"2026-06-24T13:13:24.071728Z","steps":["trace[816870983] 'agreement among raft nodes before linearized reading' (duration: 219.425992ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:24.816362Z","caller":"traceutil/trace.go:171","msg":"trace[1600633547] linearizableReadLoop","detail":"{readStateIndex:1280; appliedIndex:1279; }","duration":"131.732744ms","start":"2026-06-24T13:13:24.684605Z","end":"2026-06-24T13:13:24.816337Z","steps":["trace[1600633547] 'read index received' (duration: 131.464048ms)","trace[1600633547] 'applied index is now lower than readState.Index' (duration: 267.766µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:24.816456Z","caller":"traceutil/trace.go:171","msg":"trace[658434472] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"140.8807ms","start":"2026-06-24T13:13:24.675548Z","end":"2026-06-24T13:13:24.816429Z","steps":["trace[658434472] 'process raft request' (duration: 140.610765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:24.816639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.01405ms","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-24T13:13:24.816704Z","caller":"traceutil/trace.go:171","msg":"trace[934444503] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1231; }","duration":"132.122141ms","start":"2026-06-24T13:13:24.684561Z","end":"2026-06-24T13:13:24.816683Z","steps":["trace[934444503] 'agreement among raft nodes before linearized reading' (duration: 131.927318ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:25.776336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.107704ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:13:25.776433Z","caller":"traceutil/trace.go:171","msg":"trace[2108217594] transaction","detail":"{read_only:false; response_revision:1236; number_of_response:1; }","duration":"229.97752ms","start":"2026-06-24T13:13:25.546437Z","end":"2026-06-24T13:13:25.776414Z","steps":["trace[2108217594] 'process raft request' (duration: 57.711042ms)","trace[2108217594] 'compare' (duration: 171.857749ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:25.81234Z","caller":"traceutil/trace.go:171","msg":"trace[65791423] linearizableReadLoop","detail":"{readStateIndex:1286; appliedIndex:1284; }","duration":"244.504334ms","start":"2026-06-24T13:13:25.567811Z","end":"2026-06-24T13:13:25.812315Z","steps":["trace[65791423] 'read index received' (duration: 36.345578ms)","trace[65791423] 'applied index is now lower than readState.Index' (duration: 208.157396ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:25.812461Z","caller":"traceutil/trace.go:171","msg":"trace[1911951855] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"265.600052ms","start":"2026-06-24T13:13:25.546829Z","end":"2026-06-24T13:13:25.812429Z","steps":["trace[1911951855] 'process raft request' (duration: 265.349677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:25.812484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.648597ms","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-24T13:13:25.812697Z","caller":"traceutil/trace.go:171","msg":"trace[1279881591] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1237; }","duration":"244.927483ms","start":"2026-06-24T13:13:25.567756Z","end":"2026-06-24T13:13:25.812683Z","steps":["trace[1279881591] 'agreement among raft nodes before linearized reading' (duration: 244.654587ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:28.041618Z","caller":"traceutil/trace.go:171","msg":"trace[494236608] transaction","detail":"{read_only:false; response_revision:1243; number_of_response:1; }","duration":"218.314988ms","start":"2026-06-24T13:13:27.82328Z","end":"2026-06-24T13:13:28.041595Z","steps":["trace[494236608] 'process raft request' (duration: 181.699773ms)","trace[494236608] 'compare' (duration: 36.486813ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:31.862052Z","caller":"traceutil/trace.go:171","msg":"trace[1298084319] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"184.757194ms","start":"2026-06-24T13:13:31.677238Z","end":"2026-06-24T13:13:31.861996Z","steps":["trace[1298084319] 'process raft request' (duration: 184.586281ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:33.976088Z","caller":"traceutil/trace.go:171","msg":"trace[1035590416] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"234.639835ms","start":"2026-06-24T13:13:33.74142Z","end":"2026-06-24T13:13:33.976059Z","steps":["trace[1035590416] 'process raft request' (duration: 234.218017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:33.976423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.126068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.139\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T13:13:33.975812Z","caller":"traceutil/trace.go:171","msg":"trace[79592251] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1309; }","duration":"214.476916ms","start":"2026-06-24T13:13:33.761304Z","end":"2026-06-24T13:13:33.97578Z","steps":["trace[79592251] 'read index received' (duration: 214.270872ms)","trace[79592251] 'applied index is now lower than readState.Index' (duration: 204.524µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:33.976507Z","caller":"traceutil/trace.go:171","msg":"trace[242951088] range","detail":"{range_begin:/registry/masterleases/199.19.213.139; range_end:; response_count:1; response_revision:1260; }","duration":"215.22108ms","start":"2026-06-24T13:13:33.761266Z","end":"2026-06-24T13:13:33.976487Z","steps":["trace[242951088] 'agreement among raft nodes before linearized reading' (duration: 214.928374ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:33.976746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.624885ms","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-24T13:13:33.976809Z","caller":"traceutil/trace.go:171","msg":"trace[1098020451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"110.746787ms","start":"2026-06-24T13:13:33.866045Z","end":"2026-06-24T13:13:33.976791Z","steps":["trace[1098020451] 'agreement among raft nodes before linearized reading' (duration: 110.537723ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:35.326227Z","caller":"traceutil/trace.go:171","msg":"trace[1790839837] transaction","detail":"{read_only:false; response_revision:1276; number_of_response:1; }","duration":"155.246176ms","start":"2026-06-24T13:13:35.170953Z","end":"2026-06-24T13:13:35.326199Z","steps":["trace[1790839837] 'process raft request' (duration: 155.079273ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:35.747418Z","caller":"traceutil/trace.go:171","msg":"trace[1041557659] transaction","detail":"{read_only:false; response_revision:1277; number_of_response:1; }","duration":"207.109703ms","start":"2026-06-24T13:13:35.540282Z","end":"2026-06-24T13:13:35.747391Z","steps":["trace[1041557659] 'process raft request' (duration: 206.93828ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:35.769302Z","caller":"traceutil/trace.go:171","msg":"trace[1031095280] transaction","detail":"{read_only:false; response_revision:1278; number_of_response:1; }","duration":"140.836843ms","start":"2026-06-24T13:13:35.628439Z","end":"2026-06-24T13:13:35.769276Z","steps":["trace[1031095280] 'process raft request' (duration: 140.7037ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:35.884738Z","caller":"traceutil/trace.go:171","msg":"trace[577915752] transaction","detail":"{read_only:false; response_revision:1279; number_of_response:1; }","duration":"106.898487ms","start":"2026-06-24T13:13:35.777808Z","end":"2026-06-24T13:13:35.884706Z","steps":["trace[577915752] 'process raft request' (duration: 36.981975ms)","trace[577915752] 'compare' (duration: 69.719138ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:36.232261Z","caller":"traceutil/trace.go:171","msg":"trace[881575660] transaction","detail":"{read_only:false; response_revision:1280; number_of_response:1; }","duration":"198.101343ms","start":"2026-06-24T13:13:36.034131Z","end":"2026-06-24T13:13:36.232232Z","steps":["trace[881575660] 'process raft request' (duration: 197.94145ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:36.266763Z","caller":"traceutil/trace.go:171","msg":"trace[658253225] linearizableReadLoop","detail":"{readStateIndex:1333; appliedIndex:1331; }","duration":"186.328623ms","start":"2026-06-24T13:13:36.080406Z","end":"2026-06-24T13:13:36.266734Z","steps":["trace[658253225] 'read index received' (duration: 151.798447ms)","trace[658253225] 'applied index is now lower than readState.Index' (duration: 34.528726ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:36.266818Z","caller":"traceutil/trace.go:171","msg":"trace[1768305778] transaction","detail":"{read_only:false; response_revision:1281; number_of_response:1; }","duration":"232.535657ms","start":"2026-06-24T13:13:36.034252Z","end":"2026-06-24T13:13:36.266787Z","steps":["trace[1768305778] 'process raft request' (duration: 232.335933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:36.267143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.717491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T13:13:36.267235Z","caller":"traceutil/trace.go:171","msg":"trace[509893902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1281; }","duration":"186.876194ms","start":"2026-06-24T13:13:36.080343Z","end":"2026-06-24T13:13:36.267219Z","steps":["trace[509893902] 'agreement among raft nodes before linearized reading' (duration: 186.494767ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:37.467613Z","caller":"traceutil/trace.go:171","msg":"trace[798097876] transaction","detail":"{read_only:false; response_revision:1285; number_of_response:1; }","duration":"131.095065ms","start":"2026-06-24T13:13:37.336494Z","end":"2026-06-24T13:13:37.467589Z","steps":["trace[798097876] 'process raft request' (duration: 130.935372ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:37.972783Z","caller":"traceutil/trace.go:171","msg":"trace[1052717348] linearizableReadLoop","detail":"{readStateIndex:1338; appliedIndex:1337; }","duration":"153.943809ms","start":"2026-06-24T13:13:37.8188Z","end":"2026-06-24T13:13:37.972743Z","steps":["trace[1052717348] 'read index received' (duration: 153.46347ms)","trace[1052717348] 'applied index is now lower than readState.Index' (duration: 478.399µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:37.972885Z","caller":"traceutil/trace.go:171","msg":"trace[944578390] transaction","detail":"{read_only:false; response_revision:1286; number_of_response:1; }","duration":"219.486306ms","start":"2026-06-24T13:13:37.753357Z","end":"2026-06-24T13:13:37.972843Z","steps":["trace[944578390] 'process raft request' (duration: 219.097178ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:37.973015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.190766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:13:37.973066Z","caller":"traceutil/trace.go:171","msg":"trace[1554976718] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1286; }","duration":"154.322577ms","start":"2026-06-24T13:13:37.818732Z","end":"2026-06-24T13:13:37.973055Z","steps":["trace[1554976718] 'agreement among raft nodes before linearized reading' (duration: 154.203735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:38.489832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.483089ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:13:38.489925Z","caller":"traceutil/trace.go:171","msg":"trace[1840741311] transaction","detail":"{read_only:false; response_revision:1289; number_of_response:1; }","duration":"132.493283ms","start":"2026-06-24T13:13:38.357415Z","end":"2026-06-24T13:13:38.489908Z","steps":["trace[1840741311] 'process raft request' (duration: 27.860801ms)","trace[1840741311] 'compare' (duration: 104.396708ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:39.593303Z","caller":"traceutil/trace.go:171","msg":"trace[758260893] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1346; }","duration":"118.224179ms","start":"2026-06-24T13:13:39.475058Z","end":"2026-06-24T13:13:39.593283Z","steps":["trace[758260893] 'read index received' (duration: 118.119627ms)","trace[758260893] 'applied index is now lower than readState.Index' (duration: 103.222µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:39.593394Z","caller":"traceutil/trace.go:171","msg":"trace[438123702] transaction","detail":"{read_only:false; response_revision:1294; number_of_response:1; }","duration":"166.855319ms","start":"2026-06-24T13:13:39.426491Z","end":"2026-06-24T13:13:39.593347Z","steps":["trace[438123702] 'process raft request' (duration: 166.638295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:39.593452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.391662ms","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-24T13:13:39.59364Z","caller":"traceutil/trace.go:171","msg":"trace[929574029] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1294; }","duration":"118.636456ms","start":"2026-06-24T13:13:39.474985Z","end":"2026-06-24T13:13:39.593621Z","steps":["trace[929574029] 'agreement among raft nodes before linearized reading' (duration: 118.372371ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:41.754206Z","caller":"traceutil/trace.go:171","msg":"trace[537308855] transaction","detail":"{read_only:false; response_revision:1303; number_of_response:1; }","duration":"220.371037ms","start":"2026-06-24T13:13:41.533797Z","end":"2026-06-24T13:13:41.754168Z","steps":["trace[537308855] 'process raft request' (duration: 219.910029ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:42.364587Z","caller":"traceutil/trace.go:171","msg":"trace[311046605] transaction","detail":"{read_only:false; response_revision:1306; number_of_response:1; }","duration":"365.442644ms","start":"2026-06-24T13:13:41.999117Z","end":"2026-06-24T13:13:42.364559Z","steps":["trace[311046605] 'process raft request' (duration: 365.276771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:42.364959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:41.999106Z","time spent":"365.553006ms","remote":"127.0.0.1:36514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3884,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:13:42.711917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.058236ms","expected-duration":"100ms","prefix":"","request":"header: txn: success: > failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-24T13:13:42.71241Z","caller":"traceutil/trace.go:171","msg":"trace[1671436171] transaction","detail":"{read_only:false; number_of_response:1; response_revision:1307; }","duration":"345.93442ms","start":"2026-06-24T13:13:42.366451Z","end":"2026-06-24T13:13:42.712386Z","steps":["trace[1671436171] 'process raft request' (duration: 172.243851ms)","trace[1671436171] 'compare' (duration: 172.601478ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:42.712497Z","caller":"traceutil/trace.go:171","msg":"trace[59757092] transaction","detail":"{read_only:false; response_revision:1308; number_of_response:1; }","duration":"342.400463ms","start":"2026-06-24T13:13:42.370036Z","end":"2026-06-24T13:13:42.712437Z","steps":["trace[59757092] 'process raft request' (duration: 342.23623ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:42.712679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:42.370007Z","time spent":"342.579187ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:13:42.712527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:42.366433Z","time spent":"346.031011ms","remote":"127.0.0.1:36514","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":96,"response count":0,"response size":42,"request content":"compare: success: > failure: >"} {"level":"info","ts":"2026-06-24T13:13:42.712415Z","caller":"traceutil/trace.go:171","msg":"trace[457661819] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1359; }","duration":"333.92743ms","start":"2026-06-24T13:13:42.378467Z","end":"2026-06-24T13:13:42.712394Z","steps":["trace[457661819] 'read index received' (duration: 160.349393ms)","trace[457661819] 'applied index is now lower than readState.Index' (duration: 173.576807ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:13:42.712969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.492481ms","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-24T13:13:42.713164Z","caller":"traceutil/trace.go:171","msg":"trace[1457096391] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1308; }","duration":"334.703195ms","start":"2026-06-24T13:13:42.378439Z","end":"2026-06-24T13:13:42.713142Z","steps":["trace[1457096391] 'agreement among raft nodes before linearized reading' (duration: 334.240386ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:42.713206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.628919ms","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-24T13:13:42.713261Z","caller":"traceutil/trace.go:171","msg":"trace[2098187551] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1308; }","duration":"208.70871ms","start":"2026-06-24T13:13:42.50454Z","end":"2026-06-24T13:13:42.713249Z","steps":["trace[2098187551] 'agreement among raft nodes before linearized reading' (duration: 208.507236ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:42.713358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:42.37843Z","time spent":"334.895958ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-24T13:13:42.8526Z","caller":"traceutil/trace.go:171","msg":"trace[1033410143] transaction","detail":"{read_only:false; response_revision:1311; number_of_response:1; }","duration":"133.213423ms","start":"2026-06-24T13:13:42.719335Z","end":"2026-06-24T13:13:42.852548Z","steps":["trace[1033410143] 'process raft request' (duration: 132.988779ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:42.85264Z","caller":"traceutil/trace.go:171","msg":"trace[1401757078] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"133.739473ms","start":"2026-06-24T13:13:42.718871Z","end":"2026-06-24T13:13:42.852611Z","steps":["trace[1401757078] 'process raft request' (duration: 123.805363ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:43.094252Z","caller":"traceutil/trace.go:171","msg":"trace[885373201] transaction","detail":"{read_only:false; response_revision:1313; number_of_response:1; }","duration":"234.675851ms","start":"2026-06-24T13:13:42.859534Z","end":"2026-06-24T13:13:43.09421Z","steps":["trace[885373201] 'process raft request' (duration: 195.556444ms)","trace[885373201] 'compare' (duration: 38.70983ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:43.136783Z","caller":"traceutil/trace.go:171","msg":"trace[1638580106] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"273.077036ms","start":"2026-06-24T13:13:42.863671Z","end":"2026-06-24T13:13:43.136748Z","steps":["trace[1638580106] 'process raft request' (duration: 272.879142ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:43.34581Z","caller":"traceutil/trace.go:171","msg":"trace[1801952154] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"204.852573ms","start":"2026-06-24T13:13:43.140909Z","end":"2026-06-24T13:13:43.345761Z","steps":["trace[1801952154] 'process raft request' (duration: 138.294251ms)","trace[1801952154] 'compare' (duration: 66.396409ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:43.522445Z","caller":"traceutil/trace.go:171","msg":"trace[1661020554] transaction","detail":"{read_only:false; response_revision:1316; number_of_response:1; }","duration":"380.946257ms","start":"2026-06-24T13:13:43.141471Z","end":"2026-06-24T13:13:43.522417Z","steps":["trace[1661020554] 'process raft request' (duration: 329.825211ms)","trace[1661020554] 'compare' (duration: 51.009614ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:13:43.522616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:43.141452Z","time spent":"381.073929ms","remote":"127.0.0.1:36504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1450,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:13:48.180825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.576096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T13:13:48.180958Z","caller":"traceutil/trace.go:171","msg":"trace[2064113575] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1337; }","duration":"248.79772ms","start":"2026-06-24T13:13:47.932134Z","end":"2026-06-24T13:13:48.180932Z","steps":["trace[2064113575] 'count revisions from in-memory index tree' (duration: 248.451514ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:48.18613Z","caller":"traceutil/trace.go:171","msg":"trace[750975149] transaction","detail":"{read_only:false; response_revision:1338; number_of_response:1; }","duration":"142.445028ms","start":"2026-06-24T13:13:48.04366Z","end":"2026-06-24T13:13:48.186105Z","steps":["trace[750975149] 'process raft request' (duration: 142.276155ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:52.952451Z","caller":"traceutil/trace.go:171","msg":"trace[1763965610] transaction","detail":"{read_only:false; response_revision:1357; number_of_response:1; }","duration":"123.632104ms","start":"2026-06-24T13:13:52.828782Z","end":"2026-06-24T13:13:52.952415Z","steps":["trace[1763965610] 'process raft request' (duration: 123.4177ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:56.643765Z","caller":"traceutil/trace.go:171","msg":"trace[1019724648] linearizableReadLoop","detail":"{readStateIndex:1427; appliedIndex:1426; }","duration":"423.880312ms","start":"2026-06-24T13:13:56.219854Z","end":"2026-06-24T13:13:56.643735Z","steps":["trace[1019724648] 'read index received' (duration: 423.685797ms)","trace[1019724648] 'applied index is now lower than readState.Index' (duration: 193.165µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:56.643892Z","caller":"traceutil/trace.go:171","msg":"trace[1488479054] transaction","detail":"{read_only:false; response_revision:1371; number_of_response:1; }","duration":"425.115805ms","start":"2026-06-24T13:13:56.218744Z","end":"2026-06-24T13:13:56.64386Z","steps":["trace[1488479054] 'process raft request' (duration: 424.774428ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:56.643969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.087376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/test-pv\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:13:56.644029Z","caller":"traceutil/trace.go:171","msg":"trace[583795466] range","detail":"{range_begin:/registry/persistentvolumes/test-pv; range_end:; response_count:0; response_revision:1371; }","duration":"424.213698ms","start":"2026-06-24T13:13:56.219798Z","end":"2026-06-24T13:13:56.644012Z","steps":["trace[583795466] 'agreement among raft nodes before linearized reading' (duration: 424.089396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:56.644046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:56.218715Z","time spent":"425.247717ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:13:56.644091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:56.219776Z","time spent":"424.30105ms","remote":"127.0.0.1:36494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":37,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/test-pv\" "} {"level":"info","ts":"2026-06-24T13:13:57.046574Z","caller":"traceutil/trace.go:171","msg":"trace[2110425096] transaction","detail":"{read_only:false; response_revision:1372; number_of_response:1; }","duration":"185.60483ms","start":"2026-06-24T13:13:56.860914Z","end":"2026-06-24T13:13:57.046519Z","steps":["trace[2110425096] 'process raft request' (duration: 185.357846ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:57.524252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.583913ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T13:13:57.524473Z","caller":"traceutil/trace.go:171","msg":"trace[1026795273] linearizableReadLoop","detail":"{readStateIndex:1430; appliedIndex:1428; }","duration":"143.408222ms","start":"2026-06-24T13:13:57.381049Z","end":"2026-06-24T13:13:57.524457Z","steps":["trace[1026795273] 'read index received' (duration: 57.213756ms)","trace[1026795273] 'applied index is now lower than readState.Index' (duration: 86.193416ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:13:57.524541Z","caller":"traceutil/trace.go:171","msg":"trace[126092391] transaction","detail":"{read_only:false; response_revision:1374; number_of_response:1; }","duration":"473.15595ms","start":"2026-06-24T13:13:57.051335Z","end":"2026-06-24T13:13:57.524491Z","steps":["trace[126092391] 'process raft request' (duration: 473.018607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:13:57.524593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.544585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:13:57.524627Z","caller":"traceutil/trace.go:171","msg":"trace[362680419] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1374; }","duration":"143.624456ms","start":"2026-06-24T13:13:57.380989Z","end":"2026-06-24T13:13:57.524614Z","steps":["trace[362680419] 'agreement among raft nodes before linearized reading' (duration: 143.569905ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:57.524649Z","caller":"traceutil/trace.go:171","msg":"trace[1080020532] transaction","detail":"{read_only:false; response_revision:1373; number_of_response:1; }","duration":"473.460075ms","start":"2026-06-24T13:13:57.051158Z","end":"2026-06-24T13:13:57.524618Z","steps":["trace[1080020532] 'process raft request' (duration: 148.426143ms)","trace[1080020532] 'compare' (duration: 324.43154ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:13:57.524729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:57.051294Z","time spent":"473.338683ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T13:13:57.524801Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:13:57.051128Z","time spent":"473.601808ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T13:13:59.654505Z","caller":"traceutil/trace.go:171","msg":"trace[9079428] transaction","detail":"{read_only:false; response_revision:1383; number_of_response:1; }","duration":"122.298282ms","start":"2026-06-24T13:13:59.532186Z","end":"2026-06-24T13:13:59.654484Z","steps":["trace[9079428] 'process raft request' (duration: 122.17159ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:13:59.656736Z","caller":"traceutil/trace.go:171","msg":"trace[1701774537] transaction","detail":"{read_only:false; response_revision:1384; number_of_response:1; }","duration":"124.417931ms","start":"2026-06-24T13:13:59.532299Z","end":"2026-06-24T13:13:59.656717Z","steps":["trace[1701774537] 'process raft request' (duration: 124.197766ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:16.078308Z","caller":"traceutil/trace.go:171","msg":"trace[731332078] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"141.247906ms","start":"2026-06-24T13:14:15.937044Z","end":"2026-06-24T13:14:16.078292Z","steps":["trace[731332078] 'process raft request' (duration: 140.936091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:16.078586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.395205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T13:14:16.078689Z","caller":"traceutil/trace.go:171","msg":"trace[1681346581] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1439; }","duration":"116.543937ms","start":"2026-06-24T13:14:15.962124Z","end":"2026-06-24T13:14:16.078667Z","steps":["trace[1681346581] 'agreement among raft nodes before linearized reading' (duration: 116.322064ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:16.078908Z","caller":"traceutil/trace.go:171","msg":"trace[1795164355] linearizableReadLoop","detail":"{readStateIndex:1500; appliedIndex:1499; }","duration":"116.08151ms","start":"2026-06-24T13:14:15.962152Z","end":"2026-06-24T13:14:16.078234Z","steps":["trace[1795164355] 'read index received' (duration: 115.773015ms)","trace[1795164355] 'applied index is now lower than readState.Index' (duration: 307.065µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:14:16.080675Z","caller":"traceutil/trace.go:171","msg":"trace[1320808292] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"101.64776ms","start":"2026-06-24T13:14:15.978996Z","end":"2026-06-24T13:14:16.080644Z","steps":["trace[1320808292] 'process raft request' (duration: 101.502748ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:18.331135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.939669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:expand-controller\" ","response":"range_response_count:1 size:882"} {"level":"info","ts":"2026-06-24T13:14:18.331229Z","caller":"traceutil/trace.go:171","msg":"trace[781345998] range","detail":"{range_begin:/registry/clusterroles/system:controller:expand-controller; range_end:; response_count:1; response_revision:1446; }","duration":"139.070972ms","start":"2026-06-24T13:14:18.192141Z","end":"2026-06-24T13:14:18.331212Z","steps":["trace[781345998] 'range keys from in-memory index tree' (duration: 138.864618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:18.331325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.821392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:1 size:761"} {"level":"info","ts":"2026-06-24T13:14:18.331381Z","caller":"traceutil/trace.go:171","msg":"trace[1003621522] range","detail":"{range_begin:/registry/clusterroles/system:controller:ephemeral-volume-controller; range_end:; response_count:1; response_revision:1446; }","duration":"190.929134ms","start":"2026-06-24T13:14:18.140439Z","end":"2026-06-24T13:14:18.331368Z","steps":["trace[1003621522] 'range keys from in-memory index tree' (duration: 190.73063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:18.331526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.474541ms","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-24T13:14:18.331706Z","caller":"traceutil/trace.go:171","msg":"trace[110310158] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1446; }","duration":"156.659474ms","start":"2026-06-24T13:14:18.174983Z","end":"2026-06-24T13:14:18.331642Z","steps":["trace[110310158] 'range keys from in-memory index tree' (duration: 156.177056ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:19.088534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.47984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-autoapprove-bootstrap\" ","response":"range_response_count:1 size:550"} {"level":"info","ts":"2026-06-24T13:14:19.088621Z","caller":"traceutil/trace.go:171","msg":"trace[1192146585] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-autoapprove-bootstrap; range_end:; response_count:1; response_revision:1448; }","duration":"191.587442ms","start":"2026-06-24T13:14:18.897012Z","end":"2026-06-24T13:14:19.0886Z","steps":["trace[1192146585] 'range keys from in-memory index tree' (duration: 191.424409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:19.088962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.985537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:job-controller\" ","response":"range_response_count:1 size:782"} {"level":"info","ts":"2026-06-24T13:14:19.089692Z","caller":"traceutil/trace.go:171","msg":"trace[2024367861] range","detail":"{range_begin:/registry/clusterroles/system:controller:job-controller; range_end:; response_count:1; response_revision:1448; }","duration":"189.74246ms","start":"2026-06-24T13:14:18.899923Z","end":"2026-06-24T13:14:19.089666Z","steps":["trace[2024367861] 'range keys from in-memory index tree' (duration: 188.392807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:19.585609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.501138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/kubeadm:node-proxier\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-24T13:14:19.585724Z","caller":"traceutil/trace.go:171","msg":"trace[1625195648] range","detail":"{range_begin:/registry/clusterrolebindings/kubeadm:node-proxier; range_end:; response_count:1; response_revision:1449; }","duration":"239.651361ms","start":"2026-06-24T13:14:19.346046Z","end":"2026-06-24T13:14:19.585697Z","steps":["trace[1625195648] 'range keys from in-memory index tree' (duration: 239.402927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:19.58573Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.989715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/local-path-provisioner\" ","response":"range_response_count:1 size:1081"} {"level":"info","ts":"2026-06-24T13:14:19.585795Z","caller":"traceutil/trace.go:171","msg":"trace[1101010542] range","detail":"{range_begin:/registry/clusterrolebindings/local-path-provisioner; range_end:; response_count:1; response_revision:1449; }","duration":"258.124658ms","start":"2026-06-24T13:14:19.327653Z","end":"2026-06-24T13:14:19.585778Z","steps":["trace[1101010542] 'range keys from in-memory index tree' (duration: 257.793842ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:19.960587Z","caller":"traceutil/trace.go:171","msg":"trace[1620450628] linearizableReadLoop","detail":"{readStateIndex:1512; appliedIndex:1511; }","duration":"143.522323ms","start":"2026-06-24T13:14:19.81704Z","end":"2026-06-24T13:14:19.960563Z","steps":["trace[1620450628] 'read index received' (duration: 143.228828ms)","trace[1620450628] 'applied index is now lower than readState.Index' (duration: 292.195µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:14:19.960642Z","caller":"traceutil/trace.go:171","msg":"trace[354322549] transaction","detail":"{read_only:false; response_revision:1450; number_of_response:1; }","duration":"150.337739ms","start":"2026-06-24T13:14:19.81027Z","end":"2026-06-24T13:14:19.960608Z","steps":["trace[354322549] 'process raft request' (duration: 150.122035ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:19.960765Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.701286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:14:19.960808Z","caller":"traceutil/trace.go:171","msg":"trace[106322586] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1450; }","duration":"143.778677ms","start":"2026-06-24T13:14:19.817017Z","end":"2026-06-24T13:14:19.960796Z","steps":["trace[106322586] 'agreement among raft nodes before linearized reading' (duration: 143.695326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:19.960792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.206755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:node-controller\" ","response":"range_response_count:1 size:837"} {"level":"info","ts":"2026-06-24T13:14:19.96087Z","caller":"traceutil/trace.go:171","msg":"trace[229243841] range","detail":"{range_begin:/registry/clusterroles/system:controller:node-controller; range_end:; response_count:1; response_revision:1450; }","duration":"137.306456ms","start":"2026-06-24T13:14:19.823548Z","end":"2026-06-24T13:14:19.960854Z","steps":["trace[229243841] 'agreement among raft nodes before linearized reading' (duration: 137.170934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:19.960865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.778252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:basic-user\" ","response":"range_response_count:1 size:697"} {"level":"info","ts":"2026-06-24T13:14:19.960917Z","caller":"traceutil/trace.go:171","msg":"trace[1070068457] range","detail":"{range_begin:/registry/clusterrolebindings/system:basic-user; range_end:; response_count:1; response_revision:1450; }","duration":"134.850114ms","start":"2026-06-24T13:14:19.826054Z","end":"2026-06-24T13:14:19.960904Z","steps":["trace[1070068457] 'agreement among raft nodes before linearized reading' (duration: 134.750192ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:20.622257Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10980513637008102009,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T13:14:20.918691Z","caller":"traceutil/trace.go:171","msg":"trace[1967099747] linearizableReadLoop","detail":"{readStateIndex:1514; appliedIndex:1513; }","duration":"797.336991ms","start":"2026-06-24T13:14:20.121335Z","end":"2026-06-24T13:14:20.918672Z","steps":["trace[1967099747] 'read index received' (duration: 797.24222ms)","trace[1967099747] 'applied index is now lower than readState.Index' (duration: 93.891µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:14:20.918746Z","caller":"traceutil/trace.go:171","msg":"trace[99069190] transaction","detail":"{read_only:false; response_revision:1452; number_of_response:1; }","duration":"808.189167ms","start":"2026-06-24T13:14:20.110531Z","end":"2026-06-24T13:14:20.918721Z","steps":["trace[99069190] 'process raft request' (duration: 808.008614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:20.918824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"797.470423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" ","response":"range_response_count:1 size:1078"} {"level":"info","ts":"2026-06-24T13:14:20.918865Z","caller":"traceutil/trace.go:171","msg":"trace[279810158] range","detail":"{range_begin:/registry/clusterroles/system:controller:persistent-volume-binder; range_end:; response_count:1; response_revision:1452; }","duration":"797.556925ms","start":"2026-06-24T13:14:20.121295Z","end":"2026-06-24T13:14:20.918852Z","steps":["trace[279810158] 'agreement among raft nodes before linearized reading' (duration: 797.474704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:20.9189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:14:20.121279Z","time spent":"797.613656ms","remote":"127.0.0.1:36688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":1,"response size":1102,"request content":"key:\"/registry/clusterroles/system:controller:persistent-volume-binder\" "} {"level":"warn","ts":"2026-06-24T13:14:20.919113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:14:20.110522Z","time spent":"808.330729ms","remote":"127.0.0.1:36606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T13:14:20.946331Z","caller":"traceutil/trace.go:171","msg":"trace[1036024522] transaction","detail":"{read_only:false; response_revision:1453; number_of_response:1; }","duration":"166.03409ms","start":"2026-06-24T13:14:20.780273Z","end":"2026-06-24T13:14:20.946308Z","steps":["trace[1036024522] 'process raft request' (duration: 165.768676ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:20.94641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.228383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T13:14:20.946374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"603.525166ms","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-24T13:14:20.946763Z","caller":"traceutil/trace.go:171","msg":"trace[1975935909] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1453; }","duration":"603.950952ms","start":"2026-06-24T13:14:20.342792Z","end":"2026-06-24T13:14:20.946743Z","steps":["trace[1975935909] 'agreement among raft nodes before linearized reading' (duration: 603.457894ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:20.946691Z","caller":"traceutil/trace.go:171","msg":"trace[663712519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1453; }","duration":"128.495467ms","start":"2026-06-24T13:14:20.818116Z","end":"2026-06-24T13:14:20.946611Z","steps":["trace[663712519] 'agreement among raft nodes before linearized reading' (duration: 128.245053ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:20.946841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:14:20.342771Z","time spent":"604.044704ms","remote":"127.0.0.1:36606","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-24T13:14:20.946455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"824.425845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:pod-garbage-collector\" ","response":"range_response_count:1 size:665"} {"level":"info","ts":"2026-06-24T13:14:20.94693Z","caller":"traceutil/trace.go:171","msg":"trace[2146183550] range","detail":"{range_begin:/registry/clusterroles/system:controller:pod-garbage-collector; range_end:; response_count:1; response_revision:1453; }","duration":"824.933543ms","start":"2026-06-24T13:14:20.121984Z","end":"2026-06-24T13:14:20.946918Z","steps":["trace[2146183550] 'agreement among raft nodes before linearized reading' (duration: 824.438095ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:20.946958Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T13:14:20.121967Z","time spent":"824.983465ms","remote":"127.0.0.1:36688","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":689,"request content":"key:\"/registry/clusterroles/system:controller:pod-garbage-collector\" "} {"level":"warn","ts":"2026-06-24T13:14:21.559688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.619875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replicaset-controller\" ","response":"range_response_count:1 size:843"} {"level":"info","ts":"2026-06-24T13:14:21.55977Z","caller":"traceutil/trace.go:171","msg":"trace[58844669] range","detail":"{range_begin:/registry/clusterroles/system:controller:replicaset-controller; range_end:; response_count:1; response_revision:1455; }","duration":"189.744306ms","start":"2026-06-24T13:14:21.370006Z","end":"2026-06-24T13:14:21.55975Z","steps":["trace[58844669] 'range keys from in-memory index tree' (duration: 189.535793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:21.559807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.719548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:replication-controller\" ","response":"range_response_count:1 size:830"} {"level":"info","ts":"2026-06-24T13:14:21.559861Z","caller":"traceutil/trace.go:171","msg":"trace[29783316] range","detail":"{range_begin:/registry/clusterroles/system:controller:replication-controller; range_end:; response_count:1; response_revision:1455; }","duration":"151.82788ms","start":"2026-06-24T13:14:21.408019Z","end":"2026-06-24T13:14:21.559847Z","steps":["trace[29783316] 'range keys from in-memory index tree' (duration: 151.637967ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:23.13148Z","caller":"traceutil/trace.go:171","msg":"trace[442183996] linearizableReadLoop","detail":"{readStateIndex:1522; appliedIndex:1520; }","duration":"165.651774ms","start":"2026-06-24T13:14:22.965804Z","end":"2026-06-24T13:14:23.131456Z","steps":["trace[442183996] 'read index received' (duration: 48.994473ms)","trace[442183996] 'applied index is now lower than readState.Index' (duration: 116.656371ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:14:23.131541Z","caller":"traceutil/trace.go:171","msg":"trace[1719026338] transaction","detail":"{read_only:false; response_revision:1460; number_of_response:1; }","duration":"179.866427ms","start":"2026-06-24T13:14:22.951626Z","end":"2026-06-24T13:14:23.131492Z","steps":["trace[1719026338] 'process raft request' (duration: 122.797378ms)","trace[1719026338] 'compare' (duration: 56.957537ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:14:23.131659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.883782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/system:controller:ephemeral-volume-controller\" ","response":"range_response_count:1 size:783"} {"level":"info","ts":"2026-06-24T13:14:23.131723Z","caller":"traceutil/trace.go:171","msg":"trace[1866046951] range","detail":"{range_begin:/registry/clusterrolebindings/system:controller:ephemeral-volume-controller; range_end:; response_count:1; response_revision:1460; }","duration":"160.985884ms","start":"2026-06-24T13:14:22.970718Z","end":"2026-06-24T13:14:23.131704Z","steps":["trace[1866046951] 'agreement among raft nodes before linearized reading' (duration: 160.892913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:23.131658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.812878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:controller:ttl-after-finished-controller\" ","response":"range_response_count:1 size:695"} {"level":"warn","ts":"2026-06-24T13:14:23.131933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.019313ms","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-24T13:14:23.131999Z","caller":"traceutil/trace.go:171","msg":"trace[1460593523] range","detail":"{range_begin:/registry/clusterroles/system:controller:ttl-after-finished-controller; range_end:; response_count:1; response_revision:1460; }","duration":"166.210904ms","start":"2026-06-24T13:14:22.965773Z","end":"2026-06-24T13:14:23.131984Z","steps":["trace[1460593523] 'agreement among raft nodes before linearized reading' (duration: 165.778897ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:23.13201Z","caller":"traceutil/trace.go:171","msg":"trace[648509079] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1460; }","duration":"135.159986ms","start":"2026-06-24T13:14:22.996833Z","end":"2026-06-24T13:14:23.131993Z","steps":["trace[648509079] 'agreement among raft nodes before linearized reading' (duration: 134.874151ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:29.19439Z","caller":"traceutil/trace.go:171","msg":"trace[900624562] transaction","detail":"{read_only:false; response_revision:1479; number_of_response:1; }","duration":"131.622649ms","start":"2026-06-24T13:14:29.062744Z","end":"2026-06-24T13:14:29.194367Z","steps":["trace[900624562] 'process raft request' (duration: 131.465476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:29.348907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.042593ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-24T13:14:29.349238Z","caller":"traceutil/trace.go:171","msg":"trace[783596930] transaction","detail":"{read_only:false; response_revision:1480; number_of_response:1; }","duration":"139.695053ms","start":"2026-06-24T13:14:29.209523Z","end":"2026-06-24T13:14:29.349218Z","steps":["trace[783596930] 'process raft request' (duration: 139.541241ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:29.349446Z","caller":"traceutil/trace.go:171","msg":"trace[1441941455] linearizableReadLoop","detail":"{readStateIndex:1543; appliedIndex:1542; }","duration":"155.071542ms","start":"2026-06-24T13:14:29.194342Z","end":"2026-06-24T13:14:29.349414Z","steps":["trace[1441941455] 'read index received' (duration: 18.493639ms)","trace[1441941455] 'applied index is now lower than readState.Index' (duration: 136.574942ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:14:29.349595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.724672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"warn","ts":"2026-06-24T13:14:29.349593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.5869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/\" range_end:\"/registry/jobs/envoy-gateway-system0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T13:14:29.349638Z","caller":"traceutil/trace.go:171","msg":"trace[1611643973] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1480; }","duration":"228.787603ms","start":"2026-06-24T13:14:29.120839Z","end":"2026-06-24T13:14:29.349627Z","steps":["trace[1611643973] 'agreement among raft nodes before linearized reading' (duration: 228.61785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:29.349632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.001513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/envoy-gateway-system/envoy-gateway\" ","response":"range_response_count:1 size:1120"} {"level":"info","ts":"2026-06-24T13:14:29.349656Z","caller":"traceutil/trace.go:171","msg":"trace[550807922] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/; range_end:/registry/jobs/envoy-gateway-system0; response_count:0; response_revision:1480; }","duration":"231.700622ms","start":"2026-06-24T13:14:29.117941Z","end":"2026-06-24T13:14:29.349641Z","steps":["trace[550807922] 'agreement among raft nodes before linearized reading' (duration: 231.5714ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:29.349691Z","caller":"traceutil/trace.go:171","msg":"trace[1471407672] range","detail":"{range_begin:/registry/services/endpoints/envoy-gateway-system/envoy-gateway; range_end:; response_count:1; response_revision:1480; }","duration":"221.064744ms","start":"2026-06-24T13:14:29.128607Z","end":"2026-06-24T13:14:29.349672Z","steps":["trace[1471407672] 'agreement among raft nodes before linearized reading' (duration: 220.82679ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T13:14:29.349716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.563828ms","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-24T13:14:29.349752Z","caller":"traceutil/trace.go:171","msg":"trace[313421378] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1480; }","duration":"128.67203ms","start":"2026-06-24T13:14:29.22107Z","end":"2026-06-24T13:14:29.349742Z","steps":["trace[313421378] 'agreement among raft nodes before linearized reading' (duration: 128.485947ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T13:14:39.60866Z","caller":"traceutil/trace.go:171","msg":"trace[909704277] linearizableReadLoop","detail":"{readStateIndex:1581; appliedIndex:1580; }","duration":"127.991295ms","start":"2026-06-24T13:14:39.480642Z","end":"2026-06-24T13:14:39.608634Z","steps":["trace[909704277] 'read index received' (duration: 116.591559ms)","trace[909704277] 'applied index is now lower than readState.Index' (duration: 11.398916ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T13:14:39.608819Z","caller":"traceutil/trace.go:171","msg":"trace[1949247677] transaction","detail":"{read_only:false; response_revision:1515; number_of_response:1; }","duration":"143.381285ms","start":"2026-06-24T13:14:39.465421Z","end":"2026-06-24T13:14:39.608802Z","steps":["trace[1949247677] 'process raft request' (duration: 131.746576ms)","trace[1949247677] 'compare' (duration: 11.354595ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T13:14:39.608891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.228998ms","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-24T13:14:39.608985Z","caller":"traceutil/trace.go:171","msg":"trace[434560457] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/node-controller; range_end:; response_count:1; response_revision:1515; }","duration":"128.365871ms","start":"2026-06-24T13:14:39.480603Z","end":"2026-06-24T13:14:39.608968Z","steps":["trace[434560457] 'agreement among raft nodes before linearized reading' (duration: 128.221509ms)"],"step_count":1}