{"level":"warn","ts":"2026-06-24T22:24:54.999806Z","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-24T22:24:54.999904Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.148:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.148:2380","--initial-cluster=instance=https://199.204.45.148:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.148:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.148: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-24T22:24:54.999979Z","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-24T22:24:54.999992Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-24T22:24:55.000014Z","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-24T22:24:55.0007Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"]} {"level":"info","ts":"2026-06-24T22:24:55.000787Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.148: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-24T22:24:55.003168Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.078379ms"} {"level":"info","ts":"2026-06-24T22:24:55.01155Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"8d200b79e0a2e7ca","cluster-id":"908374b13ab3ba47"} {"level":"info","ts":"2026-06-24T22:24:55.011667Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=()"} {"level":"info","ts":"2026-06-24T22:24:55.0117Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 0"} {"level":"info","ts":"2026-06-24T22:24:55.011717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 8d200b79e0a2e7ca [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-24T22:24:55.011729Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became follower at term 1"} {"level":"info","ts":"2026-06-24T22:24:55.011779Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"warn","ts":"2026-06-24T22:24:55.016055Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-24T22:24:55.018162Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-24T22:24:55.019751Z","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-24T22:24:55.022014Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"8d200b79e0a2e7ca","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-24T22:24:55.023068Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"8d200b79e0a2e7ca","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-24T22:24:55.023115Z","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-24T22:24:55.023145Z","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-24T22:24:55.023152Z","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-24T22:24:55.024996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca switched to configuration voters=(10169140576690300874)"} {"level":"info","ts":"2026-06-24T22:24:55.025203Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","added-peer-id":"8d200b79e0a2e7ca","added-peer-peer-urls":["https://199.204.45.148:2380"]} {"level":"info","ts":"2026-06-24T22:24:55.028888Z","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-24T22:24:55.029136Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"8d200b79e0a2e7ca","initial-advertise-peer-urls":["https://199.204.45.148:2380"],"listen-peer-urls":["https://199.204.45.148:2380"],"advertise-client-urls":["https://199.204.45.148:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.148:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-24T22:24:55.029167Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-24T22:24:55.029272Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-24T22:24:55.029294Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.148:2380"} {"level":"info","ts":"2026-06-24T22:24:55.212222Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca is starting a new election at term 1"} {"level":"info","ts":"2026-06-24T22:24:55.212282Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became pre-candidate at term 1"} {"level":"info","ts":"2026-06-24T22:24:55.212318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgPreVoteResp from 8d200b79e0a2e7ca at term 1"} {"level":"info","ts":"2026-06-24T22:24:55.212347Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became candidate at term 2"} {"level":"info","ts":"2026-06-24T22:24:55.212363Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca received MsgVoteResp from 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-24T22:24:55.21238Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"8d200b79e0a2e7ca became leader at term 2"} {"level":"info","ts":"2026-06-24T22:24:55.212399Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 8d200b79e0a2e7ca elected leader 8d200b79e0a2e7ca at term 2"} {"level":"info","ts":"2026-06-24T22:24:55.213406Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:24:55.214209Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"8d200b79e0a2e7ca","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.148:2379]}","request-path":"/0/members/8d200b79e0a2e7ca/attributes","cluster-id":"908374b13ab3ba47","publish-timeout":"7s"} {"level":"info","ts":"2026-06-24T22:24:55.214239Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T22:24:55.214285Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-24T22:24:55.214735Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"908374b13ab3ba47","local-member-id":"8d200b79e0a2e7ca","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:24:55.214908Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:24:55.214943Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-24T22:24:55.215712Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-24T22:24:55.21577Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-24T22:24:55.216877Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.148:2379"} {"level":"info","ts":"2026-06-24T22:24:55.217421Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-24T22:25:02.809394Z","caller":"traceutil/trace.go:171","msg":"trace[2079271817] transaction","detail":"{read_only:false; response_revision:294; number_of_response:1; }","duration":"128.487825ms","start":"2026-06-24T22:25:02.680875Z","end":"2026-06-24T22:25:02.809363Z","steps":["trace[2079271817] 'process raft request' (duration: 128.329212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:03.349658Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093318595,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:25:03.974594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"619.91314ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:25:03.974726Z","caller":"traceutil/trace.go:171","msg":"trace[651466768] linearizableReadLoop","detail":"{readStateIndex:307; appliedIndex:306; }","duration":"1.126063482s","start":"2026-06-24T22:25:02.848641Z","end":"2026-06-24T22:25:03.974705Z","steps":["trace[651466768] 'read index received' (duration: 505.462267ms)","trace[651466768] 'applied index is now lower than readState.Index' (duration: 620.599395ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:03.974755Z","caller":"traceutil/trace.go:171","msg":"trace[857668673] transaction","detail":"{read_only:false; response_revision:295; number_of_response:1; }","duration":"1.144398754s","start":"2026-06-24T22:25:02.83032Z","end":"2026-06-24T22:25:03.974718Z","steps":["trace[857668673] 'process raft request' (duration: 523.865251ms)","trace[857668673] 'compare' (duration: 619.742895ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:03.974898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:02.830302Z","time spent":"1.144532487s","remote":"127.0.0.1:37610","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":176,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:25:03.974915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"462.57391ms","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-24T22:25:03.974964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"713.01117ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-24T22:25:03.974993Z","caller":"traceutil/trace.go:171","msg":"trace[1232231151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:295; }","duration":"462.708473ms","start":"2026-06-24T22:25:03.51227Z","end":"2026-06-24T22:25:03.974979Z","steps":["trace[1232231151] 'agreement among raft nodes before linearized reading' (duration: 462.54959ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:03.975013Z","caller":"traceutil/trace.go:171","msg":"trace[2012977390] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:295; }","duration":"713.114304ms","start":"2026-06-24T22:25:03.261884Z","end":"2026-06-24T22:25:03.974998Z","steps":["trace[2012977390] 'agreement among raft nodes before linearized reading' (duration: 712.992361ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:03.975044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.512243Z","time spent":"462.787275ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T22:25:03.975096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.261856Z","time spent":"713.197165ms","remote":"127.0.0.1:37678","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-24T22:25:03.975143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"972.772927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T22:25:03.97524Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.126572723s","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-24T22:25:03.975241Z","caller":"traceutil/trace.go:171","msg":"trace[633286296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:295; }","duration":"972.873068ms","start":"2026-06-24T22:25:03.002323Z","end":"2026-06-24T22:25:03.975196Z","steps":["trace[633286296] 'agreement among raft nodes before linearized reading' (duration: 972.49867ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:03.975303Z","caller":"traceutil/trace.go:171","msg":"trace[1622339100] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:295; }","duration":"1.126708747s","start":"2026-06-24T22:25:02.84857Z","end":"2026-06-24T22:25:03.975279Z","steps":["trace[1622339100] 'agreement among raft nodes before linearized reading' (duration: 1.126327058s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:03.975329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.002305Z","time spent":"973.004412ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T22:25:03.975398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:02.848537Z","time spent":"1.126838279s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T22:25:05.105317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"674.919004ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:25:05.105475Z","caller":"traceutil/trace.go:171","msg":"trace[50410829] transaction","detail":"{read_only:false; response_revision:296; number_of_response:1; }","duration":"1.125242992s","start":"2026-06-24T22:25:03.980206Z","end":"2026-06-24T22:25:05.105449Z","steps":["trace[50410829] 'process raft request' (duration: 449.811276ms)","trace[50410829] 'compare' (duration: 674.73876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:05.10558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.980192Z","time spent":"1.125354365s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:25:05.587907Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.157653277s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T22:25:05.588442Z","caller":"traceutil/trace.go:171","msg":"trace[834310049] transaction","detail":"{read_only:false; response_revision:298; number_of_response:1; }","duration":"1.607131506s","start":"2026-06-24T22:25:03.981215Z","end":"2026-06-24T22:25:05.588346Z","steps":["trace[834310049] 'process raft request' (duration: 1.607036804s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:05.588599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.981197Z","time spent":"1.607326781s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:05.588738Z","caller":"traceutil/trace.go:171","msg":"trace[2245242] transaction","detail":"{read_only:false; response_revision:297; number_of_response:1; }","duration":"1.607562296s","start":"2026-06-24T22:25:03.981166Z","end":"2026-06-24T22:25:05.588728Z","steps":["trace[2245242] 'process raft request' (duration: 1.606950522s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:05.588764Z","caller":"traceutil/trace.go:171","msg":"trace[1943454002] linearizableReadLoop","detail":"{readStateIndex:311; appliedIndex:307; }","duration":"1.606742257s","start":"2026-06-24T22:25:03.981991Z","end":"2026-06-24T22:25:05.588734Z","steps":["trace[1943454002] 'read index received' (duration: 448.286511ms)","trace[1943454002] 'applied index is now lower than readState.Index' (duration: 1.158453696s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:05.588825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.981147Z","time spent":"1.607651279s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:25:05.588925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.606907702s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:351"} {"level":"info","ts":"2026-06-24T22:25:05.588926Z","caller":"traceutil/trace.go:171","msg":"trace[1109006130] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"1.607660449s","start":"2026-06-24T22:25:03.981245Z","end":"2026-06-24T22:25:05.588905Z","steps":["trace[1109006130] 'process raft request' (duration: 1.607047575s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:05.588977Z","caller":"traceutil/trace.go:171","msg":"trace[1497676257] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:299; }","duration":"1.606997593s","start":"2026-06-24T22:25:03.981953Z","end":"2026-06-24T22:25:05.588951Z","steps":["trace[1497676257] 'agreement among raft nodes before linearized reading' (duration: 1.60687892s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:05.589046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.981229Z","time spent":"1.607746141s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:25:05.589108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:03.981933Z","time spent":"1.607073735s","remote":"127.0.0.1:37516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":1,"response size":375,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-06-24T22:25:06.774598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.273456ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:25:06.774694Z","caller":"traceutil/trace.go:171","msg":"trace[422618050] transaction","detail":"{read_only:false; response_revision:347; number_of_response:1; }","duration":"201.965455ms","start":"2026-06-24T22:25:06.572714Z","end":"2026-06-24T22:25:06.77468Z","steps":["trace[422618050] 'process raft request' (duration: 88.550687ms)","trace[422618050] 'compare' (duration: 113.0331ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:07.008458Z","caller":"traceutil/trace.go:171","msg":"trace[1955668702] transaction","detail":"{read_only:false; response_revision:348; number_of_response:1; }","duration":"125.563738ms","start":"2026-06-24T22:25:06.882822Z","end":"2026-06-24T22:25:07.008386Z","steps":["trace[1955668702] 'process raft request' (duration: 80.369248ms)","trace[1955668702] 'compare' (duration: 45.021776ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:07.364605Z","caller":"traceutil/trace.go:171","msg":"trace[75477427] transaction","detail":"{read_only:false; response_revision:350; number_of_response:1; }","duration":"157.961174ms","start":"2026-06-24T22:25:07.206618Z","end":"2026-06-24T22:25:07.364579Z","steps":["trace[75477427] 'process raft request' (duration: 157.559054ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:10.295472Z","caller":"traceutil/trace.go:171","msg":"trace[2079017719] transaction","detail":"{read_only:false; response_revision:363; number_of_response:1; }","duration":"100.867991ms","start":"2026-06-24T22:25:10.194588Z","end":"2026-06-24T22:25:10.295456Z","steps":["trace[2079017719] 'process raft request' (duration: 44.640477ms)","trace[2079017719] 'compare' (duration: 56.139052ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:33.55121Z","caller":"traceutil/trace.go:171","msg":"trace[17116275] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"870.985895ms","start":"2026-06-24T22:25:32.680187Z","end":"2026-06-24T22:25:33.551173Z","steps":["trace[17116275] 'process raft request' (duration: 870.698888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.551456Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.680156Z","time spent":"871.19184ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.697441Z","caller":"traceutil/trace.go:171","msg":"trace[1768463187] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"1.015330674s","start":"2026-06-24T22:25:32.682074Z","end":"2026-06-24T22:25:33.697404Z","steps":["trace[1768463187] 'process raft request' (duration: 1.01512259s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.697603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.682041Z","time spent":"1.015486768s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.697842Z","caller":"traceutil/trace.go:171","msg":"trace[1312848099] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"1.007490784s","start":"2026-06-24T22:25:32.690302Z","end":"2026-06-24T22:25:33.697792Z","steps":["trace[1312848099] 'process raft request' (duration: 1.007175217s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.698116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.690296Z","time spent":"1.007665268s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.698174Z","caller":"traceutil/trace.go:171","msg":"trace[484711670] linearizableReadLoop","detail":"{readStateIndex:515; appliedIndex:504; }","duration":"301.810292ms","start":"2026-06-24T22:25:33.396332Z","end":"2026-06-24T22:25:33.698143Z","steps":["trace[484711670] 'read index received' (duration: 155.344283ms)","trace[484711670] 'applied index is now lower than readState.Index' (duration: 146.462729ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:33.698303Z","caller":"traceutil/trace.go:171","msg":"trace[1868732803] transaction","detail":"{read_only:false; response_revision:487; number_of_response:1; }","duration":"1.008969749s","start":"2026-06-24T22:25:32.68932Z","end":"2026-06-24T22:25:33.698289Z","steps":["trace[1868732803] 'process raft request' (duration: 1.008068168s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.698368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.6893Z","time spent":"1.00903546s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.698456Z","caller":"traceutil/trace.go:171","msg":"trace[1682165229] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"1.00905588s","start":"2026-06-24T22:25:32.689382Z","end":"2026-06-24T22:25:33.698438Z","steps":["trace[1682165229] 'process raft request' (duration: 1.008048677s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.698454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.100959ms","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-24T22:25:33.698514Z","caller":"traceutil/trace.go:171","msg":"trace[748145926] transaction","detail":"{read_only:false; response_revision:486; number_of_response:1; }","duration":"1.016294537s","start":"2026-06-24T22:25:32.682206Z","end":"2026-06-24T22:25:33.6985Z","steps":["trace[748145926] 'process raft request' (duration: 1.01514153s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.698528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.689379Z","time spent":"1.009112641s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:25:33.698561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.682199Z","time spent":"1.016341018s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.698606Z","caller":"traceutil/trace.go:171","msg":"trace[2128130547] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:495; }","duration":"302.212952ms","start":"2026-06-24T22:25:33.396288Z","end":"2026-06-24T22:25:33.6985Z","steps":["trace[2128130547] 'agreement among raft nodes before linearized reading' (duration: 301.956936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.69867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:33.396266Z","time spent":"302.376136ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T22:25:33.698841Z","caller":"traceutil/trace.go:171","msg":"trace[24452754] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"958.844996ms","start":"2026-06-24T22:25:32.739981Z","end":"2026-06-24T22:25:33.698826Z","steps":["trace[24452754] 'process raft request' (duration: 957.673819ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.698873Z","caller":"traceutil/trace.go:171","msg":"trace[1516644911] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"944.047396ms","start":"2026-06-24T22:25:32.754811Z","end":"2026-06-24T22:25:33.698859Z","steps":["trace[1516644911] 'process raft request' (duration: 942.966691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.698909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.739949Z","time spent":"958.929697ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.698929Z","caller":"traceutil/trace.go:171","msg":"trace[1816116664] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"834.024544ms","start":"2026-06-24T22:25:32.86489Z","end":"2026-06-24T22:25:33.698915Z","steps":["trace[1816116664] 'process raft request' (duration: 833.163914ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.698951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.754796Z","time spent":"944.102797ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:25:33.698989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.864833Z","time spent":"834.128777ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.699022Z","caller":"traceutil/trace.go:171","msg":"trace[1710558824] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"999.121242ms","start":"2026-06-24T22:25:32.699888Z","end":"2026-06-24T22:25:33.69901Z","steps":["trace[1710558824] 'process raft request' (duration: 997.627188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.699083Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.699877Z","time spent":"999.178533ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.699231Z","caller":"traceutil/trace.go:171","msg":"trace[353838911] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"994.24474ms","start":"2026-06-24T22:25:32.704973Z","end":"2026-06-24T22:25:33.699217Z","steps":["trace[353838911] 'process raft request' (duration: 992.582062ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.699214Z","caller":"traceutil/trace.go:171","msg":"trace[1533836515] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"979.171253ms","start":"2026-06-24T22:25:32.720011Z","end":"2026-06-24T22:25:33.699183Z","steps":["trace[1533836515] 'process raft request' (duration: 977.591597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.69929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.704966Z","time spent":"994.295881ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:25:33.699357Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:32.719993Z","time spent":"979.298787ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:33.810302Z","caller":"traceutil/trace.go:171","msg":"trace[116231726] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"253.00975ms","start":"2026-06-24T22:25:33.557263Z","end":"2026-06-24T22:25:33.810273Z","steps":["trace[116231726] 'process raft request' (duration: 239.184322ms)","trace[116231726] 'compare' (duration: 13.449279ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:33.81047Z","caller":"traceutil/trace.go:171","msg":"trace[1979199783] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"251.68232ms","start":"2026-06-24T22:25:33.558765Z","end":"2026-06-24T22:25:33.810448Z","steps":["trace[1979199783] 'process raft request' (duration: 251.328532ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.810585Z","caller":"traceutil/trace.go:171","msg":"trace[909066259] transaction","detail":"{read_only:false; number_of_response:1; response_revision:497; }","duration":"250.462352ms","start":"2026-06-24T22:25:33.560109Z","end":"2026-06-24T22:25:33.810571Z","steps":["trace[909066259] 'process raft request' (duration: 250.068172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.928242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.020295ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-24T22:25:33.928554Z","caller":"traceutil/trace.go:171","msg":"trace[1606632334] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"220.39718ms","start":"2026-06-24T22:25:33.70814Z","end":"2026-06-24T22:25:33.928537Z","steps":["trace[1606632334] 'process raft request' (duration: 220.183725ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.995441Z","caller":"traceutil/trace.go:171","msg":"trace[1366627565] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"287.245017ms","start":"2026-06-24T22:25:33.708179Z","end":"2026-06-24T22:25:33.995424Z","steps":["trace[1366627565] 'process raft request' (duration: 220.350069ms)","trace[1366627565] 'compare' (duration: 66.736765ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:33.996427Z","caller":"traceutil/trace.go:171","msg":"trace[1943859049] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"288.148738ms","start":"2026-06-24T22:25:33.708254Z","end":"2026-06-24T22:25:33.996403Z","steps":["trace[1943859049] 'process raft request' (duration: 287.114974ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.996898Z","caller":"traceutil/trace.go:171","msg":"trace[101438521] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"279.335475ms","start":"2026-06-24T22:25:33.71754Z","end":"2026-06-24T22:25:33.996875Z","steps":["trace[101438521] 'process raft request' (duration: 278.602598ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.997393Z","caller":"traceutil/trace.go:171","msg":"trace[1370562533] linearizableReadLoop","detail":"{readStateIndex:529; appliedIndex:515; }","duration":"211.269149ms","start":"2026-06-24T22:25:33.786111Z","end":"2026-06-24T22:25:33.99738Z","steps":["trace[1370562533] 'read index received' (duration: 10.465491ms)","trace[1370562533] 'applied index is now lower than readState.Index' (duration: 200.802648ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:33.997467Z","caller":"traceutil/trace.go:171","msg":"trace[521619822] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"277.610946ms","start":"2026-06-24T22:25:33.719826Z","end":"2026-06-24T22:25:33.997437Z","steps":["trace[521619822] 'process raft request' (duration: 277.106804ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.997492Z","caller":"traceutil/trace.go:171","msg":"trace[656645043] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"277.567505ms","start":"2026-06-24T22:25:33.719903Z","end":"2026-06-24T22:25:33.997471Z","steps":["trace[656645043] 'process raft request' (duration: 277.138405ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.997531Z","caller":"traceutil/trace.go:171","msg":"trace[500448270] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"274.061044ms","start":"2026-06-24T22:25:33.723459Z","end":"2026-06-24T22:25:33.99752Z","steps":["trace[500448270] 'process raft request' (duration: 273.668495ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.997574Z","caller":"traceutil/trace.go:171","msg":"trace[1563394408] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"238.691011ms","start":"2026-06-24T22:25:33.758875Z","end":"2026-06-24T22:25:33.997567Z","steps":["trace[1563394408] 'process raft request' (duration: 238.422005ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.997634Z","caller":"traceutil/trace.go:171","msg":"trace[1029676822] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"279.98004ms","start":"2026-06-24T22:25:33.717643Z","end":"2026-06-24T22:25:33.997623Z","steps":["trace[1029676822] 'process raft request' (duration: 278.930696ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:33.997642Z","caller":"traceutil/trace.go:171","msg":"trace[521811949] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"277.849551ms","start":"2026-06-24T22:25:33.719785Z","end":"2026-06-24T22:25:33.997635Z","steps":["trace[521811949] 'process raft request' (duration: 276.972191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:33.997736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.617558ms","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-24T22:25:33.99851Z","caller":"traceutil/trace.go:171","msg":"trace[423153664] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:507; }","duration":"212.434646ms","start":"2026-06-24T22:25:33.78606Z","end":"2026-06-24T22:25:33.998495Z","steps":["trace[423153664] 'agreement among raft nodes before linearized reading' (duration: 211.609307ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:34.026234Z","caller":"traceutil/trace.go:171","msg":"trace[1014597776] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"182.895717ms","start":"2026-06-24T22:25:33.843316Z","end":"2026-06-24T22:25:34.026212Z","steps":["trace[1014597776] 'process raft request' (duration: 182.750353ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:34.026312Z","caller":"traceutil/trace.go:171","msg":"trace[1708039798] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"202.550059ms","start":"2026-06-24T22:25:33.82375Z","end":"2026-06-24T22:25:34.0263Z","steps":["trace[1708039798] 'process raft request' (duration: 202.18734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:34.02746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.007116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:34.027688Z","caller":"traceutil/trace.go:171","msg":"trace[421435699] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:509; }","duration":"202.296473ms","start":"2026-06-24T22:25:33.825374Z","end":"2026-06-24T22:25:34.02767Z","steps":["trace[421435699] 'agreement among raft nodes before linearized reading' (duration: 201.873434ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:34.028393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.262627ms","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-24T22:25:34.028483Z","caller":"traceutil/trace.go:171","msg":"trace[1555090184] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:509; }","duration":"117.39046ms","start":"2026-06-24T22:25:33.911057Z","end":"2026-06-24T22:25:34.028447Z","steps":["trace[1555090184] 'agreement among raft nodes before linearized reading' (duration: 117.070193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:34.537853Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093319010,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:25:35.699925Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"994.999598ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:25:35.700144Z","caller":"traceutil/trace.go:171","msg":"trace[119356738] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"1.693058333s","start":"2026-06-24T22:25:34.007058Z","end":"2026-06-24T22:25:35.700116Z","steps":["trace[119356738] 'process raft request' (duration: 697.770569ms)","trace[119356738] 'compare' (duration: 994.788013ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:35.700242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.007033Z","time spent":"1.693165765s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:35.700323Z","caller":"traceutil/trace.go:171","msg":"trace[1928990588] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"1.679528282s","start":"2026-06-24T22:25:34.020782Z","end":"2026-06-24T22:25:35.700311Z","steps":["trace[1928990588] 'process raft request' (duration: 1.679411719s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.70039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.020773Z","time spent":"1.679584233s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:35.700539Z","caller":"traceutil/trace.go:171","msg":"trace[2055024382] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"1.681891397s","start":"2026-06-24T22:25:34.018635Z","end":"2026-06-24T22:25:35.700526Z","steps":["trace[2055024382] 'process raft request' (duration: 1.681452077s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:35.700487Z","caller":"traceutil/trace.go:171","msg":"trace[1921366246] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"1.68684405s","start":"2026-06-24T22:25:34.01361Z","end":"2026-06-24T22:25:35.700454Z","steps":["trace[1921366246] 'process raft request' (duration: 1.68640645s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.700763Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.013585Z","time spent":"1.687103357s","remote":"127.0.0.1:37942","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:25:35.700804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.018623Z","time spent":"1.681961708s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79947,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:35.817036Z","caller":"traceutil/trace.go:171","msg":"trace[2082543146] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"1.780251858s","start":"2026-06-24T22:25:34.036763Z","end":"2026-06-24T22:25:35.817015Z","steps":["trace[2082543146] 'process raft request' (duration: 1.76858641s)","trace[2082543146] 'compare' (duration: 11.502335ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:35.817184Z","caller":"traceutil/trace.go:171","msg":"trace[65051431] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"1.78032288s","start":"2026-06-24T22:25:34.03682Z","end":"2026-06-24T22:25:35.817143Z","steps":["trace[65051431] 'process raft request' (duration: 1.780130386s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.817282Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.036745Z","time spent":"1.780443063s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:25:35.817408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.036815Z","time spent":"1.780463324s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:35.817452Z","caller":"traceutil/trace.go:171","msg":"trace[201764583] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"1.779383819s","start":"2026-06-24T22:25:34.038051Z","end":"2026-06-24T22:25:35.817435Z","steps":["trace[201764583] 'process raft request' (duration: 1.778926589s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.817564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.03803Z","time spent":"1.779475201s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9134,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:35.818043Z","caller":"traceutil/trace.go:171","msg":"trace[758362643] linearizableReadLoop","detail":"{readStateIndex:541; appliedIndex:531; }","duration":"1.781292483s","start":"2026-06-24T22:25:34.036738Z","end":"2026-06-24T22:25:35.818031Z","steps":["trace[758362643] 'read index received' (duration: 668.218979ms)","trace[758362643] 'applied index is now lower than readState.Index' (duration: 1.113072174s)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:35.818118Z","caller":"traceutil/trace.go:171","msg":"trace[1320299859] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"1.769666646s","start":"2026-06-24T22:25:34.048444Z","end":"2026-06-24T22:25:35.81811Z","steps":["trace[1320299859] 'process raft request' (duration: 1.769346538s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:35.818135Z","caller":"traceutil/trace.go:171","msg":"trace[852662767] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"1.7454878s","start":"2026-06-24T22:25:34.072639Z","end":"2026-06-24T22:25:35.818127Z","steps":["trace[852662767] 'process raft request' (duration: 1.745334587s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.818193Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.072605Z","time spent":"1.745558331s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":97665,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:25:35.818209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.048426Z","time spent":"1.769721717s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":150480,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:35.818296Z","caller":"traceutil/trace.go:171","msg":"trace[848918984] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"1.779985893s","start":"2026-06-24T22:25:34.038304Z","end":"2026-06-24T22:25:35.81829Z","steps":["trace[848918984] 'process raft request' (duration: 1.77897459s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.818354Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.03829Z","time spent":"1.780046274s","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10846,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:25:35.818488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.781740793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:35.818542Z","caller":"traceutil/trace.go:171","msg":"trace[1242800120] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"1.781826865s","start":"2026-06-24T22:25:34.036704Z","end":"2026-06-24T22:25:35.818531Z","steps":["trace[1242800120] 'agreement among raft nodes before linearized reading' (duration: 1.781708693s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.818585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:34.036687Z","time spent":"1.781888336s","remote":"127.0.0.1:37386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:25:35.818758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.07715ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:35.8188Z","caller":"traceutil/trace.go:171","msg":"trace[251606356] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"639.157562ms","start":"2026-06-24T22:25:35.179632Z","end":"2026-06-24T22:25:35.81879Z","steps":["trace[251606356] 'agreement among raft nodes before linearized reading' (duration: 639.102101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:35.818841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:35.179608Z","time spent":"639.225343ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:25:36.123138Z","caller":"traceutil/trace.go:171","msg":"trace[2147455395] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"146.378228ms","start":"2026-06-24T22:25:35.976704Z","end":"2026-06-24T22:25:36.123082Z","steps":["trace[2147455395] 'process raft request' (duration: 88.194789ms)","trace[2147455395] 'compare' (duration: 57.874612ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:36.123283Z","caller":"traceutil/trace.go:171","msg":"trace[1152729326] linearizableReadLoop","detail":"{readStateIndex:550; appliedIndex:547; }","duration":"123.491131ms","start":"2026-06-24T22:25:35.999758Z","end":"2026-06-24T22:25:36.123249Z","steps":["trace[1152729326] 'read index received' (duration: 27.755198ms)","trace[1152729326] 'applied index is now lower than readState.Index' (duration: 95.734132ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:36.123531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.735036ms","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-24T22:25:36.123606Z","caller":"traceutil/trace.go:171","msg":"trace[1285670935] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:528; }","duration":"123.838079ms","start":"2026-06-24T22:25:35.999716Z","end":"2026-06-24T22:25:36.123554Z","steps":["trace[1285670935] 'agreement among raft nodes before linearized reading' (duration: 123.647604ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:36.123727Z","caller":"traceutil/trace.go:171","msg":"trace[436803584] transaction","detail":"{read_only:false; response_revision:528; number_of_response:1; }","duration":"146.631883ms","start":"2026-06-24T22:25:35.977068Z","end":"2026-06-24T22:25:36.1237Z","steps":["trace[436803584] 'process raft request' (duration: 145.969708ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:36.44843Z","caller":"traceutil/trace.go:171","msg":"trace[474355919] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"311.70155ms","start":"2026-06-24T22:25:36.136687Z","end":"2026-06-24T22:25:36.448388Z","steps":["trace[474355919] 'process raft request' (duration: 296.229944ms)","trace[474355919] 'compare' (duration: 15.145368ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:36.448724Z","caller":"traceutil/trace.go:171","msg":"trace[1687878925] linearizableReadLoop","detail":"{readStateIndex:554; appliedIndex:552; }","duration":"200.892861ms","start":"2026-06-24T22:25:36.247793Z","end":"2026-06-24T22:25:36.448686Z","steps":["trace[1687878925] 'read index received' (duration: 185.125669ms)","trace[1687878925] 'applied index is now lower than readState.Index' (duration: 15.764092ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:36.448935Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.089306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.448654Z","caller":"traceutil/trace.go:171","msg":"trace[1297666923] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"306.906179ms","start":"2026-06-24T22:25:36.141724Z","end":"2026-06-24T22:25:36.44863Z","steps":["trace[1297666923] 'process raft request' (duration: 306.575321ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:36.449011Z","caller":"traceutil/trace.go:171","msg":"trace[644116020] 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:532; }","duration":"201.204398ms","start":"2026-06-24T22:25:36.247786Z","end":"2026-06-24T22:25:36.44899Z","steps":["trace[644116020] 'agreement among raft nodes before linearized reading' (duration: 201.016824ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.449088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:36.136662Z","time spent":"312.239342ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":31102,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:25:36.449132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:36.141694Z","time spent":"307.319109ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:25:36.449578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.71487ms","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-24T22:25:36.449666Z","caller":"traceutil/trace.go:171","msg":"trace[2125500552] 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:533; }","duration":"201.819952ms","start":"2026-06-24T22:25:36.247825Z","end":"2026-06-24T22:25:36.449644Z","steps":["trace[2125500552] 'agreement among raft nodes before linearized reading' (duration: 201.665209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.449752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.234943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:25:36.449807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.91509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.449889Z","caller":"traceutil/trace.go:171","msg":"trace[482785781] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:533; }","duration":"184.018733ms","start":"2026-06-24T22:25:36.265852Z","end":"2026-06-24T22:25:36.449871Z","steps":["trace[482785781] 'agreement among raft nodes before linearized reading' (duration: 183.878459ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.449931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.750571ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.449988Z","caller":"traceutil/trace.go:171","msg":"trace[1368601458] 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:533; }","duration":"201.837453ms","start":"2026-06-24T22:25:36.248138Z","end":"2026-06-24T22:25:36.449976Z","steps":["trace[1368601458] 'agreement among raft nodes before linearized reading' (duration: 201.751411ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:36.449846Z","caller":"traceutil/trace.go:171","msg":"trace[2002927291] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:533; }","duration":"169.355226ms","start":"2026-06-24T22:25:36.280472Z","end":"2026-06-24T22:25:36.449827Z","steps":["trace[2002927291] 'agreement among raft nodes before linearized reading' (duration: 169.144161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.449608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.901964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.450143Z","caller":"traceutil/trace.go:171","msg":"trace[72040036] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:533; }","duration":"132.460777ms","start":"2026-06-24T22:25:36.317672Z","end":"2026-06-24T22:25:36.450133Z","steps":["trace[72040036] 'agreement among raft nodes before linearized reading' (duration: 131.878323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.450435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.528294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.45048Z","caller":"traceutil/trace.go:171","msg":"trace[2064209856] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:533; }","duration":"184.591186ms","start":"2026-06-24T22:25:36.265878Z","end":"2026-06-24T22:25:36.450469Z","steps":["trace[2064209856] 'agreement among raft nodes before linearized reading' (duration: 184.191277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.450786Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.790792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.450827Z","caller":"traceutil/trace.go:171","msg":"trace[1108202917] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:533; }","duration":"168.847204ms","start":"2026-06-24T22:25:36.281971Z","end":"2026-06-24T22:25:36.450818Z","steps":["trace[1108202917] 'agreement among raft nodes before linearized reading' (duration: 168.788193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.450964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.302697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.451004Z","caller":"traceutil/trace.go:171","msg":"trace[1120350445] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:533; }","duration":"133.380118ms","start":"2026-06-24T22:25:36.317615Z","end":"2026-06-24T22:25:36.450995Z","steps":["trace[1120350445] 'agreement among raft nodes before linearized reading' (duration: 133.320637ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.451391Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.494752ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.451508Z","caller":"traceutil/trace.go:171","msg":"trace[150884586] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:533; }","duration":"120.620205ms","start":"2026-06-24T22:25:36.330864Z","end":"2026-06-24T22:25:36.451484Z","steps":["trace[150884586] 'agreement among raft nodes before linearized reading' (duration: 120.479532ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.451912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.207267ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.451946Z","caller":"traceutil/trace.go:171","msg":"trace[1409085686] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:533; }","duration":"134.254638ms","start":"2026-06-24T22:25:36.317685Z","end":"2026-06-24T22:25:36.451939Z","steps":["trace[1409085686] 'agreement among raft nodes before linearized reading' (duration: 134.195257ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.452112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.126556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.452138Z","caller":"traceutil/trace.go:171","msg":"trace[1582007104] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:533; }","duration":"121.163837ms","start":"2026-06-24T22:25:36.330968Z","end":"2026-06-24T22:25:36.452132Z","steps":["trace[1582007104] 'agreement among raft nodes before linearized reading' (duration: 121.124376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.452504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.599207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.452534Z","caller":"traceutil/trace.go:171","msg":"trace[1759930602] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:533; }","duration":"121.635268ms","start":"2026-06-24T22:25:36.33089Z","end":"2026-06-24T22:25:36.452526Z","steps":["trace[1759930602] 'agreement among raft nodes before linearized reading' (duration: 121.589757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:36.452507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.853344ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:36.452883Z","caller":"traceutil/trace.go:171","msg":"trace[1642717607] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:533; }","duration":"172.257742ms","start":"2026-06-24T22:25:36.280603Z","end":"2026-06-24T22:25:36.452861Z","steps":["trace[1642717607] 'agreement among raft nodes before linearized reading' (duration: 171.820292ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:39.882141Z","caller":"traceutil/trace.go:171","msg":"trace[218152987] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"165.255521ms","start":"2026-06-24T22:25:39.716855Z","end":"2026-06-24T22:25:39.88211Z","steps":["trace[218152987] 'process raft request' (duration: 165.099777ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:40.17553Z","caller":"traceutil/trace.go:171","msg":"trace[558709018] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"287.80103ms","start":"2026-06-24T22:25:39.88771Z","end":"2026-06-24T22:25:40.175511Z","steps":["trace[558709018] 'process raft request' (duration: 192.762494ms)","trace[558709018] 'compare' (duration: 94.952244ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:40.179923Z","caller":"traceutil/trace.go:171","msg":"trace[1895740981] transaction","detail":"{read_only:false; response_revision:572; number_of_response:1; }","duration":"292.007487ms","start":"2026-06-24T22:25:39.887886Z","end":"2026-06-24T22:25:40.179894Z","steps":["trace[1895740981] 'process raft request' (duration: 291.854453ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:43.438453Z","caller":"traceutil/trace.go:171","msg":"trace[625580925] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"202.853896ms","start":"2026-06-24T22:25:43.23555Z","end":"2026-06-24T22:25:43.438403Z","steps":["trace[625580925] 'read index received' (duration: 196.819527ms)","trace[625580925] 'applied index is now lower than readState.Index' (duration: 6.033679ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:43.438535Z","caller":"traceutil/trace.go:171","msg":"trace[1769774143] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"684.015093ms","start":"2026-06-24T22:25:42.754496Z","end":"2026-06-24T22:25:43.438511Z","steps":["trace[1769774143] 'process raft request' (duration: 678.719842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:43.438606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.04733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-64dsr\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-24T22:25:43.438635Z","caller":"traceutil/trace.go:171","msg":"trace[635564405] range","detail":"{range_begin:/registry/pods/kube-system/cilium-64dsr; range_end:; response_count:1; response_revision:590; }","duration":"203.113202ms","start":"2026-06-24T22:25:43.235514Z","end":"2026-06-24T22:25:43.438627Z","steps":["trace[635564405] 'agreement among raft nodes before linearized reading' (duration: 202.993499ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:43.43864Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:42.754461Z","time spent":"684.111136ms","remote":"127.0.0.1:37510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036193,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:43.592912Z","caller":"traceutil/trace.go:171","msg":"trace[1276109731] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"138.857384ms","start":"2026-06-24T22:25:43.454018Z","end":"2026-06-24T22:25:43.592876Z","steps":["trace[1276109731] 'process raft request' (duration: 48.833363ms)","trace[1276109731] 'compare' (duration: 89.609952ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:45.796061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.193350621s","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-24T22:25:45.79616Z","caller":"traceutil/trace.go:171","msg":"trace[1736616036] linearizableReadLoop","detail":"{readStateIndex:616; appliedIndex:615; }","duration":"2.192274436s","start":"2026-06-24T22:25:43.603868Z","end":"2026-06-24T22:25:45.796143Z","steps":["trace[1736616036] 'read index received' (duration: 26.86µs)","trace[1736616036] 'applied index is now lower than readState.Index' (duration: 2.192246216s)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:45.796702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.192827479s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:25:45.796711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.969886311s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:25:45.796753Z","caller":"traceutil/trace.go:171","msg":"trace[1683047315] range","detail":"{range_begin:/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system; range_end:; response_count:0; response_revision:592; }","duration":"2.192902511s","start":"2026-06-24T22:25:43.603833Z","end":"2026-06-24T22:25:45.796736Z","steps":["trace[1683047315] 'agreement among raft nodes before linearized reading' (duration: 2.192826439s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:45.796756Z","caller":"traceutil/trace.go:171","msg":"trace[1015002163] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"1.969959493s","start":"2026-06-24T22:25:43.826783Z","end":"2026-06-24T22:25:45.796743Z","steps":["trace[1015002163] 'agreement among raft nodes before linearized reading' (duration: 1.969893502s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:45.796788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:43.826767Z","time spent":"1.970014514s","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:25:45.796787Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:43.603813Z","time spent":"2.192965342s","remote":"127.0.0.1:37752","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":29,"request content":"key:\"/registry/clusterroles/envoy-gateway-gateway-helm-certgen:envoy-gateway-system\" "} {"level":"warn","ts":"2026-06-24T22:25:45.796817Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.592681144s","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-24T22:25:45.796854Z","caller":"traceutil/trace.go:171","msg":"trace[1148577083] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:592; }","duration":"1.592747385s","start":"2026-06-24T22:25:44.204095Z","end":"2026-06-24T22:25:45.796843Z","steps":["trace[1148577083] 'agreement among raft nodes before linearized reading' (duration: 1.592619572s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:45.796882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:44.204073Z","time spent":"1.592801017s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T22:25:45.796997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.528074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:25:45.796998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.593156565s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T22:25:45.797047Z","caller":"traceutil/trace.go:171","msg":"trace[1157589704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:592; }","duration":"1.593242857s","start":"2026-06-24T22:25:44.203795Z","end":"2026-06-24T22:25:45.797038Z","steps":["trace[1157589704] 'agreement among raft nodes before linearized reading' (duration: 1.593130724s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:45.797075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:44.203773Z","time spent":"1.593295709s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T22:25:45.797091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.588077708s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-24T22:25:45.797115Z","caller":"traceutil/trace.go:171","msg":"trace[1364370265] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:592; }","duration":"1.588140039s","start":"2026-06-24T22:25:44.208968Z","end":"2026-06-24T22:25:45.797108Z","steps":["trace[1364370265] 'agreement among raft nodes before linearized reading' (duration: 1.588068558s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:45.797139Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:44.208947Z","time spent":"1.588184821s","remote":"127.0.0.1:37678","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-24T22:25:45.797242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.9050975s","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-24T22:25:45.79727Z","caller":"traceutil/trace.go:171","msg":"trace[943455406] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:592; }","duration":"1.905163412s","start":"2026-06-24T22:25:43.892098Z","end":"2026-06-24T22:25:45.797261Z","steps":["trace[943455406] 'agreement among raft nodes before linearized reading' (duration: 1.90508555s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:45.797297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:43.892073Z","time spent":"1.905217663s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T22:25:45.797022Z","caller":"traceutil/trace.go:171","msg":"trace[2147310940] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:592; }","duration":"617.587545ms","start":"2026-06-24T22:25:45.179427Z","end":"2026-06-24T22:25:45.797014Z","steps":["trace[2147310940] 'agreement among raft nodes before linearized reading' (duration: 617.547184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:45.797379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:45.179407Z","time spent":"617.940653ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:25:46.365514Z","caller":"traceutil/trace.go:171","msg":"trace[1173390961] linearizableReadLoop","detail":"{readStateIndex:621; appliedIndex:620; }","duration":"118.277401ms","start":"2026-06-24T22:25:46.247216Z","end":"2026-06-24T22:25:46.365493Z","steps":["trace[1173390961] 'read index received' (duration: 115.983038ms)","trace[1173390961] 'applied index is now lower than readState.Index' (duration: 2.293423ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:46.365558Z","caller":"traceutil/trace.go:171","msg":"trace[209320562] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"186.783417ms","start":"2026-06-24T22:25:46.178751Z","end":"2026-06-24T22:25:46.365534Z","steps":["trace[209320562] 'process raft request' (duration: 185.246831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:46.365762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.535776ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-64dsr\" ","response":"range_response_count:1 size:17149"} {"level":"info","ts":"2026-06-24T22:25:46.365816Z","caller":"traceutil/trace.go:171","msg":"trace[1101862528] range","detail":"{range_begin:/registry/pods/kube-system/cilium-64dsr; range_end:; response_count:1; response_revision:597; }","duration":"118.640859ms","start":"2026-06-24T22:25:46.247162Z","end":"2026-06-24T22:25:46.365802Z","steps":["trace[1101862528] 'agreement among raft nodes before linearized reading' (duration: 118.463235ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:46.437339Z","caller":"traceutil/trace.go:171","msg":"trace[1173352045] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"189.624731ms","start":"2026-06-24T22:25:46.247679Z","end":"2026-06-24T22:25:46.437304Z","steps":["trace[1173352045] 'process raft request' (duration: 165.397875ms)","trace[1173352045] 'compare' (duration: 24.117724ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:47.824804Z","caller":"traceutil/trace.go:171","msg":"trace[88600915] transaction","detail":"{read_only:false; response_revision:624; number_of_response:1; }","duration":"400.161014ms","start":"2026-06-24T22:25:47.424593Z","end":"2026-06-24T22:25:47.824754Z","steps":["trace[88600915] 'process raft request' (duration: 399.285784ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:47.825011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:47.424567Z","time spent":"400.336689ms","remote":"127.0.0.1:37510","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036297,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:47.832686Z","caller":"traceutil/trace.go:171","msg":"trace[1202691069] transaction","detail":"{read_only:false; response_revision:625; number_of_response:1; }","duration":"323.615864ms","start":"2026-06-24T22:25:47.509048Z","end":"2026-06-24T22:25:47.832664Z","steps":["trace[1202691069] 'process raft request' (duration: 323.469581ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:47.832746Z","caller":"traceutil/trace.go:171","msg":"trace[231219977] transaction","detail":"{read_only:false; response_revision:626; number_of_response:1; }","duration":"122.15435ms","start":"2026-06-24T22:25:47.710553Z","end":"2026-06-24T22:25:47.832707Z","steps":["trace[231219977] 'process raft request' (duration: 122.047088ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:47.832887Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:47.509022Z","time spent":"323.712336ms","remote":"127.0.0.1:37456","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-24T22:25:50.45351Z","caller":"traceutil/trace.go:171","msg":"trace[1421961582] transaction","detail":"{read_only:false; response_revision:673; number_of_response:1; }","duration":"172.388115ms","start":"2026-06-24T22:25:50.281102Z","end":"2026-06-24T22:25:50.45349Z","steps":["trace[1421961582] 'process raft request' (duration: 172.257472ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:50.594108Z","caller":"traceutil/trace.go:171","msg":"trace[1725437251] transaction","detail":"{read_only:false; response_revision:675; number_of_response:1; }","duration":"281.349812ms","start":"2026-06-24T22:25:50.312727Z","end":"2026-06-24T22:25:50.594077Z","steps":["trace[1725437251] 'process raft request' (duration: 281.222459ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:50.594265Z","caller":"traceutil/trace.go:171","msg":"trace[1655276331] transaction","detail":"{read_only:false; response_revision:674; number_of_response:1; }","duration":"301.874184ms","start":"2026-06-24T22:25:50.292366Z","end":"2026-06-24T22:25:50.59424Z","steps":["trace[1655276331] 'process raft request' (duration: 299.387537ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:50.594386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:25:50.292344Z","time spent":"301.980566ms","remote":"127.0.0.1:37596","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":18322,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:25:50.837826Z","caller":"traceutil/trace.go:171","msg":"trace[1396979735] linearizableReadLoop","detail":"{readStateIndex:702; appliedIndex:701; }","duration":"130.183054ms","start":"2026-06-24T22:25:50.707622Z","end":"2026-06-24T22:25:50.837805Z","steps":["trace[1396979735] 'read index received' (duration: 66.97326ms)","trace[1396979735] 'applied index is now lower than readState.Index' (duration: 63.208984ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:50.837943Z","caller":"traceutil/trace.go:171","msg":"trace[113535771] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"139.956039ms","start":"2026-06-24T22:25:50.697976Z","end":"2026-06-24T22:25:50.837932Z","steps":["trace[113535771] 'process raft request' (duration: 76.685144ms)","trace[113535771] 'compare' (duration: 63.03862ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:50.838139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.498511ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:1 size:13229"} {"level":"info","ts":"2026-06-24T22:25:50.83822Z","caller":"traceutil/trace.go:171","msg":"trace[405588411] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:1; response_revision:677; }","duration":"130.664105ms","start":"2026-06-24T22:25:50.707537Z","end":"2026-06-24T22:25:50.838201Z","steps":["trace[405588411] 'agreement among raft nodes before linearized reading' (duration: 130.477941ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:51.434763Z","caller":"traceutil/trace.go:171","msg":"trace[1850396410] transaction","detail":"{read_only:false; response_revision:683; number_of_response:1; }","duration":"266.717665ms","start":"2026-06-24T22:25:51.167781Z","end":"2026-06-24T22:25:51.434498Z","steps":["trace[1850396410] 'process raft request' (duration: 225.685811ms)","trace[1850396410] 'compare' (duration: 40.87263ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:51.520712Z","caller":"traceutil/trace.go:171","msg":"trace[1144913806] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"289.000407ms","start":"2026-06-24T22:25:51.231683Z","end":"2026-06-24T22:25:51.520684Z","steps":["trace[1144913806] 'process raft request' (duration: 288.67857ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:51.520815Z","caller":"traceutil/trace.go:171","msg":"trace[1782106954] transaction","detail":"{read_only:false; response_revision:685; number_of_response:1; }","duration":"286.108031ms","start":"2026-06-24T22:25:51.234667Z","end":"2026-06-24T22:25:51.520775Z","steps":["trace[1782106954] 'process raft request' (duration: 285.948398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:51.521107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.43058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-64dsr\" ","response":"range_response_count:1 size:18337"} {"level":"info","ts":"2026-06-24T22:25:51.521171Z","caller":"traceutil/trace.go:171","msg":"trace[1081902830] range","detail":"{range_begin:/registry/pods/kube-system/cilium-64dsr; range_end:; response_count:1; response_revision:685; }","duration":"230.546653ms","start":"2026-06-24T22:25:51.290612Z","end":"2026-06-24T22:25:51.521159Z","steps":["trace[1081902830] 'agreement among raft nodes before linearized reading' (duration: 230.219566ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:51.520782Z","caller":"traceutil/trace.go:171","msg":"trace[960465865] linearizableReadLoop","detail":"{readStateIndex:710; appliedIndex:707; }","duration":"230.072162ms","start":"2026-06-24T22:25:51.290662Z","end":"2026-06-24T22:25:51.520734Z","steps":["trace[960465865] 'read index received' (duration: 102.948968ms)","trace[960465865] 'applied index is now lower than readState.Index' (duration: 127.122274ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:25:51.521716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.393063ms","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-24T22:25:51.521762Z","caller":"traceutil/trace.go:171","msg":"trace[1817761830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:685; }","duration":"151.477065ms","start":"2026-06-24T22:25:51.370275Z","end":"2026-06-24T22:25:51.521752Z","steps":["trace[1817761830] 'agreement among raft nodes before linearized reading' (duration: 151.331552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:25:51.521784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.269679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:1 size:9320"} {"level":"info","ts":"2026-06-24T22:25:51.521862Z","caller":"traceutil/trace.go:171","msg":"trace[603677711] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:1; response_revision:685; }","duration":"214.386651ms","start":"2026-06-24T22:25:51.30746Z","end":"2026-06-24T22:25:51.521846Z","steps":["trace[603677711] 'agreement among raft nodes before linearized reading' (duration: 214.051733ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:25:53.511428Z","caller":"traceutil/trace.go:171","msg":"trace[1948381834] transaction","detail":"{read_only:false; response_revision:702; number_of_response:1; }","duration":"118.405133ms","start":"2026-06-24T22:25:53.392993Z","end":"2026-06-24T22:25:53.511398Z","steps":["trace[1948381834] 'process raft request' (duration: 24.188526ms)","trace[1948381834] 'compare' (duration: 94.044043ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:25:59.527835Z","caller":"traceutil/trace.go:171","msg":"trace[95322466] transaction","detail":"{read_only:false; response_revision:748; number_of_response:1; }","duration":"179.815345ms","start":"2026-06-24T22:25:59.347993Z","end":"2026-06-24T22:25:59.527808Z","steps":["trace[95322466] 'process raft request' (duration: 179.669472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:03.455163Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.60759ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:26:03.455233Z","caller":"traceutil/trace.go:171","msg":"trace[748403472] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:772; }","duration":"627.722463ms","start":"2026-06-24T22:26:02.827495Z","end":"2026-06-24T22:26:03.455217Z","steps":["trace[748403472] 'range keys from in-memory index tree' (duration: 627.479476ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:03.455269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:02.827473Z","time spent":"627.788104ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:26:03.455364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.105118983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ttp5b\" ","response":"range_response_count:1 size:3965"} {"level":"info","ts":"2026-06-24T22:26:03.455461Z","caller":"traceutil/trace.go:171","msg":"trace[210836125] range","detail":"{range_begin:/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ttp5b; range_end:; response_count:1; response_revision:772; }","duration":"1.105250736s","start":"2026-06-24T22:26:02.350196Z","end":"2026-06-24T22:26:03.455446Z","steps":["trace[210836125] 'range keys from in-memory index tree' (duration: 1.104601711s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:03.455512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:02.350179Z","time spent":"1.105323527s","remote":"127.0.0.1:37596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":1,"response size":3989,"request content":"key:\"/registry/pods/envoy-gateway-system/envoy-gateway-gateway-helm-certgen-ttp5b\" "} {"level":"info","ts":"2026-06-24T22:26:03.568674Z","caller":"traceutil/trace.go:171","msg":"trace[419496580] transaction","detail":"{read_only:false; response_revision:773; number_of_response:1; }","duration":"105.507582ms","start":"2026-06-24T22:26:03.46313Z","end":"2026-06-24T22:26:03.568638Z","steps":["trace[419496580] 'process raft request' (duration: 104.953789ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:08.078739Z","caller":"traceutil/trace.go:171","msg":"trace[1526433273] linearizableReadLoop","detail":"{readStateIndex:850; appliedIndex:849; }","duration":"106.160377ms","start":"2026-06-24T22:26:07.97255Z","end":"2026-06-24T22:26:08.07871Z","steps":["trace[1526433273] 'read index received' (duration: 18.128888ms)","trace[1526433273] 'applied index is now lower than readState.Index' (duration: 88.030539ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:26:08.079043Z","caller":"traceutil/trace.go:171","msg":"trace[1847555029] transaction","detail":"{read_only:false; response_revision:820; number_of_response:1; }","duration":"129.461408ms","start":"2026-06-24T22:26:07.949565Z","end":"2026-06-24T22:26:08.079026Z","steps":["trace[1847555029] 'process raft request' (duration: 41.185713ms)","trace[1847555029] 'compare' (duration: 87.815764ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:26:08.07997Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.396336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/envoy-gateway-system/\" range_end:\"/registry/secrets/envoy-gateway-system0\" ","response":"range_response_count:5 size:1050272"} {"level":"info","ts":"2026-06-24T22:26:08.080095Z","caller":"traceutil/trace.go:171","msg":"trace[1756861990] range","detail":"{range_begin:/registry/secrets/envoy-gateway-system/; range_end:/registry/secrets/envoy-gateway-system0; response_count:5; response_revision:820; }","duration":"107.56144ms","start":"2026-06-24T22:26:07.972515Z","end":"2026-06-24T22:26:08.080076Z","steps":["trace[1756861990] 'agreement among raft nodes before linearized reading' (duration: 106.426514ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:11.917573Z","caller":"traceutil/trace.go:171","msg":"trace[541722200] transaction","detail":"{read_only:false; response_revision:858; number_of_response:1; }","duration":"102.385957ms","start":"2026-06-24T22:26:11.815169Z","end":"2026-06-24T22:26:11.917555Z","steps":["trace[541722200] 'process raft request' (duration: 102.280565ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:11.918796Z","caller":"traceutil/trace.go:171","msg":"trace[654674053] transaction","detail":"{read_only:false; response_revision:859; number_of_response:1; }","duration":"101.080036ms","start":"2026-06-24T22:26:11.817699Z","end":"2026-06-24T22:26:11.918779Z","steps":["trace[654674053] 'process raft request' (duration: 100.659456ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:33.402001Z","caller":"traceutil/trace.go:171","msg":"trace[1821670857] transaction","detail":"{read_only:false; response_revision:965; number_of_response:1; }","duration":"114.009742ms","start":"2026-06-24T22:26:33.287967Z","end":"2026-06-24T22:26:33.401976Z","steps":["trace[1821670857] 'process raft request' (duration: 113.853349ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:39.891113Z","caller":"traceutil/trace.go:171","msg":"trace[1690337590] transaction","detail":"{read_only:false; response_revision:989; number_of_response:1; }","duration":"379.220625ms","start":"2026-06-24T22:26:39.511874Z","end":"2026-06-24T22:26:39.891095Z","steps":["trace[1690337590] 'process raft request' (duration: 379.091822ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:39.891235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:39.511848Z","time spent":"379.320787ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:26:40.546612Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.673339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T22:26:40.546709Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"422.073817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T22:26:40.54673Z","caller":"traceutil/trace.go:171","msg":"trace[647101442] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:989; }","duration":"308.881064ms","start":"2026-06-24T22:26:40.237822Z","end":"2026-06-24T22:26:40.546703Z","steps":["trace[647101442] 'count revisions from in-memory index tree' (duration: 308.549336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.546746Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.858579ms","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-24T22:26:40.546819Z","caller":"traceutil/trace.go:171","msg":"trace[100547151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:989; }","duration":"422.21414ms","start":"2026-06-24T22:26:40.124563Z","end":"2026-06-24T22:26:40.546778Z","steps":["trace[100547151] 'range keys from in-memory index tree' (duration: 421.892552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.546819Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:40.237795Z","time spent":"309.006557ms","remote":"127.0.0.1:37758","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":53,"response size":31,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:26:40.546806Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.775588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-24T22:26:40.546867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:40.124546Z","time spent":"422.313223ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-24T22:26:40.54686Z","caller":"traceutil/trace.go:171","msg":"trace[1926307047] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:989; }","duration":"183.005072ms","start":"2026-06-24T22:26:40.363831Z","end":"2026-06-24T22:26:40.546836Z","steps":["trace[1926307047] 'range keys from in-memory index tree' (duration: 182.594912ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.54686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.850017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-24T22:26:40.546892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.121952ms","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-24T22:26:40.5469Z","caller":"traceutil/trace.go:171","msg":"trace[1838094977] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:989; }","duration":"238.916202ms","start":"2026-06-24T22:26:40.30796Z","end":"2026-06-24T22:26:40.546876Z","steps":["trace[1838094977] 'range keys from in-memory index tree' (duration: 238.571123ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:40.546938Z","caller":"traceutil/trace.go:171","msg":"trace[1913697241] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:989; }","duration":"335.003541ms","start":"2026-06-24T22:26:40.211916Z","end":"2026-06-24T22:26:40.54692Z","steps":["trace[1913697241] 'range keys from in-memory index tree' (duration: 334.544309ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:40.546949Z","caller":"traceutil/trace.go:171","msg":"trace[922649909] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:989; }","duration":"188.211774ms","start":"2026-06-24T22:26:40.358724Z","end":"2026-06-24T22:26:40.546935Z","steps":["trace[922649909] 'range keys from in-memory index tree' (duration: 187.941179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.547006Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:40.211878Z","time spent":"335.114724ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-24T22:26:40.851717Z","caller":"traceutil/trace.go:171","msg":"trace[154774211] transaction","detail":"{read_only:false; response_revision:990; number_of_response:1; }","duration":"299.231225ms","start":"2026-06-24T22:26:40.552455Z","end":"2026-06-24T22:26:40.851686Z","steps":["trace[154774211] 'process raft request' (duration: 299.026891ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:26:40.863329Z","caller":"traceutil/trace.go:171","msg":"trace[1656046883] transaction","detail":"{read_only:false; response_revision:992; number_of_response:1; }","duration":"310.504382ms","start":"2026-06-24T22:26:40.552809Z","end":"2026-06-24T22:26:40.863313Z","steps":["trace[1656046883] 'process raft request' (duration: 310.460561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.863448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:40.552777Z","time spent":"310.606245ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:26:40.863406Z","caller":"traceutil/trace.go:171","msg":"trace[647178062] transaction","detail":"{read_only:false; response_revision:991; number_of_response:1; }","duration":"310.602794ms","start":"2026-06-24T22:26:40.552752Z","end":"2026-06-24T22:26:40.863355Z","steps":["trace[647178062] 'process raft request' (duration: 310.389039ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.863688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:40.552738Z","time spent":"310.778908ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:26:40.863705Z","caller":"traceutil/trace.go:171","msg":"trace[1685384961] transaction","detail":"{read_only:false; response_revision:993; number_of_response:1; }","duration":"310.143814ms","start":"2026-06-24T22:26:40.55353Z","end":"2026-06-24T22:26:40.863673Z","steps":["trace[1685384961] 'process raft request' (duration: 309.762505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.863867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:40.553509Z","time spent":"310.269076ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:26:40.863902Z","caller":"traceutil/trace.go:171","msg":"trace[2081201808] transaction","detail":"{read_only:false; response_revision:994; number_of_response:1; }","duration":"310.303457ms","start":"2026-06-24T22:26:40.553585Z","end":"2026-06-24T22:26:40.863889Z","steps":["trace[2081201808] 'process raft request' (duration: 309.958789ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:26:40.863968Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:26:40.553572Z","time spent":"310.364639ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:01.096261Z","caller":"traceutil/trace.go:171","msg":"trace[1754148332] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"104.506688ms","start":"2026-06-24T22:27:00.991725Z","end":"2026-06-24T22:27:01.096231Z","steps":["trace[1754148332] 'process raft request' (duration: 72.85161ms)","trace[1754148332] 'compare' (duration: 31.441973ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:04.587085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"592.855268ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-24T22:27:04.587494Z","caller":"traceutil/trace.go:171","msg":"trace[1797673445] linearizableReadLoop","detail":"{readStateIndex:1111; appliedIndex:1109; }","duration":"431.918559ms","start":"2026-06-24T22:27:04.155548Z","end":"2026-06-24T22:27:04.587467Z","steps":["trace[1797673445] 'read index received' (duration: 398.272244ms)","trace[1797673445] 'applied index is now lower than readState.Index' (duration: 33.644535ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:04.587625Z","caller":"traceutil/trace.go:171","msg":"trace[1502534589] transaction","detail":"{read_only:false; response_revision:1068; number_of_response:1; }","duration":"598.984803ms","start":"2026-06-24T22:27:03.988627Z","end":"2026-06-24T22:27:04.587612Z","steps":["trace[1502534589] 'process raft request' (duration: 598.640275ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:04.587731Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:03.988594Z","time spent":"599.064545ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:04.683373Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"527.796793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T22:27:04.683522Z","caller":"traceutil/trace.go:171","msg":"trace[738865870] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:1068; }","duration":"528.011808ms","start":"2026-06-24T22:27:04.155477Z","end":"2026-06-24T22:27:04.683489Z","steps":["trace[738865870] 'agreement among raft nodes before linearized reading' (duration: 432.087243ms)","trace[738865870] 'count revisions from in-memory index tree' (duration: 95.69871ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:04.68364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:04.15545Z","time spent":"528.170491ms","remote":"127.0.0.1:37920","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":1,"response size":31,"request content":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:27:05.609579Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093320256,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T22:27:05.711015Z","caller":"traceutil/trace.go:171","msg":"trace[959826146] linearizableReadLoop","detail":"{readStateIndex:1112; appliedIndex:1111; }","duration":"602.289162ms","start":"2026-06-24T22:27:05.108705Z","end":"2026-06-24T22:27:05.710994Z","steps":["trace[959826146] 'read index received' (duration: 602.101918ms)","trace[959826146] 'applied index is now lower than readState.Index' (duration: 185.954µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:05.711306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"531.986092ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:05.711409Z","caller":"traceutil/trace.go:171","msg":"trace[619841873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1069; }","duration":"532.117945ms","start":"2026-06-24T22:27:05.179278Z","end":"2026-06-24T22:27:05.711396Z","steps":["trace[619841873] 'agreement among raft nodes before linearized reading' (duration: 531.989172ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:05.711541Z","caller":"traceutil/trace.go:171","msg":"trace[523016072] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"705.547451ms","start":"2026-06-24T22:27:05.005933Z","end":"2026-06-24T22:27:05.71148Z","steps":["trace[523016072] 'process raft request' (duration: 704.937616ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:05.711708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.998639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-24T22:27:05.711731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.653653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T22:27:05.711766Z","caller":"traceutil/trace.go:171","msg":"trace[612683170] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1069; }","duration":"603.090031ms","start":"2026-06-24T22:27:05.108664Z","end":"2026-06-24T22:27:05.711755Z","steps":["trace[612683170] 'agreement among raft nodes before linearized reading' (duration: 602.889766ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:05.711785Z","caller":"traceutil/trace.go:171","msg":"trace[1420206377] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1069; }","duration":"597.751366ms","start":"2026-06-24T22:27:05.114018Z","end":"2026-06-24T22:27:05.71177Z","steps":["trace[1420206377] 'agreement among raft nodes before linearized reading' (duration: 597.606742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:05.711804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.108643Z","time spent":"603.152182ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T22:27:05.711825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.113996Z","time spent":"597.821727ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-24T22:27:05.712016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.005907Z","time spent":"705.991941ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:05.71145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.179266Z","time spent":"532.175207ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:27:05.712256Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"588.874055ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-24T22:27:05.712698Z","caller":"traceutil/trace.go:171","msg":"trace[1462492267] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1069; }","duration":"589.430438ms","start":"2026-06-24T22:27:05.123252Z","end":"2026-06-24T22:27:05.712682Z","steps":["trace[1462492267] 'agreement among raft nodes before linearized reading' (duration: 588.136418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:05.712754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.12324Z","time spent":"589.500029ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-24T22:27:05.713141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"600.699775ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-24T22:27:05.7132Z","caller":"traceutil/trace.go:171","msg":"trace[1991922795] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1069; }","duration":"600.773066ms","start":"2026-06-24T22:27:05.112413Z","end":"2026-06-24T22:27:05.713186Z","steps":["trace[1991922795] 'agreement among raft nodes before linearized reading' (duration: 598.848421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:05.713231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.112407Z","time spent":"600.817258ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T22:27:05.958287Z","caller":"traceutil/trace.go:171","msg":"trace[471044881] transaction","detail":"{read_only:false; response_revision:1070; number_of_response:1; }","duration":"241.011511ms","start":"2026-06-24T22:27:05.717201Z","end":"2026-06-24T22:27:05.958212Z","steps":["trace[471044881] 'process raft request' (duration: 224.118472ms)","trace[471044881] 'compare' (duration: 16.565221ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:06.136323Z","caller":"traceutil/trace.go:171","msg":"trace[879510257] transaction","detail":"{read_only:false; response_revision:1071; number_of_response:1; }","duration":"418.82099ms","start":"2026-06-24T22:27:05.717472Z","end":"2026-06-24T22:27:06.136293Z","steps":["trace[879510257] 'process raft request' (duration: 418.444531ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:06.136413Z","caller":"traceutil/trace.go:171","msg":"trace[1574748815] linearizableReadLoop","detail":"{readStateIndex:1116; appliedIndex:1112; }","duration":"309.57507ms","start":"2026-06-24T22:27:05.826805Z","end":"2026-06-24T22:27:06.13638Z","steps":["trace[1574748815] 'read index received' (duration: 114.531634ms)","trace[1574748815] 'applied index is now lower than readState.Index' (duration: 195.039786ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:06.136467Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.717463Z","time spent":"418.930243ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:06.13653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.712083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:06.136518Z","caller":"traceutil/trace.go:171","msg":"trace[1932015704] transaction","detail":"{read_only:false; response_revision:1072; number_of_response:1; }","duration":"418.927553ms","start":"2026-06-24T22:27:05.717564Z","end":"2026-06-24T22:27:06.136492Z","steps":["trace[1932015704] 'process raft request' (duration: 418.607175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:06.136651Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.717549Z","time spent":"419.028575ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:06.136664Z","caller":"traceutil/trace.go:171","msg":"trace[211302909] transaction","detail":"{read_only:false; response_revision:1073; number_of_response:1; }","duration":"418.518403ms","start":"2026-06-24T22:27:05.718036Z","end":"2026-06-24T22:27:06.136554Z","steps":["trace[211302909] 'process raft request' (duration: 418.223936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:06.13692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.718028Z","time spent":"418.835101ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:06.137001Z","caller":"traceutil/trace.go:171","msg":"trace[539471463] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1073; }","duration":"309.802276ms","start":"2026-06-24T22:27:05.826758Z","end":"2026-06-24T22:27:06.13656Z","steps":["trace[539471463] 'agreement among raft nodes before linearized reading' (duration: 309.719574ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:06.137187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:05.826742Z","time spent":"310.43059ms","remote":"127.0.0.1:37386","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-24T22:27:07.183742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.68854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:07.183817Z","caller":"traceutil/trace.go:171","msg":"trace[790483550] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1074; }","duration":"355.806512ms","start":"2026-06-24T22:27:06.827994Z","end":"2026-06-24T22:27:07.1838Z","steps":["trace[790483550] 'range keys from in-memory index tree' (duration: 355.584107ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:07.183855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:06.827971Z","time spent":"355.876014ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:27:08.074948Z","caller":"traceutil/trace.go:171","msg":"trace[2115138876] transaction","detail":"{read_only:false; response_revision:1076; number_of_response:1; }","duration":"108.684026ms","start":"2026-06-24T22:27:07.966228Z","end":"2026-06-24T22:27:08.074912Z","steps":["trace[2115138876] 'process raft request' (duration: 108.561923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:24.52084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.212007ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"warn","ts":"2026-06-24T22:27:24.520875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.772909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-24T22:27:24.520939Z","caller":"traceutil/trace.go:171","msg":"trace[498315781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1180; }","duration":"244.34925ms","start":"2026-06-24T22:27:24.276575Z","end":"2026-06-24T22:27:24.520924Z","steps":["trace[498315781] 'range keys from in-memory index tree' (duration: 244.071473ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:24.52097Z","caller":"traceutil/trace.go:171","msg":"trace[981537792] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1180; }","duration":"299.889231ms","start":"2026-06-24T22:27:24.221059Z","end":"2026-06-24T22:27:24.520949Z","steps":["trace[981537792] 'range keys from in-memory index tree' (duration: 299.664836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:24.520871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.181457ms","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-24T22:27:24.521056Z","caller":"traceutil/trace.go:171","msg":"trace[854087599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1180; }","duration":"244.421002ms","start":"2026-06-24T22:27:24.276623Z","end":"2026-06-24T22:27:24.521044Z","steps":["trace[854087599] 'range keys from in-memory index tree' (duration: 244.032962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:24.521044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.273398ms","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-24T22:27:24.521137Z","caller":"traceutil/trace.go:171","msg":"trace[296162193] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1180; }","duration":"244.435192ms","start":"2026-06-24T22:27:24.276681Z","end":"2026-06-24T22:27:24.521117Z","steps":["trace[296162193] 'range keys from in-memory index tree' (duration: 244.097684ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:24.633756Z","caller":"traceutil/trace.go:171","msg":"trace[1079443108] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"109.094057ms","start":"2026-06-24T22:27:24.524379Z","end":"2026-06-24T22:27:24.633473Z","steps":["trace[1079443108] 'process raft request' (duration: 108.929173ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:24.634323Z","caller":"traceutil/trace.go:171","msg":"trace[1471951052] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"108.878481ms","start":"2026-06-24T22:27:24.525428Z","end":"2026-06-24T22:27:24.634307Z","steps":["trace[1471951052] 'process raft request' (duration: 108.80667ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:24.634365Z","caller":"traceutil/trace.go:171","msg":"trace[377010466] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"109.213299ms","start":"2026-06-24T22:27:24.525137Z","end":"2026-06-24T22:27:24.63435Z","steps":["trace[377010466] 'process raft request' (duration: 109.028495ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:24.634466Z","caller":"traceutil/trace.go:171","msg":"trace[533601098] transaction","detail":"{read_only:false; response_revision:1184; number_of_response:1; }","duration":"108.940072ms","start":"2026-06-24T22:27:24.5255Z","end":"2026-06-24T22:27:24.63444Z","steps":["trace[533601098] 'process raft request' (duration: 108.770418ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:27.327874Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093320524,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:27:27.677836Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.034753266s","expected-duration":"1s"} {"level":"info","ts":"2026-06-24T22:27:27.678247Z","caller":"traceutil/trace.go:171","msg":"trace[477921575] transaction","detail":"{read_only:false; response_revision:1187; number_of_response:1; }","duration":"1.035188626s","start":"2026-06-24T22:27:26.643029Z","end":"2026-06-24T22:27:27.678218Z","steps":["trace[477921575] 'process raft request' (duration: 1.035009042s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:27.678415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:26.643019Z","time spent":"1.035311659s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:28.566897Z","caller":"traceutil/trace.go:171","msg":"trace[417854236] linearizableReadLoop","detail":"{readStateIndex:1240; appliedIndex:1236; }","duration":"1.739183331s","start":"2026-06-24T22:27:26.827686Z","end":"2026-06-24T22:27:28.566869Z","steps":["trace[417854236] 'read index received' (duration: 850.812313ms)","trace[417854236] 'applied index is now lower than readState.Index' (duration: 888.369408ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:28.567265Z","caller":"traceutil/trace.go:171","msg":"trace[1291856703] transaction","detail":"{read_only:false; response_revision:1188; number_of_response:1; }","duration":"1.924122088s","start":"2026-06-24T22:27:26.643126Z","end":"2026-06-24T22:27:28.567248Z","steps":["trace[1291856703] 'process raft request' (duration: 1.920680707s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:28.567397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:26.643122Z","time spent":"1.92418168s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:28.56774Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.248084213s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:28.567749Z","caller":"traceutil/trace.go:171","msg":"trace[1054220957] transaction","detail":"{read_only:false; response_revision:1190; number_of_response:1; }","duration":"1.921712051s","start":"2026-06-24T22:27:26.645997Z","end":"2026-06-24T22:27:28.567709Z","steps":["trace[1054220957] 'process raft request' (duration: 1.920762809s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:28.567804Z","caller":"traceutil/trace.go:171","msg":"trace[45675616] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1191; }","duration":"1.248230407s","start":"2026-06-24T22:27:27.319557Z","end":"2026-06-24T22:27:28.567788Z","steps":["trace[45675616] 'agreement among raft nodes before linearized reading' (duration: 1.248127255s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:28.567798Z","caller":"traceutil/trace.go:171","msg":"trace[1726315411] transaction","detail":"{read_only:false; response_revision:1189; number_of_response:1; }","duration":"1.922816758s","start":"2026-06-24T22:27:26.644958Z","end":"2026-06-24T22:27:28.567775Z","steps":["trace[1726315411] 'process raft request' (duration: 1.921699521s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:28.567859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:27.319534Z","time spent":"1.248309379s","remote":"127.0.0.1:39642","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:27:28.567892Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:26.645991Z","time spent":"1.921821304s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:28.567895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:26.644952Z","time spent":"1.922895059s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:28.568077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"418.273607ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T22:27:28.568136Z","caller":"traceutil/trace.go:171","msg":"trace[1125150394] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1191; }","duration":"418.371469ms","start":"2026-06-24T22:27:28.149753Z","end":"2026-06-24T22:27:28.568124Z","steps":["trace[1125150394] 'agreement among raft nodes before linearized reading' (duration: 418.287467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:28.568168Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:28.14973Z","time spent":"418.429961ms","remote":"127.0.0.1:37516","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":5,"response size":31,"request content":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true "} {"level":"info","ts":"2026-06-24T22:27:28.568154Z","caller":"traceutil/trace.go:171","msg":"trace[1740731480] transaction","detail":"{read_only:false; response_revision:1191; number_of_response:1; }","duration":"1.813572857s","start":"2026-06-24T22:27:26.754559Z","end":"2026-06-24T22:27:28.568131Z","steps":["trace[1740731480] 'process raft request' (duration: 1.812258896s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:28.56819Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.895487ms","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-24T22:27:28.568248Z","caller":"traceutil/trace.go:171","msg":"trace[114842331] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1191; }","duration":"602.99393ms","start":"2026-06-24T22:27:27.96524Z","end":"2026-06-24T22:27:28.568234Z","steps":["trace[114842331] 'agreement among raft nodes before linearized reading' (duration: 602.826086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:28.568269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:26.75453Z","time spent":"1.8136777s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:28.568294Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:27.965217Z","time spent":"603.065392ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T22:27:28.568362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.428964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.148\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-24T22:27:28.568454Z","caller":"traceutil/trace.go:171","msg":"trace[1199012359] range","detail":"{range_begin:/registry/masterleases/199.204.45.148; range_end:; response_count:1; response_revision:1191; }","duration":"156.562626ms","start":"2026-06-24T22:27:28.41187Z","end":"2026-06-24T22:27:28.568432Z","steps":["trace[1199012359] 'agreement among raft nodes before linearized reading' (duration: 156.29062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:28.568728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.741043805s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:28.568809Z","caller":"traceutil/trace.go:171","msg":"trace[166742934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1191; }","duration":"1.741156198s","start":"2026-06-24T22:27:26.827631Z","end":"2026-06-24T22:27:28.568787Z","steps":["trace[166742934] 'agreement among raft nodes before linearized reading' (duration: 1.7399981s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:28.568857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:26.827608Z","time spent":"1.74123775s","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:27:40.894571Z","caller":"traceutil/trace.go:171","msg":"trace[954658266] transaction","detail":"{read_only:false; response_revision:1229; number_of_response:1; }","duration":"266.152175ms","start":"2026-06-24T22:27:40.628376Z","end":"2026-06-24T22:27:40.894528Z","steps":["trace[954658266] 'process raft request' (duration: 265.828717ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:40.894741Z","caller":"traceutil/trace.go:171","msg":"trace[1435316288] linearizableReadLoop","detail":"{readStateIndex:1281; appliedIndex:1280; }","duration":"263.491352ms","start":"2026-06-24T22:27:40.630962Z","end":"2026-06-24T22:27:40.894454Z","steps":["trace[1435316288] 'read index received' (duration: 263.294098ms)","trace[1435316288] 'applied index is now lower than readState.Index' (duration: 195.544µs)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:40.894794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.80102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-24T22:27:40.895088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.490395ms","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-24T22:27:40.895115Z","caller":"traceutil/trace.go:171","msg":"trace[405809993] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1229; }","duration":"264.187749ms","start":"2026-06-24T22:27:40.630919Z","end":"2026-06-24T22:27:40.895107Z","steps":["trace[405809993] 'agreement among raft nodes before linearized reading' (duration: 263.686337ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:40.895132Z","caller":"traceutil/trace.go:171","msg":"trace[397752830] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1229; }","duration":"261.605647ms","start":"2026-06-24T22:27:40.633515Z","end":"2026-06-24T22:27:40.89512Z","steps":["trace[397752830] 'agreement among raft nodes before linearized reading' (duration: 261.441513ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:40.895371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.505307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T22:27:40.89538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.138042ms","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-24T22:27:40.895392Z","caller":"traceutil/trace.go:171","msg":"trace[713551194] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1229; }","duration":"259.565479ms","start":"2026-06-24T22:27:40.635821Z","end":"2026-06-24T22:27:40.895387Z","steps":["trace[713551194] 'agreement among raft nodes before linearized reading' (duration: 259.411966ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:40.895409Z","caller":"traceutil/trace.go:171","msg":"trace[570787795] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1229; }","duration":"260.188734ms","start":"2026-06-24T22:27:40.635211Z","end":"2026-06-24T22:27:40.8954Z","steps":["trace[570787795] 'agreement among raft nodes before linearized reading' (duration: 260.102962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:41.422026Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093320639,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:27:41.791775Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.85982ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:27:41.791923Z","caller":"traceutil/trace.go:171","msg":"trace[514222503] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"892.736ms","start":"2026-06-24T22:27:40.899145Z","end":"2026-06-24T22:27:41.791881Z","steps":["trace[514222503] 'process raft request' (duration: 628.673295ms)","trace[514222503] 'compare' (duration: 263.684526ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:41.792023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:40.899126Z","time spent":"892.854484ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:42.29454Z","caller":"traceutil/trace.go:171","msg":"trace[423200982] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"1.395160265s","start":"2026-06-24T22:27:40.899348Z","end":"2026-06-24T22:27:42.294508Z","steps":["trace[423200982] 'process raft request' (duration: 1.394585101s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:42.294809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:40.899338Z","time spent":"1.395338029s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:42.294926Z","caller":"traceutil/trace.go:171","msg":"trace[570882875] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"1.393561297s","start":"2026-06-24T22:27:40.901338Z","end":"2026-06-24T22:27:42.294899Z","steps":["trace[570882875] 'process raft request' (duration: 1.393108616s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:42.295097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:40.901309Z","time spent":"1.39369972s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:42.295414Z","caller":"traceutil/trace.go:171","msg":"trace[142283100] linearizableReadLoop","detail":"{readStateIndex:1285; appliedIndex:1281; }","duration":"1.37421201s","start":"2026-06-24T22:27:40.92119Z","end":"2026-06-24T22:27:42.295402Z","steps":["trace[142283100] 'read index received' (duration: 606.687676ms)","trace[142283100] 'applied index is now lower than readState.Index' (duration: 767.523574ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:42.295445Z","caller":"traceutil/trace.go:171","msg":"trace[1622929068] transaction","detail":"{read_only:false; response_revision:1233; number_of_response:1; }","duration":"1.394005397s","start":"2026-06-24T22:27:40.901412Z","end":"2026-06-24T22:27:42.295417Z","steps":["trace[1622929068] 'process raft request' (duration: 1.393378233s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:42.295873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:40.901396Z","time spent":"1.394442267s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:42.295516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.374321472s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:42.297113Z","caller":"traceutil/trace.go:171","msg":"trace[1555757649] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1233; }","duration":"1.375945801s","start":"2026-06-24T22:27:40.921152Z","end":"2026-06-24T22:27:42.297098Z","steps":["trace[1555757649] 'agreement among raft nodes before linearized reading' (duration: 1.374325053s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:42.295782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.663933ms","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-24T22:27:42.297306Z","caller":"traceutil/trace.go:171","msg":"trace[145518888] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1233; }","duration":"563.23299ms","start":"2026-06-24T22:27:41.734066Z","end":"2026-06-24T22:27:42.297299Z","steps":["trace[145518888] 'agreement among raft nodes before linearized reading' (duration: 561.640812ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:42.297372Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:41.734009Z","time spent":"563.355782ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-24T22:27:42.297272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:40.92114Z","time spent":"1.376120965s","remote":"127.0.0.1:39536","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true "} {"level":"info","ts":"2026-06-24T22:27:43.174671Z","caller":"traceutil/trace.go:171","msg":"trace[1229188623] transaction","detail":"{read_only:false; response_revision:1235; number_of_response:1; }","duration":"274.980553ms","start":"2026-06-24T22:27:42.899664Z","end":"2026-06-24T22:27:43.174645Z","steps":["trace[1229188623] 'process raft request' (duration: 274.83677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:44.328179Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093320655,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T22:27:44.467513Z","caller":"traceutil/trace.go:171","msg":"trace[1830325539] linearizableReadLoop","detail":"{readStateIndex:1290; appliedIndex:1289; }","duration":"639.934651ms","start":"2026-06-24T22:27:43.827556Z","end":"2026-06-24T22:27:44.467491Z","steps":["trace[1830325539] 'read index received' (duration: 639.732097ms)","trace[1830325539] 'applied index is now lower than readState.Index' (duration: 201.714µs)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:44.467593Z","caller":"traceutil/trace.go:171","msg":"trace[882930316] transaction","detail":"{read_only:false; response_revision:1237; number_of_response:1; }","duration":"669.269184ms","start":"2026-06-24T22:27:43.798268Z","end":"2026-06-24T22:27:44.467538Z","steps":["trace[882930316] 'process raft request' (duration: 669.081099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:44.467699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"640.122196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:27:44.467809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.706934ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T22:27:44.467844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.673286ms","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-24T22:27:44.467862Z","caller":"traceutil/trace.go:171","msg":"trace[436311136] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1237; }","duration":"168.838177ms","start":"2026-06-24T22:27:44.299014Z","end":"2026-06-24T22:27:44.467852Z","steps":["trace[436311136] 'agreement among raft nodes before linearized reading' (duration: 168.648612ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:44.467859Z","caller":"traceutil/trace.go:171","msg":"trace[1528145597] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1237; }","duration":"640.29687ms","start":"2026-06-24T22:27:43.827509Z","end":"2026-06-24T22:27:44.467806Z","steps":["trace[1528145597] 'agreement among raft nodes before linearized reading' (duration: 640.090175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:44.467881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.68872ms","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-24T22:27:44.467894Z","caller":"traceutil/trace.go:171","msg":"trace[1572904730] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1237; }","duration":"155.765479ms","start":"2026-06-24T22:27:44.312113Z","end":"2026-06-24T22:27:44.467879Z","steps":["trace[1572904730] 'agreement among raft nodes before linearized reading' (duration: 155.615495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:44.467904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.657289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-06-24T22:27:44.467913Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:43.827489Z","time spent":"640.412593ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:27:44.467927Z","caller":"traceutil/trace.go:171","msg":"trace[141114536] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1237; }","duration":"167.765131ms","start":"2026-06-24T22:27:44.30015Z","end":"2026-06-24T22:27:44.467915Z","steps":["trace[141114536] 'agreement among raft nodes before linearized reading' (duration: 167.631458ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:44.467947Z","caller":"traceutil/trace.go:171","msg":"trace[1118291845] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1237; }","duration":"167.736771ms","start":"2026-06-24T22:27:44.300197Z","end":"2026-06-24T22:27:44.467934Z","steps":["trace[1118291845] 'agreement among raft nodes before linearized reading' (duration: 167.571757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:44.46815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:43.798249Z","time spent":"669.419258ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:44.99947Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093320659,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:27:45.406685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.825497ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:27:45.406789Z","caller":"traceutil/trace.go:171","msg":"trace[1976169875] transaction","detail":"{read_only:false; response_revision:1238; number_of_response:1; }","duration":"934.909726ms","start":"2026-06-24T22:27:44.471859Z","end":"2026-06-24T22:27:45.406769Z","steps":["trace[1976169875] 'process raft request' (duration: 823.897115ms)","trace[1976169875] 'compare' (duration: 110.640842ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:45.40685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:44.471843Z","time spent":"934.977748ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:45.882053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.401691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:27:45.882329Z","caller":"traceutil/trace.go:171","msg":"trace[930466872] linearizableReadLoop","detail":"{readStateIndex:1294; appliedIndex:1290; }","duration":"1.382957197s","start":"2026-06-24T22:27:44.49935Z","end":"2026-06-24T22:27:45.882307Z","steps":["trace[930466872] 'read index received' (duration: 796.560341ms)","trace[930466872] 'applied index is now lower than readState.Index' (duration: 586.395546ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:45.882337Z","caller":"traceutil/trace.go:171","msg":"trace[1451714646] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"1.408834988s","start":"2026-06-24T22:27:44.473483Z","end":"2026-06-24T22:27:45.882318Z","steps":["trace[1451714646] 'process raft request' (duration: 1.408719825s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:45.882342Z","caller":"traceutil/trace.go:171","msg":"trace[868494458] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"1.408840228s","start":"2026-06-24T22:27:44.473472Z","end":"2026-06-24T22:27:45.882312Z","steps":["trace[868494458] 'process raft request' (duration: 1.408667913s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:45.882379Z","caller":"traceutil/trace.go:171","msg":"trace[481059365] transaction","detail":"{read_only:false; response_revision:1239; number_of_response:1; }","duration":"1.410123779s","start":"2026-06-24T22:27:44.472231Z","end":"2026-06-24T22:27:45.882355Z","steps":["trace[481059365] 'process raft request' (duration: 1.121348199s)","trace[481059365] 'compare' (duration: 288.191536ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:45.882421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:44.473453Z","time spent":"1.40892497s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:45.882437Z","caller":"traceutil/trace.go:171","msg":"trace[1299853437] transaction","detail":"{read_only:false; response_revision:1242; number_of_response:1; }","duration":"701.931845ms","start":"2026-06-24T22:27:45.18049Z","end":"2026-06-24T22:27:45.882422Z","steps":["trace[1299853437] 'process raft request' (duration: 701.748541ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:45.882503Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:44.472194Z","time spent":"1.410231281s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:45.882502Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:44.473451Z","time spent":"1.408964811s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:45.882518Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:45.180469Z","time spent":"702.000767ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":533,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:45.882556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.383208353s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:27:45.882562Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.251543184s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:45.882586Z","caller":"traceutil/trace.go:171","msg":"trace[548406144] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:1242; }","duration":"1.383241094s","start":"2026-06-24T22:27:44.499336Z","end":"2026-06-24T22:27:45.882577Z","steps":["trace[548406144] 'agreement among raft nodes before linearized reading' (duration: 1.383190463s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:45.882616Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:44.499286Z","time spent":"1.383322296s","remote":"127.0.0.1:39502","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true "} {"level":"info","ts":"2026-06-24T22:27:45.882614Z","caller":"traceutil/trace.go:171","msg":"trace[589091787] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:1242; }","duration":"1.251648646s","start":"2026-06-24T22:27:44.630952Z","end":"2026-06-24T22:27:45.8826Z","steps":["trace[589091787] 'agreement among raft nodes before linearized reading' (duration: 1.251567114s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:45.882656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:44.63093Z","time spent":"1.251713598s","remote":"127.0.0.1:37566","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":29,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:27:45.882689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.05449838s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:45.882726Z","caller":"traceutil/trace.go:171","msg":"trace[2104678792] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1242; }","duration":"1.054583763s","start":"2026-06-24T22:27:44.828132Z","end":"2026-06-24T22:27:45.882716Z","steps":["trace[2104678792] 'agreement among raft nodes before linearized reading' (duration: 1.054516281s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:45.882754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:44.828103Z","time spent":"1.054645344s","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:27:47.101403Z","caller":"traceutil/trace.go:171","msg":"trace[1888362808] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"625.231483ms","start":"2026-06-24T22:27:46.476145Z","end":"2026-06-24T22:27:47.101376Z","steps":["trace[1888362808] 'process raft request' (duration: 625.057329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:47.101554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:46.4761Z","time spent":"625.378797ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:47.329071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.559592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:27:47.329146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.6279ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:47.329186Z","caller":"traceutil/trace.go:171","msg":"trace[1821454024] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1244; }","duration":"149.713206ms","start":"2026-06-24T22:27:47.179429Z","end":"2026-06-24T22:27:47.329142Z","steps":["trace[1821454024] 'count revisions from in-memory index tree' (duration: 149.452619ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:47.32951Z","caller":"traceutil/trace.go:171","msg":"trace[1534796677] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:1244; }","duration":"112.763923ms","start":"2026-06-24T22:27:47.216443Z","end":"2026-06-24T22:27:47.329207Z","steps":["trace[1534796677] 'count revisions from in-memory index tree' (duration: 112.541598ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:48.270883Z","caller":"traceutil/trace.go:171","msg":"trace[386798414] transaction","detail":"{read_only:false; response_revision:1246; number_of_response:1; }","duration":"382.143254ms","start":"2026-06-24T22:27:47.888712Z","end":"2026-06-24T22:27:48.270856Z","steps":["trace[386798414] 'process raft request' (duration: 381.932029ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:48.271108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:47.888698Z","time spent":"382.289697ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:48.663622Z","caller":"traceutil/trace.go:171","msg":"trace[1287192629] transaction","detail":"{read_only:false; response_revision:1247; number_of_response:1; }","duration":"773.956095ms","start":"2026-06-24T22:27:47.889612Z","end":"2026-06-24T22:27:48.663568Z","steps":["trace[1287192629] 'process raft request' (duration: 736.600133ms)","trace[1287192629] 'compare' (duration: 37.054275ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:48.663721Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:47.889603Z","time spent":"774.067769ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:48.663811Z","caller":"traceutil/trace.go:171","msg":"trace[1813141379] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"773.156076ms","start":"2026-06-24T22:27:47.890634Z","end":"2026-06-24T22:27:48.66379Z","steps":["trace[1813141379] 'process raft request' (duration: 772.90127ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:48.663855Z","caller":"traceutil/trace.go:171","msg":"trace[639684803] linearizableReadLoop","detail":"{readStateIndex:1302; appliedIndex:1299; }","duration":"250.332821ms","start":"2026-06-24T22:27:48.413516Z","end":"2026-06-24T22:27:48.663848Z","steps":["trace[639684803] 'read index received' (duration: 212.722593ms)","trace[639684803] 'applied index is now lower than readState.Index' (duration: 37.609708ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:48.663947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"250.446814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.148\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-06-24T22:27:48.663942Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:47.890627Z","time spent":"773.245328ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:48.663968Z","caller":"traceutil/trace.go:171","msg":"trace[1717423275] range","detail":"{range_begin:/registry/masterleases/199.204.45.148; range_end:; response_count:1; response_revision:1249; }","duration":"250.510886ms","start":"2026-06-24T22:27:48.413451Z","end":"2026-06-24T22:27:48.663962Z","steps":["trace[1717423275] 'agreement among raft nodes before linearized reading' (duration: 250.433144ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:48.663949Z","caller":"traceutil/trace.go:171","msg":"trace[1363381950] transaction","detail":"{read_only:false; response_revision:1249; number_of_response:1; }","duration":"770.654958ms","start":"2026-06-24T22:27:47.893245Z","end":"2026-06-24T22:27:48.6639Z","steps":["trace[1363381950] 'process raft request' (duration: 770.462394ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:48.664092Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:47.893218Z","time spent":"770.800841ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:49.164253Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093320688,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-24T22:27:49.655614Z","caller":"traceutil/trace.go:171","msg":"trace[1181081729] transaction","detail":"{read_only:false; response_revision:1250; number_of_response:1; }","duration":"1.011940986s","start":"2026-06-24T22:27:48.643616Z","end":"2026-06-24T22:27:49.655557Z","steps":["trace[1181081729] 'process raft request' (duration: 1.011733401s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:49.655806Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:48.643528Z","time spent":"1.012183722s","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:27:50.204048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"437.772307ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:41"} {"level":"warn","ts":"2026-06-24T22:27:50.204316Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:48.664777Z","time spent":"1.539526084s","remote":"127.0.0.1:37430","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-24T22:27:50.204423Z","caller":"traceutil/trace.go:171","msg":"trace[571246692] linearizableReadLoop","detail":"{readStateIndex:1304; appliedIndex:1302; }","duration":"1.540517828s","start":"2026-06-24T22:27:48.66387Z","end":"2026-06-24T22:27:50.204387Z","steps":["trace[571246692] 'read index received' (duration: 991.598556ms)","trace[571246692] 'applied index is now lower than readState.Index' (duration: 548.916362ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:50.204479Z","caller":"traceutil/trace.go:171","msg":"trace[1771000903] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"498.614154ms","start":"2026-06-24T22:27:49.705838Z","end":"2026-06-24T22:27:50.204452Z","steps":["trace[1771000903] 'process raft request' (duration: 498.504502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.204597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.785604475s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T22:27:50.204622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:49.705816Z","time spent":"498.717586ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:50.204585Z","caller":"traceutil/trace.go:171","msg":"trace[966452085] transaction","detail":"{read_only:false; response_revision:1251; number_of_response:1; }","duration":"539.983281ms","start":"2026-06-24T22:27:49.664539Z","end":"2026-06-24T22:27:50.204522Z","steps":["trace[966452085] 'process raft request' (duration: 539.662243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.204614Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.196298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:50.204671Z","caller":"traceutil/trace.go:171","msg":"trace[453825159] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:1252; }","duration":"1.785708927s","start":"2026-06-24T22:27:48.418945Z","end":"2026-06-24T22:27:50.204654Z","steps":["trace[453825159] 'agreement among raft nodes before linearized reading' (duration: 1.785536043s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.204682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.824665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:27:50.204681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.432715971s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:5331"} {"level":"warn","ts":"2026-06-24T22:27:50.204717Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:48.418939Z","time spent":"1.785766328s","remote":"127.0.0.1:37806","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":31,"request content":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true "} {"level":"info","ts":"2026-06-24T22:27:50.204724Z","caller":"traceutil/trace.go:171","msg":"trace[1677377047] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:1252; }","duration":"237.895987ms","start":"2026-06-24T22:27:49.966812Z","end":"2026-06-24T22:27:50.204708Z","steps":["trace[1677377047] 'agreement among raft nodes before linearized reading' (duration: 237.840916ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:50.204718Z","caller":"traceutil/trace.go:171","msg":"trace[800677645] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1252; }","duration":"701.351361ms","start":"2026-06-24T22:27:49.503348Z","end":"2026-06-24T22:27:50.204699Z","steps":["trace[800677645] 'agreement among raft nodes before linearized reading' (duration: 701.218528ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.204788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:49.503326Z","time spent":"701.441694ms","remote":"127.0.0.1:37718","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/ingressclasses/\" range_end:\"/registry/ingressclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:27:50.204824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:49.664515Z","time spent":"540.193566ms","remote":"127.0.0.1:37484","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":751,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-24T22:27:50.20486Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.099509884s","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-24T22:27:50.204909Z","caller":"traceutil/trace.go:171","msg":"trace[2131139051] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1252; }","duration":"1.099585605s","start":"2026-06-24T22:27:49.105316Z","end":"2026-06-24T22:27:50.204902Z","steps":["trace[2131139051] 'agreement among raft nodes before linearized reading' (duration: 1.099496233s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.204899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"362.277424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-24T22:27:50.204939Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:49.105296Z","time spent":"1.099635597s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-24T22:27:50.204722Z","caller":"traceutil/trace.go:171","msg":"trace[1714179641] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:1252; }","duration":"1.432798653s","start":"2026-06-24T22:27:48.771913Z","end":"2026-06-24T22:27:50.204712Z","steps":["trace[1714179641] 'agreement among raft nodes before linearized reading' (duration: 1.43263793s)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:50.204972Z","caller":"traceutil/trace.go:171","msg":"trace[774566355] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:1252; }","duration":"362.401337ms","start":"2026-06-24T22:27:49.842556Z","end":"2026-06-24T22:27:50.204957Z","steps":["trace[774566355] 'agreement among raft nodes before linearized reading' (duration: 362.265524ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.204998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:48.771894Z","time spent":"1.433096161s","remote":"127.0.0.1:37594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":5355,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-24T22:27:50.205009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:49.842535Z","time spent":"362.467569ms","remote":"127.0.0.1:37684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":31,"request content":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true "} {"level":"warn","ts":"2026-06-24T22:27:50.20501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.377032386s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:50.205045Z","caller":"traceutil/trace.go:171","msg":"trace[1687271236] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1252; }","duration":"1.377118489s","start":"2026-06-24T22:27:48.827917Z","end":"2026-06-24T22:27:50.205035Z","steps":["trace[1687271236] 'agreement among raft nodes before linearized reading' (duration: 1.377068848s)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.204795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"771.19266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-24T22:27:50.205089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:48.827887Z","time spent":"1.37719602s","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:27:50.205098Z","caller":"traceutil/trace.go:171","msg":"trace[659994179] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1252; }","duration":"771.507608ms","start":"2026-06-24T22:27:49.433577Z","end":"2026-06-24T22:27:50.205085Z","steps":["trace[659994179] 'agreement among raft nodes before linearized reading' (duration: 771.16309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.205137Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:49.433563Z","time spent":"771.562029ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-24T22:27:50.402392Z","caller":"traceutil/trace.go:171","msg":"trace[1131393699] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1307; }","duration":"173.024566ms","start":"2026-06-24T22:27:50.229342Z","end":"2026-06-24T22:27:50.402367Z","steps":["trace[1131393699] 'read index received' (duration: 165.57917ms)","trace[1131393699] 'applied index is now lower than readState.Index' (duration: 7.443726ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:50.402516Z","caller":"traceutil/trace.go:171","msg":"trace[845787604] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"193.500609ms","start":"2026-06-24T22:27:50.209Z","end":"2026-06-24T22:27:50.402501Z","steps":["trace[845787604] 'process raft request' (duration: 193.259393ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:50.402599Z","caller":"traceutil/trace.go:171","msg":"trace[711021801] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"193.604092ms","start":"2026-06-24T22:27:50.20895Z","end":"2026-06-24T22:27:50.402554Z","steps":["trace[711021801] 'process raft request' (duration: 185.948952ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:50.402689Z","caller":"traceutil/trace.go:171","msg":"trace[390426860] transaction","detail":"{read_only:false; response_revision:1256; number_of_response:1; }","duration":"193.1194ms","start":"2026-06-24T22:27:50.209554Z","end":"2026-06-24T22:27:50.402674Z","steps":["trace[390426860] 'process raft request' (duration: 192.766172ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.402896Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.540088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-24T22:27:50.402983Z","caller":"traceutil/trace.go:171","msg":"trace[862419447] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1256; }","duration":"173.680911ms","start":"2026-06-24T22:27:50.229281Z","end":"2026-06-24T22:27:50.402962Z","steps":["trace[862419447] 'agreement among raft nodes before linearized reading' (duration: 173.475936ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:50.425578Z","caller":"traceutil/trace.go:171","msg":"trace[2035438485] transaction","detail":"{read_only:false; response_revision:1257; number_of_response:1; }","duration":"148.861985ms","start":"2026-06-24T22:27:50.276695Z","end":"2026-06-24T22:27:50.425557Z","steps":["trace[2035438485] 'process raft request' (duration: 148.667681ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:50.425641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.291137ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:27:50.425663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.753938ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:50.425718Z","caller":"traceutil/trace.go:171","msg":"trace[104168369] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1257; }","duration":"188.42344ms","start":"2026-06-24T22:27:50.237275Z","end":"2026-06-24T22:27:50.425699Z","steps":["trace[104168369] 'agreement among raft nodes before linearized reading' (duration: 188.303377ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:50.425743Z","caller":"traceutil/trace.go:171","msg":"trace[1232596408] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:1257; }","duration":"155.890071ms","start":"2026-06-24T22:27:50.269835Z","end":"2026-06-24T22:27:50.425725Z","steps":["trace[1232596408] 'agreement among raft nodes before linearized reading' (duration: 155.740448ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:51.026078Z","caller":"traceutil/trace.go:171","msg":"trace[103864527] transaction","detail":"{read_only:false; response_revision:1258; number_of_response:1; }","duration":"352.873122ms","start":"2026-06-24T22:27:50.673177Z","end":"2026-06-24T22:27:51.02605Z","steps":["trace[103864527] 'process raft request' (duration: 352.708958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:51.026369Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:50.673164Z","time spent":"352.986035ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:51.564178Z","caller":"traceutil/trace.go:171","msg":"trace[834135239] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"890.724902ms","start":"2026-06-24T22:27:50.673425Z","end":"2026-06-24T22:27:51.56415Z","steps":["trace[834135239] 'process raft request' (duration: 864.960474ms)","trace[834135239] 'compare' (duration: 25.173844ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:51.56436Z","caller":"traceutil/trace.go:171","msg":"trace[812577388] linearizableReadLoop","detail":"{readStateIndex:1314; appliedIndex:1311; }","duration":"583.951818ms","start":"2026-06-24T22:27:50.980378Z","end":"2026-06-24T22:27:51.56433Z","steps":["trace[812577388] 'read index received' (duration: 45.488404ms)","trace[812577388] 'applied index is now lower than readState.Index' (duration: 538.462084ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:51.564518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"584.124782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-24T22:27:51.564564Z","caller":"traceutil/trace.go:171","msg":"trace[857842764] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:1260; }","duration":"584.227835ms","start":"2026-06-24T22:27:50.980326Z","end":"2026-06-24T22:27:51.564554Z","steps":["trace[857842764] 'agreement among raft nodes before linearized reading' (duration: 584.112712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:51.5646Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:50.980304Z","time spent":"584.287287ms","remote":"127.0.0.1:37560","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true "} {"level":"info","ts":"2026-06-24T22:27:51.564887Z","caller":"traceutil/trace.go:171","msg":"trace[1970895235] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"891.138952ms","start":"2026-06-24T22:27:50.673735Z","end":"2026-06-24T22:27:51.564874Z","steps":["trace[1970895235] 'process raft request' (duration: 890.334713ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:51.564897Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:50.673418Z","time spent":"890.823145ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:51.564979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:50.673718Z","time spent":"891.204774ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-24T22:27:55.198291Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":16702336972093320746,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-24T22:27:55.559487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.933859ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-24T22:27:55.559652Z","caller":"traceutil/trace.go:171","msg":"trace[43986930] linearizableReadLoop","detail":"{readStateIndex:1337; appliedIndex:1336; }","duration":"862.292102ms","start":"2026-06-24T22:27:54.697332Z","end":"2026-06-24T22:27:55.559624Z","steps":["trace[43986930] 'read index received' (duration: 527.092946ms)","trace[43986930] 'applied index is now lower than readState.Index' (duration: 335.196166ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:55.559817Z","caller":"traceutil/trace.go:171","msg":"trace[1727161063] transaction","detail":"{read_only:false; response_revision:1282; number_of_response:1; }","duration":"1.122919666s","start":"2026-06-24T22:27:54.436873Z","end":"2026-06-24T22:27:55.559793Z","steps":["trace[1727161063] 'process raft request' (duration: 787.586067ms)","trace[1727161063] 'compare' (duration: 334.691934ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:55.559902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"862.548958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-9xqxf\" ","response":"range_response_count:1 size:11061"} {"level":"warn","ts":"2026-06-24T22:27:55.559914Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.561069ms","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-24T22:27:55.559931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"732.108438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-24T22:27:55.559946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:54.43686Z","time spent":"1.123021749s","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-24T22:27:55.559958Z","caller":"traceutil/trace.go:171","msg":"trace[332782443] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1282; }","duration":"519.645651ms","start":"2026-06-24T22:27:55.040302Z","end":"2026-06-24T22:27:55.559948Z","steps":["trace[332782443] 'agreement among raft nodes before linearized reading' (duration: 519.478907ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:27:55.559955Z","caller":"traceutil/trace.go:171","msg":"trace[130929065] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-9xqxf; range_end:; response_count:1; response_revision:1282; }","duration":"862.618289ms","start":"2026-06-24T22:27:54.697325Z","end":"2026-06-24T22:27:55.559943Z","steps":["trace[130929065] 'agreement among raft nodes before linearized reading' (duration: 862.433325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:55.559997Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:55.040275Z","time spent":"519.714172ms","remote":"127.0.0.1:37678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-24T22:27:55.560001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:54.697243Z","time spent":"862.747342ms","remote":"127.0.0.1:37596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":11085,"request content":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-9xqxf\" "} {"level":"info","ts":"2026-06-24T22:27:55.560705Z","caller":"traceutil/trace.go:171","msg":"trace[2040631870] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1282; }","duration":"732.164469ms","start":"2026-06-24T22:27:54.827789Z","end":"2026-06-24T22:27:55.559953Z","steps":["trace[2040631870] 'agreement among raft nodes before linearized reading' (duration: 731.983935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:55.560779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-24T22:27:54.827776Z","time spent":"732.983909ms","remote":"127.0.0.1:37402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-24T22:27:56.830657Z","caller":"traceutil/trace.go:171","msg":"trace[1872629258] transaction","detail":"{read_only:false; response_revision:1292; number_of_response:1; }","duration":"263.505722ms","start":"2026-06-24T22:27:56.567124Z","end":"2026-06-24T22:27:56.830629Z","steps":["trace[1872629258] 'process raft request' (duration: 219.903232ms)","trace[1872629258] 'compare' (duration: 42.980275ms)"],"step_count":2} {"level":"info","ts":"2026-06-24T22:27:56.83074Z","caller":"traceutil/trace.go:171","msg":"trace[1003201562] linearizableReadLoop","detail":"{readStateIndex:1347; appliedIndex:1346; }","duration":"245.889287ms","start":"2026-06-24T22:27:56.584726Z","end":"2026-06-24T22:27:56.830616Z","steps":["trace[1003201562] 'read index received' (duration: 202.317288ms)","trace[1003201562] 'applied index is now lower than readState.Index' (duration: 43.570259ms)"],"step_count":2} {"level":"warn","ts":"2026-06-24T22:27:56.831084Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.720098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-06-24T22:27:56.831137Z","caller":"traceutil/trace.go:171","msg":"trace[1929110715] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:1292; }","duration":"100.8192ms","start":"2026-06-24T22:27:56.730284Z","end":"2026-06-24T22:27:56.831103Z","steps":["trace[1929110715] 'agreement among raft nodes before linearized reading' (duration: 100.555844ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:56.831144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.382198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-24T22:27:56.831245Z","caller":"traceutil/trace.go:171","msg":"trace[929456537] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1292; }","duration":"246.563163ms","start":"2026-06-24T22:27:56.584658Z","end":"2026-06-24T22:27:56.831221Z","steps":["trace[929456537] 'agreement among raft nodes before linearized reading' (duration: 246.124372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:27:56.832387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.246035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:125245"} {"level":"info","ts":"2026-06-24T22:27:56.832654Z","caller":"traceutil/trace.go:171","msg":"trace[707935160] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:1292; }","duration":"105.560142ms","start":"2026-06-24T22:27:56.727072Z","end":"2026-06-24T22:27:56.832632Z","steps":["trace[707935160] 'agreement among raft nodes before linearized reading' (duration: 103.738609ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:28:00.611338Z","caller":"traceutil/trace.go:171","msg":"trace[683092637] transaction","detail":"{read_only:false; response_revision:1318; number_of_response:1; }","duration":"122.086453ms","start":"2026-06-24T22:28:00.489196Z","end":"2026-06-24T22:28:00.611283Z","steps":["trace[683092637] 'process raft request' (duration: 121.887008ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:28:00.640788Z","caller":"traceutil/trace.go:171","msg":"trace[1476660806] transaction","detail":"{read_only:false; response_revision:1319; number_of_response:1; }","duration":"110.392997ms","start":"2026-06-24T22:28:00.53037Z","end":"2026-06-24T22:28:00.640763Z","steps":["trace[1476660806] 'process raft request' (duration: 110.223654ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:28:47.303077Z","caller":"traceutil/trace.go:171","msg":"trace[1768700360] transaction","detail":"{read_only:false; response_revision:1555; number_of_response:1; }","duration":"119.865569ms","start":"2026-06-24T22:28:47.183181Z","end":"2026-06-24T22:28:47.303047Z","steps":["trace[1768700360] 'process raft request' (duration: 119.724566ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:28:49.160354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.017892ms","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-24T22:28:49.16044Z","caller":"traceutil/trace.go:171","msg":"trace[187942017] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1562; }","duration":"204.209357ms","start":"2026-06-24T22:28:48.956211Z","end":"2026-06-24T22:28:49.16042Z","steps":["trace[187942017] 'range keys from in-memory index tree' (duration: 203.811098ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:28:49.160472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.16841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-24T22:28:49.160574Z","caller":"traceutil/trace.go:171","msg":"trace[687963082] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1562; }","duration":"205.337074ms","start":"2026-06-24T22:28:48.955215Z","end":"2026-06-24T22:28:49.160552Z","steps":["trace[687963082] 'range keys from in-memory index tree' (duration: 204.935104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-24T22:28:49.16105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.613465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-24T22:28:49.161721Z","caller":"traceutil/trace.go:171","msg":"trace[540710752] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1562; }","duration":"245.317561ms","start":"2026-06-24T22:28:48.916386Z","end":"2026-06-24T22:28:49.161704Z","steps":["trace[540710752] 'range keys from in-memory index tree' (duration: 243.670992ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:30:04.22009Z","caller":"traceutil/trace.go:171","msg":"trace[438403232] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"123.74288ms","start":"2026-06-24T22:30:04.096321Z","end":"2026-06-24T22:30:04.220064Z","steps":["trace[438403232] 'process raft request' (duration: 123.558276ms)"],"step_count":1} {"level":"info","ts":"2026-06-24T22:30:17.477733Z","caller":"traceutil/trace.go:171","msg":"trace[387929087] transaction","detail":"{read_only:false; response_revision:1968; number_of_response:1; }","duration":"108.346262ms","start":"2026-06-24T22:30:17.369361Z","end":"2026-06-24T22:30:17.477707Z","steps":["trace[387929087] 'process raft request' (duration: 108.202759ms)"],"step_count":1}