{"level":"warn","ts":"2026-06-24T11:00:00.027496Z","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-24T11:00:00.027656Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.14: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.14:2380","--initial-cluster=instance=https://199.19.213.14:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.14:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.14: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-24T11:00:00.027991Z","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-24T11:00:00.028014Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-06-24T11:00:00.028072Z","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-24T11:00:00.029176Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"]} {"level":"info","ts":"2026-06-24T11:00:00.029426Z","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.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.14: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-24T11:00:00.034025Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.12784ms"} {"level":"info","ts":"2026-06-24T11:00:00.040968Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"329f95029c2a91ed","cluster-id":"5fd85759a04d0f9f"} {"level":"info","ts":"2026-06-24T11:00:00.041184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T11:00:00.041234Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 0"} {"level":"info","ts":"2026-06-24T11:00:00.041267Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 329f95029c2a91ed [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T11:00:00.04128Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became follower at term 1"} {"level":"info","ts":"2026-06-24T11:00:00.041417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"warn","ts":"2026-06-24T11:00:00.057185Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T11:00:00.058718Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T11:00:00.061454Z","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-24T11:00:00.067283Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"329f95029c2a91ed","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T11:00:00.067697Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"329f95029c2a91ed","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T11:00:00.067837Z","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-24T11:00:00.067866Z","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-24T11:00:00.067873Z","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-24T11:00:00.069356Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed switched to configuration voters=(3647798061635899885)"} {"level":"info","ts":"2026-06-24T11:00:00.069509Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","added-peer-id":"329f95029c2a91ed","added-peer-peer-urls":["https://199.19.213.14:2380"]} {"level":"info","ts":"2026-06-24T11:00:00.07252Z","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-24T11:00:00.072611Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-06-24T11:00:00.072698Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.14:2380"} {"level":"info","ts":"2026-06-24T11:00:00.0729Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"329f95029c2a91ed","initial-advertise-peer-urls":["https://199.19.213.14:2380"],"listen-peer-urls":["https://199.19.213.14:2380"],"advertise-client-urls":["https://199.19.213.14:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.14:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T11:00:00.072943Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T11:00:00.842455Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T11:00:00.842505Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T11:00:00.842573Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgPreVoteResp from 329f95029c2a91ed at term 1"} {"level":"info","ts":"2026-06-24T11:00:00.842588Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became candidate at term 2"} {"level":"info","ts":"2026-06-24T11:00:00.842594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed received MsgVoteResp from 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-06-24T11:00:00.842605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"329f95029c2a91ed became leader at term 2"} {"level":"info","ts":"2026-06-24T11:00:00.842617Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 329f95029c2a91ed elected leader 329f95029c2a91ed at term 2"} {"level":"info","ts":"2026-06-24T11:00:00.8444Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T11:00:00.845231Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T11:00:00.84523Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"329f95029c2a91ed","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.14:2379]}","request-path":"/0/members/329f95029c2a91ed/attributes","cluster-id":"5fd85759a04d0f9f","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T11:00:00.845282Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T11:00:00.845579Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T11:00:00.845654Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T11:00:00.845808Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5fd85759a04d0f9f","local-member-id":"329f95029c2a91ed","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T11:00:00.845956Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T11:00:00.845974Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T11:00:00.84809Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T11:00:00.848336Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.14:2379"} {"level":"info","ts":"2026-06-24T11:00:10.239404Z","caller":"traceutil/trace.go:171","msg":"trace[230042462] transaction","detail":"{read_only:false; response_revision:361; number_of_response:1; }","duration":"342.665389ms","start":"2026-06-24T11:00:09.896713Z","end":"2026-06-24T11:00:10.239378Z","steps":["trace[230042462] 'process raft request' (duration: 342.511247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:10.239951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:09.896687Z","time spent":"342.829173ms","remote":"127.0.0.1:40258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3527,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T11:00:10.344775Z","caller":"traceutil/trace.go:171","msg":"trace[1122019217] transaction","detail":"{read_only:false; response_revision:362; number_of_response:1; }","duration":"447.747438ms","start":"2026-06-24T11:00:09.897001Z","end":"2026-06-24T11:00:10.344749Z","steps":["trace[1122019217] 'process raft request' (duration: 447.479473ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:10.344679Z","caller":"traceutil/trace.go:171","msg":"trace[912683129] linearizableReadLoop","detail":"{readStateIndex:375; appliedIndex:373; }","duration":"408.748795ms","start":"2026-06-24T11:00:09.935905Z","end":"2026-06-24T11:00:10.344654Z","steps":["trace[912683129] 'read index received' (duration: 303.409861ms)","trace[912683129] 'applied index is now lower than readState.Index' (duration: 105.337894ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:10.345339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.07524ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T11:00:10.345618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:09.896976Z","time spent":"447.947512ms","remote":"127.0.0.1:40258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7279,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:10.34563Z","caller":"traceutil/trace.go:171","msg":"trace[1991053454] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:362; }","duration":"409.60431ms","start":"2026-06-24T11:00:09.935866Z","end":"2026-06-24T11:00:10.34547Z","steps":["trace[1991053454] 'agreement among raft nodes before linearized reading' (duration: 408.981778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:10.346054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:09.935848Z","time spent":"410.187672ms","remote":"127.0.0.1:40040","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T11:00:10.352911Z","caller":"traceutil/trace.go:171","msg":"trace[403088301] transaction","detail":"{read_only:false; response_revision:364; number_of_response:1; }","duration":"108.659555ms","start":"2026-06-24T11:00:10.244239Z","end":"2026-06-24T11:00:10.352898Z","steps":["trace[403088301] 'process raft request' (duration: 108.554483ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:10.352904Z","caller":"traceutil/trace.go:171","msg":"trace[1178480679] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"102.121503ms","start":"2026-06-24T11:00:10.250763Z","end":"2026-06-24T11:00:10.352885Z","steps":["trace[1178480679] 'process raft request' (duration: 102.080832ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:10.352894Z","caller":"traceutil/trace.go:171","msg":"trace[517886633] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"109.162225ms","start":"2026-06-24T11:00:10.243712Z","end":"2026-06-24T11:00:10.352875Z","steps":["trace[517886633] 'process raft request' (duration: 108.982062ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:10.352958Z","caller":"traceutil/trace.go:171","msg":"trace[1599906004] transaction","detail":"{read_only:false; response_revision:365; number_of_response:1; }","duration":"108.425701ms","start":"2026-06-24T11:00:10.24452Z","end":"2026-06-24T11:00:10.352946Z","steps":["trace[1599906004] 'process raft request' (duration: 108.301499ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:16.676956Z","caller":"traceutil/trace.go:171","msg":"trace[2025378742] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"128.822201ms","start":"2026-06-24T11:00:16.548117Z","end":"2026-06-24T11:00:16.676939Z","steps":["trace[2025378742] 'process raft request' (duration: 128.433703ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:17.094793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.164977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/etcd-instance\" ","response":"range_response_count:1 size:5326"} {"level":"info","ts":"2026-06-24T11:00:17.094872Z","caller":"traceutil/trace.go:171","msg":"trace[1961685791] range","detail":"{range_begin:/registry/pods/kube-system/etcd-instance; range_end:; response_count:1; response_revision:393; }","duration":"103.28831ms","start":"2026-06-24T11:00:16.99157Z","end":"2026-06-24T11:00:17.094858Z","steps":["trace[1961685791] 'range keys from in-memory index tree' (duration: 103.091055ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:24.844279Z","caller":"traceutil/trace.go:171","msg":"trace[2017534723] transaction","detail":"{read_only:false; response_revision:413; number_of_response:1; }","duration":"120.652187ms","start":"2026-06-24T11:00:24.723594Z","end":"2026-06-24T11:00:24.844247Z","steps":["trace[2017534723] 'process raft request' (duration: 120.417741ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:25.007369Z","caller":"traceutil/trace.go:171","msg":"trace[2049997881] linearizableReadLoop","detail":"{readStateIndex:431; appliedIndex:430; }","duration":"137.1844ms","start":"2026-06-24T11:00:24.870143Z","end":"2026-06-24T11:00:25.007328Z","steps":["trace[2049997881] 'read index received' (duration: 85.191597ms)","trace[2049997881] 'applied index is now lower than readState.Index' (duration: 51.991713ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:25.007604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.449897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T11:00:25.00758Z","caller":"traceutil/trace.go:171","msg":"trace[355474793] transaction","detail":"{read_only:false; response_revision:414; number_of_response:1; }","duration":"158.866853ms","start":"2026-06-24T11:00:24.848658Z","end":"2026-06-24T11:00:25.007525Z","steps":["trace[355474793] 'process raft request' (duration: 106.641984ms)","trace[355474793] 'compare' (duration: 51.88345ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:25.00767Z","caller":"traceutil/trace.go:171","msg":"trace[1859603451] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:414; }","duration":"137.58264ms","start":"2026-06-24T11:00:24.870067Z","end":"2026-06-24T11:00:25.00765Z","steps":["trace[1859603451] 'agreement among raft nodes before linearized reading' (duration: 137.452247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:25.00767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.633805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:00:25.007797Z","caller":"traceutil/trace.go:171","msg":"trace[248006794] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:414; }","duration":"136.782388ms","start":"2026-06-24T11:00:24.87099Z","end":"2026-06-24T11:00:25.007772Z","steps":["trace[248006794] 'agreement among raft nodes before linearized reading' (duration: 136.570913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:25.323139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.936783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:00:25.323506Z","caller":"traceutil/trace.go:171","msg":"trace[1241277355] transaction","detail":"{read_only:false; response_revision:416; number_of_response:1; }","duration":"311.077976ms","start":"2026-06-24T11:00:25.012404Z","end":"2026-06-24T11:00:25.323482Z","steps":["trace[1241277355] 'process raft request' (duration: 124.574528ms)","trace[1241277355] 'compare' (duration: 185.769039ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:25.323771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:25.012387Z","time spent":"311.304682ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:26.601453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.052162ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:26.601553Z","caller":"traceutil/trace.go:171","msg":"trace[858584077] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:417; }","duration":"199.163655ms","start":"2026-06-24T11:00:26.402377Z","end":"2026-06-24T11:00:26.60154Z","steps":["trace[858584077] 'range keys from in-memory index tree' (duration: 199.035891ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:27.137191Z","caller":"traceutil/trace.go:171","msg":"trace[208335199] linearizableReadLoop","detail":"{readStateIndex:436; appliedIndex:435; }","duration":"110.850996ms","start":"2026-06-24T11:00:27.026318Z","end":"2026-06-24T11:00:27.137169Z","steps":["trace[208335199] 'read index received' (duration: 110.686061ms)","trace[208335199] 'applied index is now lower than readState.Index' (duration: 163.955µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:27.13733Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.99754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T11:00:27.137368Z","caller":"traceutil/trace.go:171","msg":"trace[801174503] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:419; }","duration":"111.086313ms","start":"2026-06-24T11:00:27.026273Z","end":"2026-06-24T11:00:27.137359Z","steps":["trace[801174503] 'agreement among raft nodes before linearized reading' (duration: 110.982409ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:27.137705Z","caller":"traceutil/trace.go:171","msg":"trace[1424424100] transaction","detail":"{read_only:false; response_revision:419; number_of_response:1; }","duration":"121.742125ms","start":"2026-06-24T11:00:27.015946Z","end":"2026-06-24T11:00:27.137689Z","steps":["trace[1424424100] 'process raft request' (duration: 121.111527ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:33.696438Z","caller":"traceutil/trace.go:171","msg":"trace[742034865] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"327.800922ms","start":"2026-06-24T11:00:33.368613Z","end":"2026-06-24T11:00:33.696414Z","steps":["trace[742034865] 'process raft request' (duration: 327.666248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:33.696592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:33.368582Z","time spent":"327.930376ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:41.919686Z","caller":"traceutil/trace.go:171","msg":"trace[225995777] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"170.759551ms","start":"2026-06-24T11:00:41.748907Z","end":"2026-06-24T11:00:41.919666Z","steps":["trace[225995777] 'process raft request' (duration: 170.643798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:46.439156Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235498496077246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T11:00:46.93988Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235498496077246,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T11:00:46.962668Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.053129107s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T11:00:46.985259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.318679ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:46.985405Z","caller":"traceutil/trace.go:171","msg":"trace[1401464923] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:550; }","duration":"584.464994ms","start":"2026-06-24T11:00:46.400915Z","end":"2026-06-24T11:00:46.98538Z","steps":["trace[1401464923] 'range keys from in-memory index tree' (duration: 584.304139ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:46.985505Z","caller":"traceutil/trace.go:171","msg":"trace[104402185] transaction","detail":"{read_only:false; response_revision:551; number_of_response:1; }","duration":"1.076035905s","start":"2026-06-24T11:00:45.909447Z","end":"2026-06-24T11:00:46.985483Z","steps":["trace[104402185] 'process raft request' (duration: 1.053529292s)","trace[104402185] 'compare' (duration: 22.024225ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:46.985643Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:45.909396Z","time spent":"1.076137579s","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7684,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:46.9866Z","caller":"traceutil/trace.go:171","msg":"trace[2095738827] transaction","detail":"{read_only:false; response_revision:552; number_of_response:1; }","duration":"1.067006634s","start":"2026-06-24T11:00:45.919573Z","end":"2026-06-24T11:00:46.98658Z","steps":["trace[2095738827] 'process raft request' (duration: 1.066709034s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:46.986745Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:45.919536Z","time spent":"1.067151609s","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:46.986811Z","caller":"traceutil/trace.go:171","msg":"trace[607527358] transaction","detail":"{read_only:false; response_revision:554; number_of_response:1; }","duration":"1.003061053s","start":"2026-06-24T11:00:45.983732Z","end":"2026-06-24T11:00:46.986793Z","steps":["trace[607527358] 'process raft request' (duration: 1.002899277s)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:46.986899Z","caller":"traceutil/trace.go:171","msg":"trace[723608898] transaction","detail":"{read_only:false; response_revision:553; number_of_response:1; }","duration":"1.009562296s","start":"2026-06-24T11:00:45.977322Z","end":"2026-06-24T11:00:46.986884Z","steps":["trace[723608898] 'process raft request' (duration: 1.009176092s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:46.986932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:45.983718Z","time spent":"1.003152275s","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:46.986973Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:45.977288Z","time spent":"1.009651779s","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T11:00:46.987375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049084147s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:00:46.987438Z","caller":"traceutil/trace.go:171","msg":"trace[154101515] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:554; }","duration":"1.04917613s","start":"2026-06-24T11:00:45.938243Z","end":"2026-06-24T11:00:46.987419Z","steps":["trace[154101515] 'agreement among raft nodes before linearized reading' (duration: 1.048913381s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:46.987485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:45.938229Z","time spent":"1.049243502s","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-24T11:00:46.986751Z","caller":"traceutil/trace.go:171","msg":"trace[780115017] linearizableReadLoop","detail":"{readStateIndex:580; appliedIndex:576; }","duration":"1.048449524s","start":"2026-06-24T11:00:45.938277Z","end":"2026-06-24T11:00:46.986726Z","steps":["trace[780115017] 'read index received' (duration: 1.024621966s)","trace[780115017] 'applied index is now lower than readState.Index' (duration: 23.826498ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:48.128356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.322877ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:00:48.128453Z","caller":"traceutil/trace.go:171","msg":"trace[515961007] transaction","detail":"{read_only:false; response_revision:602; number_of_response:1; }","duration":"173.274154ms","start":"2026-06-24T11:00:47.955165Z","end":"2026-06-24T11:00:48.128439Z","steps":["trace[515961007] 'process raft request' (duration: 68.816872ms)","trace[515961007] 'compare' (duration: 104.15447ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:48.135566Z","caller":"traceutil/trace.go:171","msg":"trace[1177269712] transaction","detail":"{read_only:false; response_revision:603; number_of_response:1; }","duration":"133.180137ms","start":"2026-06-24T11:00:48.002354Z","end":"2026-06-24T11:00:48.135534Z","steps":["trace[1177269712] 'process raft request' (duration: 133.030932ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:48.331641Z","caller":"traceutil/trace.go:171","msg":"trace[857768350] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"121.489524ms","start":"2026-06-24T11:00:48.210132Z","end":"2026-06-24T11:00:48.331622Z","steps":["trace[857768350] 'read index received' (duration: 31.04054ms)","trace[857768350] 'applied index is now lower than readState.Index' (duration: 90.448254ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:48.331843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.690501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:29570"} {"level":"info","ts":"2026-06-24T11:00:48.331871Z","caller":"traceutil/trace.go:171","msg":"trace[608182659] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/backendtlspolicies.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:604; }","duration":"121.756103ms","start":"2026-06-24T11:00:48.210107Z","end":"2026-06-24T11:00:48.331863Z","steps":["trace[608182659] 'agreement among raft nodes before linearized reading' (duration: 121.596238ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:48.332574Z","caller":"traceutil/trace.go:171","msg":"trace[877042572] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"180.873508ms","start":"2026-06-24T11:00:48.151688Z","end":"2026-06-24T11:00:48.332561Z","steps":["trace[877042572] 'process raft request' (duration: 89.030145ms)","trace[877042572] 'compare' (duration: 90.724054ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:48.395158Z","caller":"traceutil/trace.go:171","msg":"trace[209155319] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"162.86903ms","start":"2026-06-24T11:00:48.232267Z","end":"2026-06-24T11:00:48.395136Z","steps":["trace[209155319] 'process raft request' (duration: 161.901595ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:48.52797Z","caller":"traceutil/trace.go:171","msg":"trace[1180480249] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:631; }","duration":"123.565557ms","start":"2026-06-24T11:00:48.404378Z","end":"2026-06-24T11:00:48.527943Z","steps":["trace[1180480249] 'read index received' (duration: 55.472865ms)","trace[1180480249] 'applied index is now lower than readState.Index' (duration: 68.091722ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:48.528108Z","caller":"traceutil/trace.go:171","msg":"trace[225236285] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"152.963209ms","start":"2026-06-24T11:00:48.375123Z","end":"2026-06-24T11:00:48.528086Z","steps":["trace[225236285] 'process raft request' (duration: 84.724512ms)","trace[225236285] 'compare' (duration: 67.933846ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:48.528283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.879249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:59631"} {"level":"info","ts":"2026-06-24T11:00:48.528367Z","caller":"traceutil/trace.go:171","msg":"trace[1193573538] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/gateways.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:606; }","duration":"124.005793ms","start":"2026-06-24T11:00:48.404343Z","end":"2026-06-24T11:00:48.528349Z","steps":["trace[1193573538] 'agreement among raft nodes before linearized reading' (duration: 123.701403ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:48.790614Z","caller":"traceutil/trace.go:171","msg":"trace[1635655409] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"145.385291ms","start":"2026-06-24T11:00:48.64519Z","end":"2026-06-24T11:00:48.790575Z","steps":["trace[1635655409] 'read index received' (duration: 72.091274ms)","trace[1635655409] 'applied index is now lower than readState.Index' (duration: 73.293127ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:48.790793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.582278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io\" ","response":"range_response_count:1 size:7708"} {"level":"info","ts":"2026-06-24T11:00:48.790834Z","caller":"traceutil/trace.go:171","msg":"trace[220132240] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/referencegrants.gateway.networking.k8s.io; range_end:; response_count:1; response_revision:607; }","duration":"145.656431ms","start":"2026-06-24T11:00:48.645166Z","end":"2026-06-24T11:00:48.790822Z","steps":["trace[220132240] 'agreement among raft nodes before linearized reading' (duration: 145.513806ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:48.790936Z","caller":"traceutil/trace.go:171","msg":"trace[276329064] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"182.042549ms","start":"2026-06-24T11:00:48.608883Z","end":"2026-06-24T11:00:48.790925Z","steps":["trace[276329064] 'process raft request' (duration: 108.516435ms)","trace[276329064] 'compare' (duration: 72.993165ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:49.281936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.363221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:00:49.28201Z","caller":"traceutil/trace.go:171","msg":"trace[378263715] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:607; }","duration":"264.473374ms","start":"2026-06-24T11:00:49.017518Z","end":"2026-06-24T11:00:49.281992Z","steps":["trace[378263715] 'range keys from in-memory index tree' (duration: 264.216735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:49.282144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.002032ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:74769"} {"level":"info","ts":"2026-06-24T11:00:49.282217Z","caller":"traceutil/trace.go:171","msg":"trace[221792230] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:607; }","duration":"382.092575ms","start":"2026-06-24T11:00:48.90011Z","end":"2026-06-24T11:00:49.282202Z","steps":["trace[221792230] 'range keys from in-memory index tree' (duration: 381.900438ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:49.282269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.710502ms","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-24T11:00:49.282306Z","caller":"traceutil/trace.go:171","msg":"trace[1941433082] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:607; }","duration":"170.780524ms","start":"2026-06-24T11:00:49.111517Z","end":"2026-06-24T11:00:49.282297Z","steps":["trace[1941433082] 'range keys from in-memory index tree' (duration: 170.598638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:49.28243Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.952821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:49.282518Z","caller":"traceutil/trace.go:171","msg":"trace[1130270995] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:607; }","duration":"347.074535ms","start":"2026-06-24T11:00:48.935424Z","end":"2026-06-24T11:00:49.282498Z","steps":["trace[1130270995] 'range keys from in-memory index tree' (duration: 346.891729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:49.282279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:48.9001Z","time spent":"382.168078ms","remote":"127.0.0.1:40098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":103,"response count":1,"response size":74791,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyextensionpolicies.gateway.envoyproxy.io\" "} {"level":"warn","ts":"2026-06-24T11:00:49.282568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:48.935386Z","time spent":"347.173589ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T11:00:52.750775Z","caller":"traceutil/trace.go:171","msg":"trace[1002316108] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"113.485343ms","start":"2026-06-24T11:00:52.637263Z","end":"2026-06-24T11:00:52.750749Z","steps":["trace[1002316108] 'process raft request' (duration: 102.374496ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:53.377207Z","caller":"traceutil/trace.go:171","msg":"trace[1284754765] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"123.414105ms","start":"2026-06-24T11:00:53.253763Z","end":"2026-06-24T11:00:53.377177Z","steps":["trace[1284754765] 'process raft request' (duration: 123.154415ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:53.419954Z","caller":"traceutil/trace.go:171","msg":"trace[770874617] linearizableReadLoop","detail":"{readStateIndex:655; appliedIndex:653; }","duration":"114.873758ms","start":"2026-06-24T11:00:53.30506Z","end":"2026-06-24T11:00:53.419934Z","steps":["trace[770874617] 'read index received' (duration: 71.849968ms)","trace[770874617] 'applied index is now lower than readState.Index' (duration: 43.02297ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:53.420056Z","caller":"traceutil/trace.go:171","msg":"trace[1525270927] transaction","detail":"{read_only:false; response_revision:628; number_of_response:1; }","duration":"134.842058ms","start":"2026-06-24T11:00:53.285185Z","end":"2026-06-24T11:00:53.420027Z","steps":["trace[1525270927] 'process raft request' (duration: 134.642599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:53.420144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.340588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-24T11:00:53.420167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.123458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:00:53.420196Z","caller":"traceutil/trace.go:171","msg":"trace[596177066] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:628; }","duration":"111.457472ms","start":"2026-06-24T11:00:53.308721Z","end":"2026-06-24T11:00:53.420179Z","steps":["trace[596177066] 'agreement among raft nodes before linearized reading' (duration: 111.345538ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:53.420198Z","caller":"traceutil/trace.go:171","msg":"trace[950222076] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:628; }","duration":"115.198192ms","start":"2026-06-24T11:00:53.304989Z","end":"2026-06-24T11:00:53.420187Z","steps":["trace[950222076] 'agreement among raft nodes before linearized reading' (duration: 115.049546ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:53.659373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.051635ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:00:53.659605Z","caller":"traceutil/trace.go:171","msg":"trace[275754654] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:655; }","duration":"210.933871ms","start":"2026-06-24T11:00:53.448655Z","end":"2026-06-24T11:00:53.659589Z","steps":["trace[275754654] 'read index received' (duration: 95.600446ms)","trace[275754654] 'applied index is now lower than readState.Index' (duration: 115.332655ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:53.659632Z","caller":"traceutil/trace.go:171","msg":"trace[445308794] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"234.723081ms","start":"2026-06-24T11:00:53.42489Z","end":"2026-06-24T11:00:53.659613Z","steps":["trace[445308794] 'process raft request' (duration: 234.598026ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:53.659619Z","caller":"traceutil/trace.go:171","msg":"trace[1437534468] transaction","detail":"{read_only:false; response_revision:629; number_of_response:1; }","duration":"234.749961ms","start":"2026-06-24T11:00:53.424831Z","end":"2026-06-24T11:00:53.659581Z","steps":["trace[1437534468] 'process raft request' (duration: 119.410746ms)","trace[1437534468] 'compare' (duration: 114.874138ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:53.659659Z","caller":"traceutil/trace.go:171","msg":"trace[84752044] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"233.37168ms","start":"2026-06-24T11:00:53.426261Z","end":"2026-06-24T11:00:53.659633Z","steps":["trace[84752044] 'process raft request' (duration: 233.290347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:53.65984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.18303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T11:00:53.659907Z","caller":"traceutil/trace.go:171","msg":"trace[174793328] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:631; }","duration":"211.246772ms","start":"2026-06-24T11:00:53.448617Z","end":"2026-06-24T11:00:53.659864Z","steps":["trace[174793328] 'agreement among raft nodes before linearized reading' (duration: 211.031034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:55.094199Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235498496077398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T11:00:55.594417Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235498496077398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T11:00:56.094868Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235498496077398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T11:00:56.595069Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":10515235498496077398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T11:00:56.92575Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.624502983s","expected-duration":"1s"} {"level":"warn","ts":"2026-06-24T11:00:56.935177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.999911114s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-24T11:00:56.935268Z","caller":"traceutil/trace.go:171","msg":"trace[694644644] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000055829s","start":"2026-06-24T11:00:54.935192Z","end":"2026-06-24T11:00:56.935248Z","steps":["trace[694644644] 'agreement among raft nodes before linearized reading' (duration: 1.999944645s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:56.935319Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:54.935172Z","time spent":"2.000136802s","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/24 11:00:56 WARNING: [core] [Server #8] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-24T11:00:56.939265Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"537.626903ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:56.939347Z","caller":"traceutil/trace.go:171","msg":"trace[1548057161] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:637; }","duration":"537.707736ms","start":"2026-06-24T11:00:56.401626Z","end":"2026-06-24T11:00:56.939334Z","steps":["trace[1548057161] 'range keys from in-memory index tree' (duration: 537.617663ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:56.939564Z","caller":"traceutil/trace.go:171","msg":"trace[794445692] linearizableReadLoop","detail":"{readStateIndex:665; appliedIndex:664; }","duration":"2.346257228s","start":"2026-06-24T11:00:54.593298Z","end":"2026-06-24T11:00:56.939555Z","steps":["trace[794445692] 'read index received' (duration: 2.332609402s)","trace[794445692] 'applied index is now lower than readState.Index' (duration: 13.647036ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:56.938315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.95384249s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.14\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-24T11:00:56.940556Z","caller":"traceutil/trace.go:171","msg":"trace[187131103] range","detail":"{range_begin:/registry/masterleases/199.19.213.14; range_end:; response_count:1; response_revision:637; }","duration":"2.955469342s","start":"2026-06-24T11:00:53.984432Z","end":"2026-06-24T11:00:56.939901Z","steps":["trace[187131103] 'range keys from in-memory index tree' (duration: 2.953769687s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:56.940632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:53.984416Z","time spent":"2.956197469s","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":155,"request content":"key:\"/registry/masterleases/199.19.213.14\" "} {"level":"info","ts":"2026-06-24T11:00:56.94409Z","caller":"traceutil/trace.go:171","msg":"trace[13067593] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"2.643968298s","start":"2026-06-24T11:00:54.300076Z","end":"2026-06-24T11:00:56.944044Z","steps":["trace[13067593] 'process raft request' (duration: 2.626125053s)","trace[13067593] 'compare' (duration: 11.711073ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:56.944591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.21453233s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T11:00:56.944675Z","caller":"traceutil/trace.go:171","msg":"trace[1747723613] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"1.214650374s","start":"2026-06-24T11:00:55.729995Z","end":"2026-06-24T11:00:56.944646Z","steps":["trace[1747723613] 'agreement among raft nodes before linearized reading' (duration: 1.214138914s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:56.944721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:55.729977Z","time spent":"1.214732348s","remote":"127.0.0.1:40338","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-24T11:00:56.944784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.282072947s","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-24T11:00:56.944875Z","caller":"traceutil/trace.go:171","msg":"trace[1726741620] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:638; }","duration":"1.282168361s","start":"2026-06-24T11:00:55.662654Z","end":"2026-06-24T11:00:56.944822Z","steps":["trace[1726741620] 'agreement among raft nodes before linearized reading' (duration: 1.281465334s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:56.944912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:55.662643Z","time spent":"1.282259524s","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T11:00:56.944401Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:54.300053Z","time spent":"2.644190767s","remote":"127.0.0.1:40156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036281,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:56.945379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.282124199s","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-24T11:00:56.945508Z","caller":"traceutil/trace.go:171","msg":"trace[116646226] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:638; }","duration":"1.282272065s","start":"2026-06-24T11:00:55.663196Z","end":"2026-06-24T11:00:56.945468Z","steps":["trace[116646226] 'agreement among raft nodes before linearized reading' (duration: 1.281844969s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:56.945605Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:55.663188Z","time spent":"1.28240058s","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-24T11:00:56.945709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.283020173s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:00:56.946638Z","caller":"traceutil/trace.go:171","msg":"trace[1940649984] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"1.283993059s","start":"2026-06-24T11:00:55.662629Z","end":"2026-06-24T11:00:56.946622Z","steps":["trace[1940649984] 'agreement among raft nodes before linearized reading' (duration: 1.282434361s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:56.946686Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:55.66261Z","time spent":"1.284060082s","remote":"127.0.0.1:40338","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-24T11:00:56.947051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.353755312s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9xgll\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-24T11:00:56.94713Z","caller":"traceutil/trace.go:171","msg":"trace[1445389034] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9xgll; range_end:; response_count:1; response_revision:638; }","duration":"2.353869866s","start":"2026-06-24T11:00:54.593228Z","end":"2026-06-24T11:00:56.947098Z","steps":["trace[1445389034] 'agreement among raft nodes before linearized reading' (duration: 2.350640843s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:56.947889Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:54.593205Z","time spent":"2.354647405s","remote":"127.0.0.1:40258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16983,"request content":"key:\"/registry/pods/kube-system/cilium-9xgll\" "} {"level":"warn","ts":"2026-06-24T11:00:57.532184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.251231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:00:57.532863Z","caller":"traceutil/trace.go:171","msg":"trace[1535645899] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"580.786067ms","start":"2026-06-24T11:00:56.952061Z","end":"2026-06-24T11:00:57.532847Z","steps":["trace[1535645899] 'process raft request' (duration: 580.245406ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:57.532842Z","caller":"traceutil/trace.go:171","msg":"trace[662257625] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"580.62929ms","start":"2026-06-24T11:00:56.952146Z","end":"2026-06-24T11:00:57.532775Z","steps":["trace[662257625] 'process raft request' (duration: 580.236524ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:57.53291Z","caller":"traceutil/trace.go:171","msg":"trace[955224931] transaction","detail":"{read_only:false; response_revision:642; number_of_response:1; }","duration":"573.703588ms","start":"2026-06-24T11:00:56.959196Z","end":"2026-06-24T11:00:57.5329Z","steps":["trace[955224931] 'process raft request' (duration: 573.234179ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:57.532914Z","caller":"traceutil/trace.go:171","msg":"trace[1931621730] transaction","detail":"{read_only:false; response_revision:639; number_of_response:1; }","duration":"581.14483ms","start":"2026-06-24T11:00:56.951722Z","end":"2026-06-24T11:00:57.532867Z","steps":["trace[1931621730] 'process raft request' (duration: 199.170951ms)","trace[1931621730] 'compare' (duration: 381.033882ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:57.532981Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:56.952025Z","time spent":"580.88608ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:57.532986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:56.95212Z","time spent":"580.802017ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:57.533078Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:56.951695Z","time spent":"581.304886ms","remote":"127.0.0.1:40128","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":759,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T11:00:57.533189Z","caller":"traceutil/trace.go:171","msg":"trace[1473385755] transaction","detail":"{read_only:false; response_revision:644; number_of_response:1; }","duration":"555.737828ms","start":"2026-06-24T11:00:56.977439Z","end":"2026-06-24T11:00:57.533177Z","steps":["trace[1473385755] 'process raft request' (duration: 555.137776ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:00:57.533197Z","caller":"traceutil/trace.go:171","msg":"trace[107735718] transaction","detail":"{read_only:false; response_revision:645; number_of_response:1; }","duration":"527.670475ms","start":"2026-06-24T11:00:57.005472Z","end":"2026-06-24T11:00:57.533142Z","steps":["trace[107735718] 'process raft request' (duration: 527.250729ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:57.533247Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:56.977419Z","time spent":"555.801451ms","remote":"127.0.0.1:40258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:57.532838Z","caller":"traceutil/trace.go:171","msg":"trace[1367274303] transaction","detail":"{read_only:false; response_revision:646; number_of_response:1; }","duration":"524.841278ms","start":"2026-06-24T11:00:57.007972Z","end":"2026-06-24T11:00:57.532814Z","steps":["trace[1367274303] 'process raft request' (duration: 524.794396ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:57.532999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:56.959169Z","time spent":"573.778481ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:57.533316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.531229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T11:00:57.533325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:57.005422Z","time spent":"527.845272ms","remote":"127.0.0.1:40578","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T11:00:57.533264Z","caller":"traceutil/trace.go:171","msg":"trace[907517056] linearizableReadLoop","detail":"{readStateIndex:669; appliedIndex:665; }","duration":"574.280429ms","start":"2026-06-24T11:00:56.958972Z","end":"2026-06-24T11:00:57.533252Z","steps":["trace[907517056] 'read index received' (duration: 47.622973ms)","trace[907517056] 'applied index is now lower than readState.Index' (duration: 526.656416ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:57.533357Z","caller":"traceutil/trace.go:171","msg":"trace[519793923] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:646; }","duration":"574.604482ms","start":"2026-06-24T11:00:56.958742Z","end":"2026-06-24T11:00:57.533347Z","steps":["trace[519793923] 'agreement among raft nodes before linearized reading' (duration: 574.5445ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:57.533397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:56.958727Z","time spent":"574.661344ms","remote":"127.0.0.1:40052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T11:00:57.533433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:57.007943Z","time spent":"525.398199ms","remote":"127.0.0.1:40086","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:57.533043Z","caller":"traceutil/trace.go:171","msg":"trace[894283785] transaction","detail":"{read_only:false; response_revision:643; number_of_response:1; }","duration":"571.049507ms","start":"2026-06-24T11:00:56.961985Z","end":"2026-06-24T11:00:57.533034Z","steps":["trace[894283785] 'process raft request' (duration: 570.475404ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:57.533587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:56.961956Z","time spent":"571.598639ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:57.665862Z","caller":"traceutil/trace.go:171","msg":"trace[211568433] linearizableReadLoop","detail":"{readStateIndex:675; appliedIndex:674; }","duration":"128.152748ms","start":"2026-06-24T11:00:57.537687Z","end":"2026-06-24T11:00:57.66584Z","steps":["trace[211568433] 'read index received' (duration: 120.981495ms)","trace[211568433] 'applied index is now lower than readState.Index' (duration: 7.170033ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:57.665928Z","caller":"traceutil/trace.go:171","msg":"trace[130727475] transaction","detail":"{read_only:false; response_revision:647; number_of_response:1; }","duration":"352.92394ms","start":"2026-06-24T11:00:57.312968Z","end":"2026-06-24T11:00:57.665891Z","steps":["trace[130727475] 'process raft request' (duration: 345.649713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:57.666074Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:57.312943Z","time spent":"353.047934ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:00:57.666139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.403897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-06-24T11:00:57.666185Z","caller":"traceutil/trace.go:171","msg":"trace[415452079] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:647; }","duration":"128.529672ms","start":"2026-06-24T11:00:57.537644Z","end":"2026-06-24T11:00:57.666174Z","steps":["trace[415452079] 'agreement among raft nodes before linearized reading' (duration: 128.369506ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:57.666784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.111398ms","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-24T11:00:57.666973Z","caller":"traceutil/trace.go:171","msg":"trace[558482731] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:647; }","duration":"121.335887ms","start":"2026-06-24T11:00:57.545618Z","end":"2026-06-24T11:00:57.666954Z","steps":["trace[558482731] 'agreement among raft nodes before linearized reading' (duration: 121.102188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:57.666806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.006026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9xgll\" ","response":"range_response_count:1 size:17145"} {"level":"info","ts":"2026-06-24T11:00:57.667321Z","caller":"traceutil/trace.go:171","msg":"trace[581552135] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9xgll; range_end:; response_count:1; response_revision:647; }","duration":"126.547537ms","start":"2026-06-24T11:00:57.540761Z","end":"2026-06-24T11:00:57.667308Z","steps":["trace[581552135] 'agreement among raft nodes before linearized reading' (duration: 125.939613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:59.131699Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.012783623s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T11:00:59.132783Z","caller":"traceutil/trace.go:171","msg":"trace[1085014411] linearizableReadLoop","detail":"{readStateIndex:676; appliedIndex:675; }","duration":"198.930708ms","start":"2026-06-24T11:00:58.933824Z","end":"2026-06-24T11:00:59.132755Z","steps":["trace[1085014411] 'read index received' (duration: 198.167897ms)","trace[1085014411] 'applied index is now lower than readState.Index' (duration: 761.611µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:00:59.132819Z","caller":"traceutil/trace.go:171","msg":"trace[1577969528] transaction","detail":"{read_only:false; response_revision:648; number_of_response:1; }","duration":"1.063658239s","start":"2026-06-24T11:00:58.069147Z","end":"2026-06-24T11:00:59.132805Z","steps":["trace[1577969528] 'process raft request' (duration: 1.063053365s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:59.132894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.052432ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:59.132919Z","caller":"traceutil/trace.go:171","msg":"trace[1283281462] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:648; }","duration":"199.092494ms","start":"2026-06-24T11:00:58.93382Z","end":"2026-06-24T11:00:59.132912Z","steps":["trace[1283281462] 'agreement among raft nodes before linearized reading' (duration: 199.031231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:00:59.13296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:00:58.069116Z","time spent":"1.063758712s","remote":"127.0.0.1:40156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:00:59.240531Z","caller":"traceutil/trace.go:171","msg":"trace[1618045578] linearizableReadLoop","detail":"{readStateIndex:677; appliedIndex:676; }","duration":"106.563143ms","start":"2026-06-24T11:00:59.133944Z","end":"2026-06-24T11:00:59.240508Z","steps":["trace[1618045578] 'read index received' (duration: 66.758913ms)","trace[1618045578] 'applied index is now lower than readState.Index' (duration: 39.79774ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:00:59.240679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.720449ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:00:59.240716Z","caller":"traceutil/trace.go:171","msg":"trace[662702493] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:649; }","duration":"106.800422ms","start":"2026-06-24T11:00:59.133903Z","end":"2026-06-24T11:00:59.240704Z","steps":["trace[662702493] 'agreement among raft nodes before linearized reading' (duration: 106.684897ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:01.016171Z","caller":"traceutil/trace.go:171","msg":"trace[36545426] transaction","detail":"{read_only:false; response_revision:690; number_of_response:1; }","duration":"250.899749ms","start":"2026-06-24T11:01:00.76524Z","end":"2026-06-24T11:01:01.01614Z","steps":["trace[36545426] 'process raft request' (duration: 250.734332ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:01.894768Z","caller":"traceutil/trace.go:171","msg":"trace[479568396] linearizableReadLoop","detail":"{readStateIndex:730; appliedIndex:727; }","duration":"130.172597ms","start":"2026-06-24T11:01:01.764578Z","end":"2026-06-24T11:01:01.89475Z","steps":["trace[479568396] 'read index received' (duration: 99.67182ms)","trace[479568396] 'applied index is now lower than readState.Index' (duration: 30.500027ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:01.894793Z","caller":"traceutil/trace.go:171","msg":"trace[670252521] transaction","detail":"{read_only:false; response_revision:700; number_of_response:1; }","duration":"253.853179ms","start":"2026-06-24T11:01:01.640915Z","end":"2026-06-24T11:01:01.894768Z","steps":["trace[670252521] 'process raft request' (duration: 253.752655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:01.894862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.276451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:01:01.894928Z","caller":"traceutil/trace.go:171","msg":"trace[1642081931] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:701; }","duration":"130.385205ms","start":"2026-06-24T11:01:01.76453Z","end":"2026-06-24T11:01:01.894915Z","steps":["trace[1642081931] 'agreement among raft nodes before linearized reading' (duration: 130.292032ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:01.894946Z","caller":"traceutil/trace.go:171","msg":"trace[1357410506] transaction","detail":"{read_only:false; response_revision:699; number_of_response:1; }","duration":"254.511064ms","start":"2026-06-24T11:01:01.640415Z","end":"2026-06-24T11:01:01.894926Z","steps":["trace[1357410506] 'process raft request' (duration: 223.914833ms)","trace[1357410506] 'compare' (duration: 30.247397ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:01.895141Z","caller":"traceutil/trace.go:171","msg":"trace[1381932839] transaction","detail":"{read_only:false; response_revision:701; number_of_response:1; }","duration":"238.503426ms","start":"2026-06-24T11:01:01.656571Z","end":"2026-06-24T11:01:01.895074Z","steps":["trace[1381932839] 'process raft request' (duration: 238.140671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:08.688531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.217943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-9xgll\" ","response":"range_response_count:1 size:18709"} {"level":"info","ts":"2026-06-24T11:01:08.688815Z","caller":"traceutil/trace.go:171","msg":"trace[298203277] range","detail":"{range_begin:/registry/pods/kube-system/cilium-9xgll; range_end:; response_count:1; response_revision:760; }","duration":"127.506434ms","start":"2026-06-24T11:01:08.561229Z","end":"2026-06-24T11:01:08.688736Z","steps":["trace[298203277] 'range keys from in-memory index tree' (duration: 127.086198ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:08.951297Z","caller":"traceutil/trace.go:171","msg":"trace[339471401] transaction","detail":"{read_only:false; response_revision:762; number_of_response:1; }","duration":"247.285321ms","start":"2026-06-24T11:01:08.703981Z","end":"2026-06-24T11:01:08.951267Z","steps":["trace[339471401] 'process raft request' (duration: 240.652479ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:11.885565Z","caller":"traceutil/trace.go:171","msg":"trace[708812239] transaction","detail":"{read_only:false; response_revision:788; number_of_response:1; }","duration":"151.009042ms","start":"2026-06-24T11:01:11.734522Z","end":"2026-06-24T11:01:11.885531Z","steps":["trace[708812239] 'process raft request' (duration: 134.086337ms)","trace[708812239] 'compare' (duration: 16.745427ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:11.885763Z","caller":"traceutil/trace.go:171","msg":"trace[562733283] transaction","detail":"{read_only:false; response_revision:789; number_of_response:1; }","duration":"148.399522ms","start":"2026-06-24T11:01:11.737342Z","end":"2026-06-24T11:01:11.885742Z","steps":["trace[562733283] 'process raft request' (duration: 148.135671ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:11.88571Z","caller":"traceutil/trace.go:171","msg":"trace[1830560546] linearizableReadLoop","detail":"{readStateIndex:821; appliedIndex:819; }","duration":"109.724902ms","start":"2026-06-24T11:01:11.775954Z","end":"2026-06-24T11:01:11.885679Z","steps":["trace[1830560546] 'read index received' (duration: 92.596468ms)","trace[1830560546] 'applied index is now lower than readState.Index' (duration: 17.126554ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:11.886668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.688041ms","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-24T11:01:11.887055Z","caller":"traceutil/trace.go:171","msg":"trace[1065515699] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:789; }","duration":"110.855608ms","start":"2026-06-24T11:01:11.775901Z","end":"2026-06-24T11:01:11.886757Z","steps":["trace[1065515699] 'agreement among raft nodes before linearized reading' (duration: 109.971972ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:17.153436Z","caller":"traceutil/trace.go:171","msg":"trace[1921274500] linearizableReadLoop","detail":"{readStateIndex:851; appliedIndex:850; }","duration":"217.693675ms","start":"2026-06-24T11:01:16.93572Z","end":"2026-06-24T11:01:17.153413Z","steps":["trace[1921274500] 'read index received' (duration: 217.499327ms)","trace[1921274500] 'applied index is now lower than readState.Index' (duration: 193.498µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:17.153541Z","caller":"traceutil/trace.go:171","msg":"trace[1848249796] transaction","detail":"{read_only:false; response_revision:817; number_of_response:1; }","duration":"442.345847ms","start":"2026-06-24T11:01:16.711179Z","end":"2026-06-24T11:01:17.153525Z","steps":["trace[1848249796] 'process raft request' (duration: 442.094956ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:17.153602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.871052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:01:17.153637Z","caller":"traceutil/trace.go:171","msg":"trace[2074953953] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:817; }","duration":"217.940836ms","start":"2026-06-24T11:01:16.935686Z","end":"2026-06-24T11:01:17.153627Z","steps":["trace[2074953953] 'agreement among raft nodes before linearized reading' (duration: 217.839042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:17.153642Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:01:16.711167Z","time spent":"442.41098ms","remote":"127.0.0.1:40258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:01:17.153792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.137232ms","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-24T11:01:17.153854Z","caller":"traceutil/trace.go:171","msg":"trace[366653378] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:817; }","duration":"217.217886ms","start":"2026-06-24T11:01:16.936622Z","end":"2026-06-24T11:01:17.15384Z","steps":["trace[366653378] 'agreement among raft nodes before linearized reading' (duration: 217.018927ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:30.098213Z","caller":"traceutil/trace.go:171","msg":"trace[1444048863] transaction","detail":"{read_only:false; response_revision:969; number_of_response:1; }","duration":"112.709428ms","start":"2026-06-24T11:01:29.985481Z","end":"2026-06-24T11:01:30.098191Z","steps":["trace[1444048863] 'process raft request' (duration: 112.52297ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:30.225846Z","caller":"traceutil/trace.go:171","msg":"trace[407939686] transaction","detail":"{read_only:false; response_revision:970; number_of_response:1; }","duration":"121.746431ms","start":"2026-06-24T11:01:30.104059Z","end":"2026-06-24T11:01:30.225805Z","steps":["trace[407939686] 'process raft request' (duration: 39.467309ms)","trace[407939686] 'compare' (duration: 82.107325ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:30.268829Z","caller":"traceutil/trace.go:171","msg":"trace[645211826] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"164.522511ms","start":"2026-06-24T11:01:30.104283Z","end":"2026-06-24T11:01:30.268805Z","steps":["trace[645211826] 'process raft request' (duration: 164.26287ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:30.268828Z","caller":"traceutil/trace.go:171","msg":"trace[2044170112] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"163.786917ms","start":"2026-06-24T11:01:30.105016Z","end":"2026-06-24T11:01:30.268803Z","steps":["trace[2044170112] 'process raft request' (duration: 163.717054ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:31.402977Z","caller":"traceutil/trace.go:171","msg":"trace[309095590] transaction","detail":"{read_only:false; response_revision:973; number_of_response:1; }","duration":"102.58491ms","start":"2026-06-24T11:01:31.300364Z","end":"2026-06-24T11:01:31.402949Z","steps":["trace[309095590] 'process raft request' (duration: 102.414442ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:31.57689Z","caller":"traceutil/trace.go:171","msg":"trace[1877061964] linearizableReadLoop","detail":"{readStateIndex:1011; appliedIndex:1010; }","duration":"169.237183ms","start":"2026-06-24T11:01:31.407629Z","end":"2026-06-24T11:01:31.576866Z","steps":["trace[1877061964] 'read index received' (duration: 169.087097ms)","trace[1877061964] 'applied index is now lower than readState.Index' (duration: 149.156µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:31.576922Z","caller":"traceutil/trace.go:171","msg":"trace[857204430] transaction","detail":"{read_only:false; response_revision:974; number_of_response:1; }","duration":"169.847132ms","start":"2026-06-24T11:01:31.407051Z","end":"2026-06-24T11:01:31.576898Z","steps":["trace[857204430] 'process raft request' (duration: 169.690425ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:31.577102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.455563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/coredns-7c96b6546b-gbfvj\" ","response":"range_response_count:1 size:4880"} {"level":"info","ts":"2026-06-24T11:01:31.577144Z","caller":"traceutil/trace.go:171","msg":"trace[820895628] range","detail":"{range_begin:/registry/pods/kube-system/coredns-7c96b6546b-gbfvj; range_end:; response_count:1; response_revision:974; }","duration":"169.544097ms","start":"2026-06-24T11:01:31.407589Z","end":"2026-06-24T11:01:31.577134Z","steps":["trace[820895628] 'agreement among raft nodes before linearized reading' (duration: 169.36896ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:31.620776Z","caller":"traceutil/trace.go:171","msg":"trace[1363142296] transaction","detail":"{read_only:false; response_revision:975; number_of_response:1; }","duration":"211.31859ms","start":"2026-06-24T11:01:31.409432Z","end":"2026-06-24T11:01:31.620751Z","steps":["trace[1363142296] 'process raft request' (duration: 211.069439ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:31.62086Z","caller":"traceutil/trace.go:171","msg":"trace[1933262874] transaction","detail":"{read_only:false; response_revision:977; number_of_response:1; }","duration":"210.828497ms","start":"2026-06-24T11:01:31.410014Z","end":"2026-06-24T11:01:31.620843Z","steps":["trace[1933262874] 'process raft request' (duration: 210.714442ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:31.62115Z","caller":"traceutil/trace.go:171","msg":"trace[567079728] transaction","detail":"{read_only:false; response_revision:978; number_of_response:1; }","duration":"208.664229ms","start":"2026-06-24T11:01:31.412458Z","end":"2026-06-24T11:01:31.621122Z","steps":["trace[567079728] 'process raft request' (duration: 208.317573ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:31.621591Z","caller":"traceutil/trace.go:171","msg":"trace[455325838] transaction","detail":"{read_only:false; number_of_response:1; response_revision:976; }","duration":"211.884885ms","start":"2026-06-24T11:01:31.409685Z","end":"2026-06-24T11:01:31.62157Z","steps":["trace[455325838] 'process raft request' (duration: 210.973564ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:31.691551Z","caller":"traceutil/trace.go:171","msg":"trace[1292172846] transaction","detail":"{read_only:false; response_revision:979; number_of_response:1; }","duration":"104.97606ms","start":"2026-06-24T11:01:31.586551Z","end":"2026-06-24T11:01:31.691527Z","steps":["trace[1292172846] 'process raft request' (duration: 72.555993ms)","trace[1292172846] 'compare' (duration: 32.257119ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:32.01337Z","caller":"traceutil/trace.go:171","msg":"trace[1219128476] linearizableReadLoop","detail":"{readStateIndex:1019; appliedIndex:1018; }","duration":"206.902259ms","start":"2026-06-24T11:01:31.806444Z","end":"2026-06-24T11:01:32.013346Z","steps":["trace[1219128476] 'read index received' (duration: 206.741932ms)","trace[1219128476] 'applied index is now lower than readState.Index' (duration: 159.297µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:32.013589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.584041ms","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-24T11:01:32.013576Z","caller":"traceutil/trace.go:171","msg":"trace[162299680] transaction","detail":"{read_only:false; response_revision:982; number_of_response:1; }","duration":"233.462709ms","start":"2026-06-24T11:01:31.780092Z","end":"2026-06-24T11:01:32.013554Z","steps":["trace[162299680] 'process raft request' (duration: 233.088532ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:32.013623Z","caller":"traceutil/trace.go:171","msg":"trace[1817961072] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:982; }","duration":"198.666785ms","start":"2026-06-24T11:01:31.814945Z","end":"2026-06-24T11:01:32.013611Z","steps":["trace[1817961072] 'agreement among raft nodes before linearized reading' (duration: 198.529109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:32.01361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.116169ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T11:01:32.013703Z","caller":"traceutil/trace.go:171","msg":"trace[200639767] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:982; }","duration":"207.296717ms","start":"2026-06-24T11:01:31.806381Z","end":"2026-06-24T11:01:32.013677Z","steps":["trace[200639767] 'agreement among raft nodes before linearized reading' (duration: 207.102058ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:34.353553Z","caller":"traceutil/trace.go:171","msg":"trace[136416663] linearizableReadLoop","detail":"{readStateIndex:1030; appliedIndex:1028; }","duration":"128.138084ms","start":"2026-06-24T11:01:34.225398Z","end":"2026-06-24T11:01:34.353536Z","steps":["trace[136416663] 'read index received' (duration: 128.026749ms)","trace[136416663] 'applied index is now lower than readState.Index' (duration: 110.725µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:34.353594Z","caller":"traceutil/trace.go:171","msg":"trace[645076424] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"204.937507ms","start":"2026-06-24T11:01:34.148641Z","end":"2026-06-24T11:01:34.353579Z","steps":["trace[645076424] 'process raft request' (duration: 204.865814ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:34.353656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.239368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-06-24T11:01:34.353619Z","caller":"traceutil/trace.go:171","msg":"trace[10132485] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"211.514109ms","start":"2026-06-24T11:01:34.142079Z","end":"2026-06-24T11:01:34.353593Z","steps":["trace[10132485] 'process raft request' (duration: 211.32979ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:34.353676Z","caller":"traceutil/trace.go:171","msg":"trace[1702431201] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:992; }","duration":"128.300592ms","start":"2026-06-24T11:01:34.225367Z","end":"2026-06-24T11:01:34.353668Z","steps":["trace[1702431201] 'agreement among raft nodes before linearized reading' (duration: 128.241659ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:36.534791Z","caller":"traceutil/trace.go:171","msg":"trace[70623004] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"111.922203ms","start":"2026-06-24T11:01:36.422845Z","end":"2026-06-24T11:01:36.534768Z","steps":["trace[70623004] 'process raft request' (duration: 111.85841ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:36.535027Z","caller":"traceutil/trace.go:171","msg":"trace[835557778] transaction","detail":"{read_only:false; response_revision:1001; number_of_response:1; }","duration":"113.339289ms","start":"2026-06-24T11:01:36.421659Z","end":"2026-06-24T11:01:36.534998Z","steps":["trace[835557778] 'process raft request' (duration: 51.580239ms)","trace[835557778] 'compare' (duration: 61.192144ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:36.535266Z","caller":"traceutil/trace.go:171","msg":"trace[1727926988] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"113.067306ms","start":"2026-06-24T11:01:36.422069Z","end":"2026-06-24T11:01:36.535136Z","steps":["trace[1727926988] 'process raft request' (duration: 112.591384ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:37.908378Z","caller":"traceutil/trace.go:171","msg":"trace[2007830957] transaction","detail":"{read_only:false; response_revision:1007; number_of_response:1; }","duration":"110.091564ms","start":"2026-06-24T11:01:37.798263Z","end":"2026-06-24T11:01:37.908354Z","steps":["trace[2007830957] 'process raft request' (duration: 109.933087ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:37.980652Z","caller":"traceutil/trace.go:171","msg":"trace[1152844508] transaction","detail":"{read_only:false; response_revision:1008; number_of_response:1; }","duration":"180.853842ms","start":"2026-06-24T11:01:37.799777Z","end":"2026-06-24T11:01:37.980631Z","steps":["trace[1152844508] 'process raft request' (duration: 175.246662ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:38.129679Z","caller":"traceutil/trace.go:171","msg":"trace[1207429730] transaction","detail":"{read_only:false; response_revision:1009; number_of_response:1; }","duration":"140.868383ms","start":"2026-06-24T11:01:37.988783Z","end":"2026-06-24T11:01:38.129652Z","steps":["trace[1207429730] 'process raft request' (duration: 104.144882ms)","trace[1207429730] 'compare' (duration: 36.594155ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:38.301247Z","caller":"traceutil/trace.go:171","msg":"trace[335970086] transaction","detail":"{read_only:false; response_revision:1010; number_of_response:1; }","duration":"164.727546ms","start":"2026-06-24T11:01:38.136495Z","end":"2026-06-24T11:01:38.301222Z","steps":["trace[335970086] 'process raft request' (duration: 108.292306ms)","trace[335970086] 'compare' (duration: 56.311734ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:38.756748Z","caller":"traceutil/trace.go:171","msg":"trace[234436115] linearizableReadLoop","detail":"{readStateIndex:1052; appliedIndex:1051; }","duration":"217.139471ms","start":"2026-06-24T11:01:38.539582Z","end":"2026-06-24T11:01:38.756721Z","steps":["trace[234436115] 'read index received' (duration: 52.284287ms)","trace[234436115] 'applied index is now lower than readState.Index' (duration: 164.854004ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:38.756812Z","caller":"traceutil/trace.go:171","msg":"trace[1721761100] transaction","detail":"{read_only:false; response_revision:1014; number_of_response:1; }","duration":"243.397734ms","start":"2026-06-24T11:01:38.51339Z","end":"2026-06-24T11:01:38.756788Z","steps":["trace[1721761100] 'process raft request' (duration: 168.88348ms)","trace[1721761100] 'compare' (duration: 74.317585ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:01:38.757025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.425004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-24T11:01:38.757059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.421583ms","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-24T11:01:38.757108Z","caller":"traceutil/trace.go:171","msg":"trace[43888084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1014; }","duration":"217.55612ms","start":"2026-06-24T11:01:38.539534Z","end":"2026-06-24T11:01:38.75709Z","steps":["trace[43888084] 'agreement among raft nodes before linearized reading' (duration: 217.33686ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:38.757114Z","caller":"traceutil/trace.go:171","msg":"trace[1361198485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1014; }","duration":"217.534258ms","start":"2026-06-24T11:01:38.539565Z","end":"2026-06-24T11:01:38.757099Z","steps":["trace[1361198485] 'agreement among raft nodes before linearized reading' (duration: 217.340229ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:38.99511Z","caller":"traceutil/trace.go:171","msg":"trace[543306757] transaction","detail":"{read_only:false; response_revision:1016; number_of_response:1; }","duration":"233.964135ms","start":"2026-06-24T11:01:38.761101Z","end":"2026-06-24T11:01:38.995066Z","steps":["trace[543306757] 'process raft request' (duration: 233.157398ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:01:40.711697Z","caller":"traceutil/trace.go:171","msg":"trace[1039596248] transaction","detail":"{read_only:false; response_revision:1019; number_of_response:1; }","duration":"112.449113ms","start":"2026-06-24T11:01:40.599194Z","end":"2026-06-24T11:01:40.711643Z","steps":["trace[1039596248] 'process raft request' (duration: 81.399307ms)","trace[1039596248] 'compare' (duration: 30.91734ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:01:43.021405Z","caller":"traceutil/trace.go:171","msg":"trace[792452332] transaction","detail":"{read_only:false; response_revision:1027; number_of_response:1; }","duration":"158.783222ms","start":"2026-06-24T11:01:42.862589Z","end":"2026-06-24T11:01:43.021373Z","steps":["trace[792452332] 'process raft request' (duration: 154.133913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:01:56.986174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.50538ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-06-24T11:01:56.986258Z","caller":"traceutil/trace.go:171","msg":"trace[886073247] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1075; }","duration":"133.628666ms","start":"2026-06-24T11:01:56.852611Z","end":"2026-06-24T11:01:56.986239Z","steps":["trace[886073247] 'range keys from in-memory index tree' (duration: 133.319222ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:09.186022Z","caller":"traceutil/trace.go:171","msg":"trace[1401946911] transaction","detail":"{read_only:false; response_revision:1116; number_of_response:1; }","duration":"197.58859ms","start":"2026-06-24T11:02:08.98841Z","end":"2026-06-24T11:02:09.185999Z","steps":["trace[1401946911] 'process raft request' (duration: 197.39339ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:09.185949Z","caller":"traceutil/trace.go:171","msg":"trace[955781733] linearizableReadLoop","detail":"{readStateIndex:1160; appliedIndex:1159; }","duration":"135.114614ms","start":"2026-06-24T11:02:09.050816Z","end":"2026-06-24T11:02:09.185931Z","steps":["trace[955781733] 'read index received' (duration: 134.924024ms)","trace[955781733] 'applied index is now lower than readState.Index' (duration: 189.8µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:02:09.186321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.483562ms","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-24T11:02:09.186404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.425475ms","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-24T11:02:09.186404Z","caller":"traceutil/trace.go:171","msg":"trace[964759494] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1116; }","duration":"135.616139ms","start":"2026-06-24T11:02:09.050767Z","end":"2026-06-24T11:02:09.186383Z","steps":["trace[964759494] 'agreement among raft nodes before linearized reading' (duration: 135.370397ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:09.186442Z","caller":"traceutil/trace.go:171","msg":"trace[801122299] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1116; }","duration":"108.52172ms","start":"2026-06-24T11:02:09.077909Z","end":"2026-06-24T11:02:09.186431Z","steps":["trace[801122299] 'agreement among raft nodes before linearized reading' (duration: 108.398243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:09.404037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.717223ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-24T11:02:10.888159Z","caller":"traceutil/trace.go:171","msg":"trace[380262190] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"111.405954ms","start":"2026-06-24T11:02:10.776734Z","end":"2026-06-24T11:02:10.88814Z","steps":["trace[380262190] 'process raft request' (duration: 111.254856ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:11.448468Z","caller":"traceutil/trace.go:171","msg":"trace[1254586983] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"163.11789ms","start":"2026-06-24T11:02:11.285331Z","end":"2026-06-24T11:02:11.448448Z","steps":["trace[1254586983] 'process raft request' (duration: 78.511576ms)","trace[1254586983] 'compare' (duration: 84.14283ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:11.448482Z","caller":"traceutil/trace.go:171","msg":"trace[1185493324] transaction","detail":"{read_only:false; response_revision:1125; number_of_response:1; }","duration":"162.771273ms","start":"2026-06-24T11:02:11.285687Z","end":"2026-06-24T11:02:11.448458Z","steps":["trace[1185493324] 'process raft request' (duration: 162.470427ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:13.02028Z","caller":"traceutil/trace.go:171","msg":"trace[1993072611] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"127.612023ms","start":"2026-06-24T11:02:12.892634Z","end":"2026-06-24T11:02:13.020246Z","steps":["trace[1993072611] 'process raft request' (duration: 127.37081ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:14.222362Z","caller":"traceutil/trace.go:171","msg":"trace[75026945] linearizableReadLoop","detail":"{readStateIndex:1180; appliedIndex:1179; }","duration":"159.514128ms","start":"2026-06-24T11:02:14.062822Z","end":"2026-06-24T11:02:14.222336Z","steps":["trace[75026945] 'read index received' (duration: 131.734481ms)","trace[75026945] 'applied index is now lower than readState.Index' (duration: 27.778407ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:02:14.222709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.864077ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"warn","ts":"2026-06-24T11:02:14.222781Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.145846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:02:14.222771Z","caller":"traceutil/trace.go:171","msg":"trace[481638331] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:1134; }","duration":"159.94846ms","start":"2026-06-24T11:02:14.062807Z","end":"2026-06-24T11:02:14.222755Z","steps":["trace[481638331] 'agreement among raft nodes before linearized reading' (duration: 159.799593ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:14.222763Z","caller":"traceutil/trace.go:171","msg":"trace[1401234193] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"160.661008ms","start":"2026-06-24T11:02:14.062062Z","end":"2026-06-24T11:02:14.222723Z","steps":["trace[1401234193] 'process raft request' (duration: 132.552814ms)","trace[1401234193] 'compare' (duration: 27.590958ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:14.222821Z","caller":"traceutil/trace.go:171","msg":"trace[1034611678] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1134; }","duration":"105.195638ms","start":"2026-06-24T11:02:14.117614Z","end":"2026-06-24T11:02:14.22281Z","steps":["trace[1034611678] 'agreement among raft nodes before linearized reading' (duration: 105.127465ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:15.79827Z","caller":"traceutil/trace.go:171","msg":"trace[1733038802] linearizableReadLoop","detail":"{readStateIndex:1185; appliedIndex:1184; }","duration":"145.68627ms","start":"2026-06-24T11:02:15.65255Z","end":"2026-06-24T11:02:15.798236Z","steps":["trace[1733038802] 'read index received' (duration: 129.734001ms)","trace[1733038802] 'applied index is now lower than readState.Index' (duration: 15.950029ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:15.798531Z","caller":"traceutil/trace.go:171","msg":"trace[601296700] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"205.315065ms","start":"2026-06-24T11:02:15.593174Z","end":"2026-06-24T11:02:15.798489Z","steps":["trace[601296700] 'process raft request' (duration: 189.078982ms)","trace[601296700] 'compare' (duration: 15.684815ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:02:15.799032Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.466879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:02:15.799102Z","caller":"traceutil/trace.go:171","msg":"trace[1258523837] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1139; }","duration":"146.610158ms","start":"2026-06-24T11:02:15.652471Z","end":"2026-06-24T11:02:15.799082Z","steps":["trace[1258523837] 'agreement among raft nodes before linearized reading' (duration: 145.897191ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:17.987182Z","caller":"traceutil/trace.go:171","msg":"trace[1635657888] linearizableReadLoop","detail":"{readStateIndex:1191; appliedIndex:1190; }","duration":"166.797529ms","start":"2026-06-24T11:02:17.820356Z","end":"2026-06-24T11:02:17.987154Z","steps":["trace[1635657888] 'read index received' (duration: 166.539285ms)","trace[1635657888] 'applied index is now lower than readState.Index' (duration: 256.584µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:17.987238Z","caller":"traceutil/trace.go:171","msg":"trace[130329639] transaction","detail":"{read_only:false; response_revision:1145; number_of_response:1; }","duration":"179.199909ms","start":"2026-06-24T11:02:17.808002Z","end":"2026-06-24T11:02:17.987202Z","steps":["trace[130329639] 'process raft request' (duration: 178.987488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:17.987393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.031321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:02:17.987435Z","caller":"traceutil/trace.go:171","msg":"trace[1483841067] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1145; }","duration":"167.121486ms","start":"2026-06-24T11:02:17.820304Z","end":"2026-06-24T11:02:17.987426Z","steps":["trace[1483841067] 'agreement among raft nodes before linearized reading' (duration: 166.987719ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:17.987435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.810152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T11:02:17.987528Z","caller":"traceutil/trace.go:171","msg":"trace[878077828] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:1145; }","duration":"124.944779ms","start":"2026-06-24T11:02:17.862568Z","end":"2026-06-24T11:02:17.987513Z","steps":["trace[878077828] 'agreement among raft nodes before linearized reading' (duration: 124.749779ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:18.369057Z","caller":"traceutil/trace.go:171","msg":"trace[650698000] transaction","detail":"{read_only:false; response_revision:1147; number_of_response:1; }","duration":"119.262159ms","start":"2026-06-24T11:02:18.249767Z","end":"2026-06-24T11:02:18.369029Z","steps":["trace[650698000] 'process raft request' (duration: 119.104691ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:19.586085Z","caller":"traceutil/trace.go:171","msg":"trace[806834668] transaction","detail":"{read_only:false; response_revision:1150; number_of_response:1; }","duration":"176.402735ms","start":"2026-06-24T11:02:19.409638Z","end":"2026-06-24T11:02:19.586041Z","steps":["trace[806834668] 'process raft request' (duration: 163.866755ms)","trace[806834668] 'compare' (duration: 12.288367ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:20.171041Z","caller":"traceutil/trace.go:171","msg":"trace[2039810590] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"138.053007ms","start":"2026-06-24T11:02:20.032944Z","end":"2026-06-24T11:02:20.170997Z","steps":["trace[2039810590] 'process raft request' (duration: 76.503521ms)","trace[2039810590] 'compare' (duration: 61.383818ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:21.332854Z","caller":"traceutil/trace.go:171","msg":"trace[2072120591] transaction","detail":"{read_only:false; response_revision:1155; number_of_response:1; }","duration":"108.220651ms","start":"2026-06-24T11:02:21.22461Z","end":"2026-06-24T11:02:21.332831Z","steps":["trace[2072120591] 'process raft request' (duration: 108.081954ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:21.641021Z","caller":"traceutil/trace.go:171","msg":"trace[1512693310] transaction","detail":"{read_only:false; response_revision:1156; number_of_response:1; }","duration":"111.215105ms","start":"2026-06-24T11:02:21.529531Z","end":"2026-06-24T11:02:21.640747Z","steps":["trace[1512693310] 'process raft request' (duration: 110.955481ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:22.394043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.533317ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T11:02:22.394235Z","caller":"traceutil/trace.go:171","msg":"trace[913438859] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"214.169822ms","start":"2026-06-24T11:02:22.18003Z","end":"2026-06-24T11:02:22.394199Z","steps":["trace[913438859] 'process raft request' (duration: 104.170251ms)","trace[913438859] 'compare' (duration: 108.842001ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:24.598167Z","caller":"traceutil/trace.go:171","msg":"trace[607739068] transaction","detail":"{read_only:false; response_revision:1167; number_of_response:1; }","duration":"103.880931ms","start":"2026-06-24T11:02:24.494254Z","end":"2026-06-24T11:02:24.598134Z","steps":["trace[607739068] 'process raft request' (duration: 48.98573ms)","trace[607739068] 'compare' (duration: 54.757234ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:25.730447Z","caller":"traceutil/trace.go:171","msg":"trace[1965827577] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"349.461103ms","start":"2026-06-24T11:02:25.380963Z","end":"2026-06-24T11:02:25.730425Z","steps":["trace[1965827577] 'process raft request' (duration: 349.295894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:25.731062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:02:25.380925Z","time spent":"349.591029ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:02:25.83569Z","caller":"traceutil/trace.go:171","msg":"trace[260624766] linearizableReadLoop","detail":"{readStateIndex:1217; appliedIndex:1215; }","duration":"117.11611ms","start":"2026-06-24T11:02:25.71853Z","end":"2026-06-24T11:02:25.835646Z","steps":["trace[260624766] 'read index received' (duration: 11.755326ms)","trace[260624766] 'applied index is now lower than readState.Index' (duration: 105.359024ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:25.835782Z","caller":"traceutil/trace.go:171","msg":"trace[1816674856] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"434.854158ms","start":"2026-06-24T11:02:25.400907Z","end":"2026-06-24T11:02:25.835761Z","steps":["trace[1816674856] 'process raft request' (duration: 406.018494ms)","trace[1816674856] 'compare' (duration: 28.55134ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:02:25.835913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:02:25.400882Z","time spent":"434.946264ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T11:02:25.835926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.389494ms","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-24T11:02:25.836099Z","caller":"traceutil/trace.go:171","msg":"trace[242571849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1169; }","duration":"117.599525ms","start":"2026-06-24T11:02:25.71848Z","end":"2026-06-24T11:02:25.836079Z","steps":["trace[242571849] 'agreement among raft nodes before linearized reading' (duration: 117.30761ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:25.986356Z","caller":"traceutil/trace.go:171","msg":"trace[1379891455] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"145.493782ms","start":"2026-06-24T11:02:25.840824Z","end":"2026-06-24T11:02:25.986318Z","steps":["trace[1379891455] 'process raft request' (duration: 107.624481ms)","trace[1379891455] 'compare' (duration: 37.761985ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:26.871096Z","caller":"traceutil/trace.go:171","msg":"trace[2059912148] transaction","detail":"{read_only:false; response_revision:1174; number_of_response:1; }","duration":"187.904007ms","start":"2026-06-24T11:02:26.682945Z","end":"2026-06-24T11:02:26.870849Z","steps":["trace[2059912148] 'process raft request' (duration: 187.736279ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:34.22984Z","caller":"traceutil/trace.go:171","msg":"trace[1884703983] transaction","detail":"{read_only:false; response_revision:1197; number_of_response:1; }","duration":"108.020835ms","start":"2026-06-24T11:02:34.121788Z","end":"2026-06-24T11:02:34.229809Z","steps":["trace[1884703983] 'process raft request' (duration: 107.801533ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:35.128951Z","caller":"traceutil/trace.go:171","msg":"trace[947556037] transaction","detail":"{read_only:false; response_revision:1200; number_of_response:1; }","duration":"143.431867ms","start":"2026-06-24T11:02:34.985494Z","end":"2026-06-24T11:02:35.128926Z","steps":["trace[947556037] 'process raft request' (duration: 143.198975ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:36.526145Z","caller":"traceutil/trace.go:171","msg":"trace[734795576] linearizableReadLoop","detail":"{readStateIndex:1253; appliedIndex:1252; }","duration":"291.634471ms","start":"2026-06-24T11:02:36.234492Z","end":"2026-06-24T11:02:36.526126Z","steps":["trace[734795576] 'read index received' (duration: 291.478573ms)","trace[734795576] 'applied index is now lower than readState.Index' (duration: 155.348µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T11:02:36.526236Z","caller":"traceutil/trace.go:171","msg":"trace[358887665] transaction","detail":"{read_only:false; response_revision:1203; number_of_response:1; }","duration":"417.147313ms","start":"2026-06-24T11:02:36.109059Z","end":"2026-06-24T11:02:36.526207Z","steps":["trace[358887665] 'process raft request' (duration: 416.951683ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:36.526337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.807411ms","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-24T11:02:36.526367Z","caller":"traceutil/trace.go:171","msg":"trace[1829913854] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1203; }","duration":"291.905635ms","start":"2026-06-24T11:02:36.234453Z","end":"2026-06-24T11:02:36.526359Z","steps":["trace[1829913854] 'agreement among raft nodes before linearized reading' (duration: 291.747557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:36.526383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T11:02:36.109014Z","time spent":"417.28392ms","remote":"127.0.0.1:40338","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T11:02:37.241017Z","caller":"traceutil/trace.go:171","msg":"trace[1060683932] transaction","detail":"{read_only:false; response_revision:1207; number_of_response:1; }","duration":"104.959984ms","start":"2026-06-24T11:02:37.136039Z","end":"2026-06-24T11:02:37.240999Z","steps":["trace[1060683932] 'process raft request' (duration: 104.581965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:02:39.410302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.399634ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-24T11:02:39.41105Z","caller":"traceutil/trace.go:171","msg":"trace[1107787025] transaction","detail":"{read_only:false; response_revision:1213; number_of_response:1; }","duration":"161.901239ms","start":"2026-06-24T11:02:39.249128Z","end":"2026-06-24T11:02:39.41103Z","steps":["trace[1107787025] 'process raft request' (duration: 161.281336ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:02:40.113603Z","caller":"traceutil/trace.go:171","msg":"trace[853663165] transaction","detail":"{read_only:false; response_revision:1214; number_of_response:1; }","duration":"139.490001ms","start":"2026-06-24T11:02:39.974088Z","end":"2026-06-24T11:02:40.113578Z","steps":["trace[853663165] 'process raft request' (duration: 139.335723ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:03:06.219222Z","caller":"traceutil/trace.go:171","msg":"trace[857501126] transaction","detail":"{read_only:false; response_revision:1329; number_of_response:1; }","duration":"109.010954ms","start":"2026-06-24T11:03:06.110184Z","end":"2026-06-24T11:03:06.219195Z","steps":["trace[857501126] 'process raft request' (duration: 108.877936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T11:03:17.116812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.982526ms","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-24T11:03:17.116903Z","caller":"traceutil/trace.go:171","msg":"trace[1992909712] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1376; }","duration":"105.158296ms","start":"2026-06-24T11:03:17.011727Z","end":"2026-06-24T11:03:17.116885Z","steps":["trace[1992909712] 'range keys from in-memory index tree' (duration: 104.812817ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:03:35.543917Z","caller":"traceutil/trace.go:171","msg":"trace[688805656] linearizableReadLoop","detail":"{readStateIndex:1504; appliedIndex:1503; }","duration":"195.41704ms","start":"2026-06-24T11:03:35.348482Z","end":"2026-06-24T11:03:35.543899Z","steps":["trace[688805656] 'read index received' (duration: 195.242504ms)","trace[688805656] 'applied index is now lower than readState.Index' (duration: 173.916µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T11:03:35.544052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.552906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-24T11:03:35.544076Z","caller":"traceutil/trace.go:171","msg":"trace[12108352] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1439; }","duration":"195.611164ms","start":"2026-06-24T11:03:35.348456Z","end":"2026-06-24T11:03:35.544068Z","steps":["trace[12108352] 'agreement among raft nodes before linearized reading' (duration: 195.516637ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T11:03:35.544146Z","caller":"traceutil/trace.go:171","msg":"trace[31053307] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"203.359226ms","start":"2026-06-24T11:03:35.340782Z","end":"2026-06-24T11:03:35.544141Z","steps":["trace[31053307] 'process raft request' (duration: 203.014505ms)"],"step_count":1}