{"level":"warn","ts":"2026-06-15T20:02:38.80671Z","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-15T20:02:38.806789Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.123:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.123:2380","--initial-cluster=instance=https://199.19.213.123:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.123:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.123: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-15T20:02:38.806861Z","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-15T20:02:38.806875Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.123:2380"]} {"level":"info","ts":"2026-06-15T20:02:38.806893Z","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-15T20:02:38.807551Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"]} {"level":"info","ts":"2026-06-15T20:02:38.807639Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.123: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-15T20:02:38.810192Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.341961ms"} {"level":"info","ts":"2026-06-15T20:02:38.814562Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3e4829a3cabe4fce","cluster-id":"b469cfed817d8605"} {"level":"info","ts":"2026-06-15T20:02:38.814619Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=()"} {"level":"info","ts":"2026-06-15T20:02:38.814635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 0"} {"level":"info","ts":"2026-06-15T20:02:38.814663Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3e4829a3cabe4fce [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-15T20:02:38.81467Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became follower at term 1"} {"level":"info","ts":"2026-06-15T20:02:38.814704Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"} {"level":"warn","ts":"2026-06-15T20:02:38.8192Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-15T20:02:38.820388Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-15T20:02:38.822159Z","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-15T20:02:38.825153Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3e4829a3cabe4fce","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-15T20:02:38.825329Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3e4829a3cabe4fce","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-15T20:02:38.825426Z","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-15T20:02:38.825494Z","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-15T20:02:38.825514Z","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-15T20:02:38.82835Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce switched to configuration voters=(4487882812132577230)"} {"level":"info","ts":"2026-06-15T20:02:38.828548Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","added-peer-id":"3e4829a3cabe4fce","added-peer-peer-urls":["https://199.19.213.123:2380"]} {"level":"info","ts":"2026-06-15T20:02:38.833338Z","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-15T20:02:38.833432Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.123:2380"} {"level":"info","ts":"2026-06-15T20:02:38.833497Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.123:2380"} {"level":"info","ts":"2026-06-15T20:02:38.833687Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-15T20:02:38.833901Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3e4829a3cabe4fce","initial-advertise-peer-urls":["https://199.19.213.123:2380"],"listen-peer-urls":["https://199.19.213.123:2380"],"advertise-client-urls":["https://199.19.213.123:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.123:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-15T20:02:39.215425Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce is starting a new election at term 1"} {"level":"info","ts":"2026-06-15T20:02:39.21549Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became pre-candidate at term 1"} {"level":"info","ts":"2026-06-15T20:02:39.21553Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgPreVoteResp from 3e4829a3cabe4fce at term 1"} {"level":"info","ts":"2026-06-15T20:02:39.215548Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became candidate at term 2"} {"level":"info","ts":"2026-06-15T20:02:39.215559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce received MsgVoteResp from 3e4829a3cabe4fce at term 2"} {"level":"info","ts":"2026-06-15T20:02:39.215575Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3e4829a3cabe4fce became leader at term 2"} {"level":"info","ts":"2026-06-15T20:02:39.215589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3e4829a3cabe4fce elected leader 3e4829a3cabe4fce at term 2"} {"level":"info","ts":"2026-06-15T20:02:39.216806Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:02:39.217624Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3e4829a3cabe4fce","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.123:2379]}","request-path":"/0/members/3e4829a3cabe4fce/attributes","cluster-id":"b469cfed817d8605","publish-timeout":"7s"} {"level":"info","ts":"2026-06-15T20:02:39.217992Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T20:02:39.218151Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"b469cfed817d8605","local-member-id":"3e4829a3cabe4fce","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:02:39.218526Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-15T20:02:39.220023Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:02:39.220223Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-15T20:02:39.220081Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-15T20:02:39.220258Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-15T20:02:39.22141Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.123:2379"} {"level":"info","ts":"2026-06-15T20:02:39.222041Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-15T20:02:49.674427Z","caller":"traceutil/trace.go:171","msg":"trace[1230061904] transaction","detail":"{read_only:false; response_revision:390; number_of_response:1; }","duration":"128.720668ms","start":"2026-06-15T20:02:49.54568Z","end":"2026-06-15T20:02:49.674401Z","steps":["trace[1230061904] 'process raft request' (duration: 128.559624ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:02:50.891633Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750708376984248690,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T20:02:51.391886Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750708376984248690,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T20:02:51.453285Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.221486246s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T20:02:51.454225Z","caller":"traceutil/trace.go:171","msg":"trace[48756840] transaction","detail":"{read_only:false; response_revision:391; number_of_response:1; }","duration":"1.224570598s","start":"2026-06-15T20:02:50.229628Z","end":"2026-06-15T20:02:51.454199Z","steps":["trace[48756840] 'process raft request' (duration: 1.224410823s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:02:51.455053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:02:50.22961Z","time spent":"1.22467531s","remote":"127.0.0.1:59870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2903,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:02:51.645873Z","caller":"traceutil/trace.go:171","msg":"trace[686508553] linearizableReadLoop","detail":"{readStateIndex:403; appliedIndex:401; }","duration":"1.254588673s","start":"2026-06-15T20:02:50.391262Z","end":"2026-06-15T20:02:51.645851Z","steps":["trace[686508553] 'read index received' (duration: 1.062772243s)","trace[686508553] 'applied index is now lower than readState.Index' (duration: 191.81551ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:02:51.645974Z","caller":"traceutil/trace.go:171","msg":"trace[354147958] transaction","detail":"{read_only:false; response_revision:392; number_of_response:1; }","duration":"523.632962ms","start":"2026-06-15T20:02:51.122333Z","end":"2026-06-15T20:02:51.645966Z","steps":["trace[354147958] 'process raft request' (duration: 433.982057ms)","trace[354147958] 'compare' (duration: 89.361998ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:02:51.646054Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:02:51.122298Z","time spent":"523.695774ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:02:51.64624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"639.145016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-15T20:02:51.64639Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"820.593674ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-06-15T20:02:51.646413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.255151807s","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-15T20:02:51.646458Z","caller":"traceutil/trace.go:171","msg":"trace[974769510] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:392; }","duration":"1.255236019s","start":"2026-06-15T20:02:50.391214Z","end":"2026-06-15T20:02:51.64645Z","steps":["trace[974769510] 'agreement among raft nodes before linearized reading' (duration: 1.255159358s)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:02:51.646466Z","caller":"traceutil/trace.go:171","msg":"trace[1225500308] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:392; }","duration":"820.711457ms","start":"2026-06-15T20:02:50.825724Z","end":"2026-06-15T20:02:51.646435Z","steps":["trace[1225500308] 'agreement among raft nodes before linearized reading' (duration: 820.628795ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:02:51.646484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:02:50.391195Z","time spent":"1.25528455s","remote":"127.0.0.1:59678","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-15T20:02:51.646524Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:02:50.825701Z","time spent":"820.8127ms","remote":"127.0.0.1:59678","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-15T20:02:51.6464Z","caller":"traceutil/trace.go:171","msg":"trace[1077589543] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:392; }","duration":"639.369841ms","start":"2026-06-15T20:02:51.007001Z","end":"2026-06-15T20:02:51.646371Z","steps":["trace[1077589543] 'agreement among raft nodes before linearized reading' (duration: 639.081614ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:02:51.646668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:02:51.006978Z","time spent":"639.67857ms","remote":"127.0.0.1:59678","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-15T20:02:51.646239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.031464464s","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-15T20:02:51.64674Z","caller":"traceutil/trace.go:171","msg":"trace[1752303143] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:392; }","duration":"1.032054069s","start":"2026-06-15T20:02:50.614678Z","end":"2026-06-15T20:02:51.646732Z","steps":["trace[1752303143] 'agreement among raft nodes before linearized reading' (duration: 1.031357641s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:02:51.646774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:02:50.614659Z","time spent":"1.03210705s","remote":"127.0.0.1:59678","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-15T20:03:21.525635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.422933669s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:03:21.525758Z","caller":"traceutil/trace.go:171","msg":"trace[98968524] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"1.861806774s","start":"2026-06-15T20:03:19.663931Z","end":"2026-06-15T20:03:21.525738Z","steps":["trace[98968524] 'process raft request' (duration: 438.490616ms)","trace[98968524] 'compare' (duration: 1.422535708s)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:03:21.52581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.6639Z","time spent":"1.861885825s","remote":"127.0.0.1:59882","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4387,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:03:21.526279Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.405493252s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T20:03:21.526924Z","caller":"traceutil/trace.go:171","msg":"trace[414665397] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"1.811913448s","start":"2026-06-15T20:03:19.714975Z","end":"2026-06-15T20:03:21.526889Z","steps":["trace[414665397] 'process raft request' (duration: 1.81160768s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.527043Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.714951Z","time spent":"1.812036411s","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3104,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:03:21.527265Z","caller":"traceutil/trace.go:171","msg":"trace[287652802] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"1.800487749s","start":"2026-06-15T20:03:19.726713Z","end":"2026-06-15T20:03:21.527201Z","steps":["trace[287652802] 'process raft request' (duration: 1.800051298s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.527924Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.726691Z","time spent":"1.800678774s","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":14661,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:03:21.531307Z","caller":"traceutil/trace.go:171","msg":"trace[1351559124] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"1.655014662s","start":"2026-06-15T20:03:19.876262Z","end":"2026-06-15T20:03:21.531277Z","steps":["trace[1351559124] 'process raft request' (duration: 1.651824768s)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:21.531483Z","caller":"traceutil/trace.go:171","msg":"trace[88498949] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:630; }","duration":"1.687705676s","start":"2026-06-15T20:03:19.84375Z","end":"2026-06-15T20:03:21.531456Z","steps":["trace[88498949] 'read index received' (duration: 258.601967ms)","trace[88498949] 'applied index is now lower than readState.Index' (duration: 1.429100199s)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:03:21.531693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.687929364s","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-15T20:03:21.531662Z","caller":"traceutil/trace.go:171","msg":"trace[647543247] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"1.619733258s","start":"2026-06-15T20:03:19.911745Z","end":"2026-06-15T20:03:21.531479Z","steps":["trace[647543247] 'process raft request' (duration: 1.619437111s)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:21.531741Z","caller":"traceutil/trace.go:171","msg":"trace[1020588536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:613; }","duration":"1.688051707s","start":"2026-06-15T20:03:19.843677Z","end":"2026-06-15T20:03:21.531729Z","steps":["trace[1020588536] 'agreement among raft nodes before linearized reading' (duration: 1.687893262s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.53177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.843615Z","time spent":"1.68814849s","remote":"127.0.0.1:59678","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-15T20:03:21.531871Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.876218Z","time spent":"1.655387631s","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":570081,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:03:21.531899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.911621Z","time spent":"1.62016953s","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9343,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:03:21.556611Z","caller":"traceutil/trace.go:171","msg":"trace[2006972521] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"241.415838ms","start":"2026-06-15T20:03:21.31517Z","end":"2026-06-15T20:03:21.556586Z","steps":["trace[2006972521] 'process raft request' (duration: 241.385917ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:21.55697Z","caller":"traceutil/trace.go:171","msg":"trace[1911009365] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"1.446085105s","start":"2026-06-15T20:03:20.110879Z","end":"2026-06-15T20:03:21.556964Z","steps":["trace[1911009365] 'process raft request' (duration: 1.445497679s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.557048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:20.110826Z","time spent":"1.446163967s","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3202,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:03:21.557119Z","caller":"traceutil/trace.go:171","msg":"trace[850767860] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"1.243600245s","start":"2026-06-15T20:03:20.313515Z","end":"2026-06-15T20:03:21.557115Z","steps":["trace[850767860] 'process raft request' (duration: 1.242973999s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.557153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:20.313466Z","time spent":"1.243669737s","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":12244,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:03:21.557229Z","caller":"traceutil/trace.go:171","msg":"trace[967343089] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"1.045424139s","start":"2026-06-15T20:03:20.511801Z","end":"2026-06-15T20:03:21.557225Z","steps":["trace[967343089] 'process raft request' (duration: 1.04471047s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.557261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:20.511759Z","time spent":"1.04548497s","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3353,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-15T20:03:21.557321Z","caller":"traceutil/trace.go:171","msg":"trace[1628559345] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"845.363813ms","start":"2026-06-15T20:03:20.711954Z","end":"2026-06-15T20:03:21.557317Z","steps":["trace[1628559345] 'process raft request' (duration: 844.576123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.557346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:20.711918Z","time spent":"845.416905ms","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8270,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-15T20:03:21.557705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"647.905806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:03:21.55774Z","caller":"traceutil/trace.go:171","msg":"trace[923325917] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:618; }","duration":"648.000839ms","start":"2026-06-15T20:03:20.90973Z","end":"2026-06-15T20:03:21.557731Z","steps":["trace[923325917] 'agreement among raft nodes before linearized reading' (duration: 647.909186ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.557758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:20.909702Z","time spent":"648.05222ms","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-15T20:03:21.557791Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.710602498s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T20:03:21.557848Z","caller":"traceutil/trace.go:171","msg":"trace[235242347] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:618; }","duration":"1.710687399s","start":"2026-06-15T20:03:19.847146Z","end":"2026-06-15T20:03:21.557833Z","steps":["trace[235242347] 'agreement among raft nodes before linearized reading' (duration: 1.710487644s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.557886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.84713Z","time spent":"1.710748601s","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-15T20:03:21.557979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.611919ms","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-15T20:03:21.557998Z","caller":"traceutil/trace.go:171","msg":"trace[171428139] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:618; }","duration":"237.67394ms","start":"2026-06-15T20:03:21.32032Z","end":"2026-06-15T20:03:21.557994Z","steps":["trace[171428139] 'agreement among raft nodes before linearized reading' (duration: 237.613819ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.558056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"851.74315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:03:21.558094Z","caller":"traceutil/trace.go:171","msg":"trace[628519433] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:618; }","duration":"851.820442ms","start":"2026-06-15T20:03:20.706264Z","end":"2026-06-15T20:03:21.558084Z","steps":["trace[628519433] 'agreement among raft nodes before linearized reading' (duration: 851.767031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.558123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:20.706233Z","time spent":"851.883813ms","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T20:03:21.558064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"447.785809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-15T20:03:21.558251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.710798862s","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-15T20:03:21.558267Z","caller":"traceutil/trace.go:171","msg":"trace[1633473579] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"1.710815233s","start":"2026-06-15T20:03:19.847447Z","end":"2026-06-15T20:03:21.558262Z","steps":["trace[1633473579] 'agreement among raft nodes before linearized reading' (duration: 1.710780291s)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:21.558267Z","caller":"traceutil/trace.go:171","msg":"trace[1755876954] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:618; }","duration":"448.028655ms","start":"2026-06-15T20:03:21.110225Z","end":"2026-06-15T20:03:21.558254Z","steps":["trace[1755876954] 'agreement among raft nodes before linearized reading' (duration: 447.825429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.558285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.847424Z","time spent":"1.710858174s","remote":"127.0.0.1:59678","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-15T20:03:21.558297Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:21.110193Z","time spent":"448.094897ms","remote":"127.0.0.1:59450","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":28,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumclusterwidenetworkpolicies.cilium.io\" "} {"level":"warn","ts":"2026-06-15T20:03:21.558358Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.710952986s","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-15T20:03:21.558381Z","caller":"traceutil/trace.go:171","msg":"trace[449431677] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:618; }","duration":"1.711029348s","start":"2026-06-15T20:03:19.847346Z","end":"2026-06-15T20:03:21.558376Z","steps":["trace[449431677] 'agreement among raft nodes before linearized reading' (duration: 1.710994297s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:21.558397Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:19.84734Z","time spent":"1.711052989s","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-15T20:03:21.667922Z","caller":"traceutil/trace.go:171","msg":"trace[619100097] transaction","detail":"{read_only:false; response_revision:621; number_of_response:1; }","duration":"102.838601ms","start":"2026-06-15T20:03:21.565023Z","end":"2026-06-15T20:03:21.667862Z","steps":["trace[619100097] 'process raft request' (duration: 67.036115ms)","trace[619100097] 'compare' (duration: 35.362965ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:03:27.205978Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750708376984249238,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T20:03:27.307829Z","caller":"traceutil/trace.go:171","msg":"trace[2098972850] linearizableReadLoop","detail":"{readStateIndex:700; appliedIndex:699; }","duration":"602.090667ms","start":"2026-06-15T20:03:26.705711Z","end":"2026-06-15T20:03:27.307802Z","steps":["trace[2098972850] 'read index received' (duration: 601.364108ms)","trace[2098972850] 'applied index is now lower than readState.Index' (duration: 725.929µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:03:27.307945Z","caller":"traceutil/trace.go:171","msg":"trace[1637065784] transaction","detail":"{read_only:false; response_revision:677; number_of_response:1; }","duration":"610.099156ms","start":"2026-06-15T20:03:26.69783Z","end":"2026-06-15T20:03:27.307929Z","steps":["trace[1637065784] 'process raft request' (duration: 609.537841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:27.307965Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"602.2227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:03:27.307991Z","caller":"traceutil/trace.go:171","msg":"trace[194036162] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:677; }","duration":"602.319832ms","start":"2026-06-15T20:03:26.705663Z","end":"2026-06-15T20:03:27.307983Z","steps":["trace[194036162] 'agreement among raft nodes before linearized reading' (duration: 602.24058ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:27.308012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:26.705639Z","time spent":"602.367054ms","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T20:03:27.308062Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:26.697794Z","time spent":"610.189328ms","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036261,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:03:28.026013Z","caller":"traceutil/trace.go:171","msg":"trace[2041595372] transaction","detail":"{read_only:false; response_revision:684; number_of_response:1; }","duration":"236.402837ms","start":"2026-06-15T20:03:27.789575Z","end":"2026-06-15T20:03:28.025978Z","steps":["trace[2041595372] 'process raft request' (duration: 235.635327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:29.15038Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750708376984249266,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T20:03:29.651628Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750708376984249266,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-15T20:03:30.119639Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.592631119s","expected-duration":"1s"} {"level":"info","ts":"2026-06-15T20:03:30.121115Z","caller":"traceutil/trace.go:171","msg":"trace[517260475] linearizableReadLoop","detail":"{readStateIndex:713; appliedIndex:712; }","duration":"1.470968045s","start":"2026-06-15T20:03:28.650098Z","end":"2026-06-15T20:03:30.121067Z","steps":["trace[517260475] 'read index received' (duration: 1.469718023s)","trace[517260475] 'applied index is now lower than readState.Index' (duration: 1.248822ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:03:30.121193Z","caller":"traceutil/trace.go:171","msg":"trace[1948056527] transaction","detail":"{read_only:false; response_revision:689; number_of_response:1; }","duration":"1.600700252s","start":"2026-06-15T20:03:28.520468Z","end":"2026-06-15T20:03:30.121168Z","steps":["trace[1948056527] 'process raft request' (duration: 1.599819468s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:30.121331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:28.520424Z","time spent":"1.600804214s","remote":"127.0.0.1:59506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036313,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:03:30.121457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.405441ms","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-15T20:03:30.121484Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.940439ms","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-15T20:03:30.121521Z","caller":"traceutil/trace.go:171","msg":"trace[1310491838] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:689; }","duration":"279.506784ms","start":"2026-06-15T20:03:29.841992Z","end":"2026-06-15T20:03:30.121499Z","steps":["trace[1310491838] 'agreement among raft nodes before linearized reading' (duration: 279.3454ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:03:30.121546Z","caller":"traceutil/trace.go:171","msg":"trace[499245732] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:689; }","duration":"279.032651ms","start":"2026-06-15T20:03:29.842494Z","end":"2026-06-15T20:03:30.121526Z","steps":["trace[499245732] 'agreement among raft nodes before linearized reading' (duration: 278.868297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:30.121726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"460.816079ms","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-15T20:03:30.121763Z","caller":"traceutil/trace.go:171","msg":"trace[2086810535] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:689; }","duration":"460.911061ms","start":"2026-06-15T20:03:29.660839Z","end":"2026-06-15T20:03:30.12175Z","steps":["trace[2086810535] 'agreement among raft nodes before linearized reading' (duration: 460.804478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:30.121797Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:29.660807Z","time spent":"460.980333ms","remote":"127.0.0.1:59678","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-15T20:03:30.121788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.676788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T20:03:30.121911Z","caller":"traceutil/trace.go:171","msg":"trace[2117291184] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:689; }","duration":"279.895724ms","start":"2026-06-15T20:03:29.841978Z","end":"2026-06-15T20:03:30.121874Z","steps":["trace[2117291184] 'agreement among raft nodes before linearized reading' (duration: 279.471793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:30.121773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.798959ms","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-15T20:03:30.121987Z","caller":"traceutil/trace.go:171","msg":"trace[656482156] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:689; }","duration":"346.108298ms","start":"2026-06-15T20:03:29.775864Z","end":"2026-06-15T20:03:30.121972Z","steps":["trace[656482156] 'agreement among raft nodes before linearized reading' (duration: 345.569583ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:30.122031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:29.775827Z","time spent":"346.19159ms","remote":"127.0.0.1:59678","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-15T20:03:30.122182Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.472089066s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-67twd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-06-15T20:03:30.122879Z","caller":"traceutil/trace.go:171","msg":"trace[1259764392] range","detail":"{range_begin:/registry/pods/kube-system/cilium-67twd; range_end:; response_count:1; response_revision:689; }","duration":"1.472792924s","start":"2026-06-15T20:03:28.650035Z","end":"2026-06-15T20:03:30.122827Z","steps":["trace[1259764392] 'agreement among raft nodes before linearized reading' (duration: 1.471226313s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:30.123031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:28.65001Z","time spent":"1.472953927s","remote":"127.0.0.1:59596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":16988,"request content":"key:\"/registry/pods/kube-system/cilium-67twd\" "} {"level":"warn","ts":"2026-06-15T20:03:30.124181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.415635197s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:03:30.124288Z","caller":"traceutil/trace.go:171","msg":"trace[1572007060] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:689; }","duration":"1.415831442s","start":"2026-06-15T20:03:28.708429Z","end":"2026-06-15T20:03:30.124261Z","steps":["trace[1572007060] 'agreement among raft nodes before linearized reading' (duration: 1.412891705s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:30.124344Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:28.708378Z","time spent":"1.415954415s","remote":"127.0.0.1:59402","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T20:03:46.012722Z","caller":"traceutil/trace.go:171","msg":"trace[746340898] transaction","detail":"{read_only:false; response_revision:812; number_of_response:1; }","duration":"540.252019ms","start":"2026-06-15T20:03:45.472402Z","end":"2026-06-15T20:03:46.012654Z","steps":["trace[746340898] 'process raft request' (duration: 540.033183ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:46.01295Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:45.47237Z","time spent":"540.461604ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:03:46.022618Z","caller":"traceutil/trace.go:171","msg":"trace[602984103] linearizableReadLoop","detail":"{readStateIndex:842; appliedIndex:841; }","duration":"315.596653ms","start":"2026-06-15T20:03:45.706977Z","end":"2026-06-15T20:03:46.022573Z","steps":["trace[602984103] 'read index received' (duration: 306.730192ms)","trace[602984103] 'applied index is now lower than readState.Index' (duration: 8.865611ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:03:46.022853Z","caller":"traceutil/trace.go:171","msg":"trace[1486736000] transaction","detail":"{read_only:false; response_revision:814; number_of_response:1; }","duration":"254.045552ms","start":"2026-06-15T20:03:45.768655Z","end":"2026-06-15T20:03:46.022721Z","steps":["trace[1486736000] 'process raft request' (duration: 253.825826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:46.023005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.910971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:03:46.02326Z","caller":"traceutil/trace.go:171","msg":"trace[893595727] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:814; }","duration":"316.301571ms","start":"2026-06-15T20:03:45.706927Z","end":"2026-06-15T20:03:46.023229Z","steps":["trace[893595727] 'agreement among raft nodes before linearized reading' (duration: 315.849599ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:46.023373Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:45.706899Z","time spent":"316.458785ms","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T20:03:46.02262Z","caller":"traceutil/trace.go:171","msg":"trace[1141982777] transaction","detail":"{read_only:false; response_revision:813; number_of_response:1; }","duration":"350.706467ms","start":"2026-06-15T20:03:45.671892Z","end":"2026-06-15T20:03:46.022598Z","steps":["trace[1141982777] 'process raft request' (duration: 350.467531ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:03:46.023715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:03:45.67186Z","time spent":"351.733043ms","remote":"127.0.0.1:59584","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":5052,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:04:48.822157Z","caller":"traceutil/trace.go:171","msg":"trace[840826256] transaction","detail":"{read_only:false; response_revision:1123; number_of_response:1; }","duration":"150.134425ms","start":"2026-06-15T20:04:48.671998Z","end":"2026-06-15T20:04:48.822132Z","steps":["trace[840826256] 'process raft request' (duration: 150.058903ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:48.822359Z","caller":"traceutil/trace.go:171","msg":"trace[1882673371] transaction","detail":"{read_only:false; response_revision:1122; number_of_response:1; }","duration":"151.060289ms","start":"2026-06-15T20:04:48.671287Z","end":"2026-06-15T20:04:48.822347Z","steps":["trace[1882673371] 'process raft request' (duration: 129.708164ms)","trace[1882673371] 'compare' (duration: 20.932654ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:04:48.822465Z","caller":"traceutil/trace.go:171","msg":"trace[346804906] linearizableReadLoop","detail":"{readStateIndex:1167; appliedIndex:1165; }","duration":"150.175196ms","start":"2026-06-15T20:04:48.672279Z","end":"2026-06-15T20:04:48.822454Z","steps":["trace[346804906] 'read index received' (duration: 28.732522ms)","trace[346804906] 'applied index is now lower than readState.Index' (duration: 121.441564ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:04:48.82268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.382921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T20:04:48.822725Z","caller":"traceutil/trace.go:171","msg":"trace[705445340] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1124; }","duration":"150.461394ms","start":"2026-06-15T20:04:48.672254Z","end":"2026-06-15T20:04:48.822715Z","steps":["trace[705445340] 'agreement among raft nodes before linearized reading' (duration: 150.31954ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:48.822681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.41278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:04:48.822763Z","caller":"traceutil/trace.go:171","msg":"trace[1967369457] transaction","detail":"{read_only:false; response_revision:1124; number_of_response:1; }","duration":"150.387061ms","start":"2026-06-15T20:04:48.672364Z","end":"2026-06-15T20:04:48.822751Z","steps":["trace[1967369457] 'process raft request' (duration: 149.733785ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:48.822821Z","caller":"traceutil/trace.go:171","msg":"trace[1081628755] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1124; }","duration":"115.554324ms","start":"2026-06-15T20:04:48.707231Z","end":"2026-06-15T20:04:48.822785Z","steps":["trace[1081628755] 'agreement among raft nodes before linearized reading' (duration: 115.421241ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:49.295042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.206827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:04:49.295128Z","caller":"traceutil/trace.go:171","msg":"trace[1732591139] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:1125; }","duration":"287.32572ms","start":"2026-06-15T20:04:49.00777Z","end":"2026-06-15T20:04:49.295096Z","steps":["trace[1732591139] 'count revisions from in-memory index tree' (duration: 287.064384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:49.295225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.689022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-15T20:04:49.295191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.375238ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:04:49.295361Z","caller":"traceutil/trace.go:171","msg":"trace[242552180] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1125; }","duration":"312.695596ms","start":"2026-06-15T20:04:48.982647Z","end":"2026-06-15T20:04:49.295342Z","steps":["trace[242552180] 'count revisions from in-memory index tree' (duration: 312.281936ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:49.295437Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:48.982622Z","time spent":"312.798989ms","remote":"127.0.0.1:59538","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":0,"response size":28,"request content":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true "} {"level":"info","ts":"2026-06-15T20:04:49.295307Z","caller":"traceutil/trace.go:171","msg":"trace[255593976] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:1125; }","duration":"249.812965ms","start":"2026-06-15T20:04:49.045475Z","end":"2026-06-15T20:04:49.295288Z","steps":["trace[255593976] 'count revisions from in-memory index tree' (duration: 249.581648ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:49.494011Z","caller":"traceutil/trace.go:171","msg":"trace[968433622] linearizableReadLoop","detail":"{readStateIndex:1170; appliedIndex:1169; }","duration":"127.116418ms","start":"2026-06-15T20:04:49.366872Z","end":"2026-06-15T20:04:49.493989Z","steps":["trace[968433622] 'read index received' (duration: 126.892432ms)","trace[968433622] 'applied index is now lower than readState.Index' (duration: 223.166µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:04:49.494147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.256973ms","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-15T20:04:49.494207Z","caller":"traceutil/trace.go:171","msg":"trace[702963799] range","detail":"{range_begin:/registry/ingressclasses/; range_end:/registry/ingressclasses0; response_count:0; response_revision:1126; }","duration":"127.369106ms","start":"2026-06-15T20:04:49.366819Z","end":"2026-06-15T20:04:49.494188Z","steps":["trace[702963799] 'agreement among raft nodes before linearized reading' (duration: 127.258843ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:49.494612Z","caller":"traceutil/trace.go:171","msg":"trace[1963504458] transaction","detail":"{read_only:false; response_revision:1126; number_of_response:1; }","duration":"377.028866ms","start":"2026-06-15T20:04:49.117571Z","end":"2026-06-15T20:04:49.494599Z","steps":["trace[1963504458] 'process raft request' (duration: 376.287108ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:49.494728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:49.11755Z","time spent":"377.098039ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:04:49.939983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.215618ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:04:49.940059Z","caller":"traceutil/trace.go:171","msg":"trace[367212526] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:1126; }","duration":"340.341071ms","start":"2026-06-15T20:04:49.5997Z","end":"2026-06-15T20:04:49.940041Z","steps":["trace[367212526] 'count revisions from in-memory index tree' (duration: 340.024594ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:49.940115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:49.599678Z","time spent":"340.426143ms","remote":"127.0.0.1:44328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true "} {"level":"info","ts":"2026-06-15T20:04:50.901805Z","caller":"traceutil/trace.go:171","msg":"trace[784887117] transaction","detail":"{read_only:false; response_revision:1127; number_of_response:1; }","duration":"189.664732ms","start":"2026-06-15T20:04:50.712101Z","end":"2026-06-15T20:04:50.901765Z","steps":["trace[784887117] 'process raft request' (duration: 189.477718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:51.685596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.621407ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:04:51.685726Z","caller":"traceutil/trace.go:171","msg":"trace[268617975] transaction","detail":"{read_only:false; response_revision:1128; number_of_response:1; }","duration":"779.549142ms","start":"2026-06-15T20:04:50.906152Z","end":"2026-06-15T20:04:51.685701Z","steps":["trace[268617975] 'process raft request' (duration: 420.726959ms)","trace[268617975] 'compare' (duration: 358.119365ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:04:51.68583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:50.906127Z","time spent":"779.642664ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:04:52.310284Z","caller":"traceutil/trace.go:171","msg":"trace[977197072] transaction","detail":"{read_only:false; response_revision:1130; number_of_response:1; }","duration":"1.403815126s","start":"2026-06-15T20:04:50.906441Z","end":"2026-06-15T20:04:52.310256Z","steps":["trace[977197072] 'process raft request' (duration: 1.403714533s)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:52.310347Z","caller":"traceutil/trace.go:171","msg":"trace[2058565398] transaction","detail":"{read_only:false; response_revision:1129; number_of_response:1; }","duration":"1.403884787s","start":"2026-06-15T20:04:50.906435Z","end":"2026-06-15T20:04:52.31032Z","steps":["trace[2058565398] 'process raft request' (duration: 1.403523577s)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:52.310443Z","caller":"traceutil/trace.go:171","msg":"trace[189596171] transaction","detail":"{read_only:false; response_revision:1131; number_of_response:1; }","duration":"1.40399773s","start":"2026-06-15T20:04:50.906414Z","end":"2026-06-15T20:04:52.310411Z","steps":["trace[189596171] 'process raft request' (duration: 1.403798786s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:52.310469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:50.90641Z","time spent":"1.40399337s","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:04:52.310638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:50.906366Z","time spent":"1.404165075s","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:04:52.310666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:50.906418Z","time spent":"1.403945109s","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:04:52.5397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.705803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:04:52.539834Z","caller":"traceutil/trace.go:171","msg":"trace[995382438] transaction","detail":"{read_only:false; response_revision:1132; number_of_response:1; }","duration":"1.039730359s","start":"2026-06-15T20:04:51.500078Z","end":"2026-06-15T20:04:52.539809Z","steps":["trace[995382438] 'process raft request' (duration: 924.777459ms)","trace[995382438] 'compare' (duration: 114.58558ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:04:52.539904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:51.500056Z","time spent":"1.039813313s","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:04:53.207237Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750708376984250290,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T20:04:53.315216Z","caller":"traceutil/trace.go:171","msg":"trace[1551416885] transaction","detail":"{read_only:false; response_revision:1133; number_of_response:1; }","duration":"723.550914ms","start":"2026-06-15T20:04:52.591625Z","end":"2026-06-15T20:04:53.315176Z","steps":["trace[1551416885] 'process raft request' (duration: 696.080795ms)","trace[1551416885] 'compare' (duration: 27.232664ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:04:53.315261Z","caller":"traceutil/trace.go:171","msg":"trace[1121103808] linearizableReadLoop","detail":"{readStateIndex:1178; appliedIndex:1177; }","duration":"609.018767ms","start":"2026-06-15T20:04:52.706207Z","end":"2026-06-15T20:04:53.315226Z","steps":["trace[1121103808] 'read index received' (duration: 581.555077ms)","trace[1121103808] 'applied index is now lower than readState.Index' (duration: 27.46135ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:04:53.315377Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:52.591609Z","time spent":"723.686747ms","remote":"127.0.0.1:59426","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":120,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:04:53.315441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"609.221442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:04:53.3155Z","caller":"traceutil/trace.go:171","msg":"trace[1235563159] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1133; }","duration":"609.325885ms","start":"2026-06-15T20:04:52.70616Z","end":"2026-06-15T20:04:53.315486Z","steps":["trace[1235563159] 'agreement among raft nodes before linearized reading' (duration: 609.206571ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:53.315542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:52.70614Z","time spent":"609.392017ms","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T20:04:53.315575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"407.016421ms","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-15T20:04:53.315621Z","caller":"traceutil/trace.go:171","msg":"trace[1854173309] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1133; }","duration":"407.103713ms","start":"2026-06-15T20:04:52.908504Z","end":"2026-06-15T20:04:53.315608Z","steps":["trace[1854173309] 'agreement among raft nodes before linearized reading' (duration: 406.963189ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:53.315658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:52.908485Z","time spent":"407.165634ms","remote":"127.0.0.1:59678","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-15T20:04:53.813637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"366.421095ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-15T20:04:53.813862Z","caller":"traceutil/trace.go:171","msg":"trace[475111780] linearizableReadLoop","detail":"{readStateIndex:1179; appliedIndex:1178; }","duration":"251.397565ms","start":"2026-06-15T20:04:53.562436Z","end":"2026-06-15T20:04:53.813833Z","steps":["trace[475111780] 'read index received' (duration: 54.831µs)","trace[475111780] 'applied index is now lower than readState.Index' (duration: 251.341114ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:04:53.814002Z","caller":"traceutil/trace.go:171","msg":"trace[613757096] transaction","detail":"{read_only:false; response_revision:1134; number_of_response:1; }","duration":"492.097387ms","start":"2026-06-15T20:04:53.321878Z","end":"2026-06-15T20:04:53.813975Z","steps":["trace[613757096] 'process raft request' (duration: 125.22413ms)","trace[613757096] 'compare' (duration: 366.18749ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:04:53.814046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.589721ms","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":"warn","ts":"2026-06-15T20:04:53.814071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.933087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-15T20:04:53.814103Z","caller":"traceutil/trace.go:171","msg":"trace[1504330226] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1134; }","duration":"251.701844ms","start":"2026-06-15T20:04:53.562386Z","end":"2026-06-15T20:04:53.814088Z","steps":["trace[1504330226] 'agreement among raft nodes before linearized reading' (duration: 251.576781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:04:53.814111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:04:53.321854Z","time spent":"492.20024ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:04:53.814112Z","caller":"traceutil/trace.go:171","msg":"trace[723144741] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1134; }","duration":"123.974058ms","start":"2026-06-15T20:04:53.690125Z","end":"2026-06-15T20:04:53.814099Z","steps":["trace[723144741] 'agreement among raft nodes before linearized reading' (duration: 123.849255ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:04:54.005368Z","caller":"traceutil/trace.go:171","msg":"trace[1378752956] transaction","detail":"{read_only:false; response_revision:1135; number_of_response:1; }","duration":"187.23207ms","start":"2026-06-15T20:04:53.818104Z","end":"2026-06-15T20:04:54.005336Z","steps":["trace[1378752956] 'process raft request' (duration: 187.120788ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:08.106949Z","caller":"traceutil/trace.go:171","msg":"trace[1969400486] transaction","detail":"{read_only:false; response_revision:1231; number_of_response:1; }","duration":"226.168113ms","start":"2026-06-15T20:05:07.880761Z","end":"2026-06-15T20:05:08.106929Z","steps":["trace[1969400486] 'process raft request' (duration: 226.0388ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:08.107559Z","caller":"traceutil/trace.go:171","msg":"trace[198177500] transaction","detail":"{read_only:false; response_revision:1232; number_of_response:1; }","duration":"125.520927ms","start":"2026-06-15T20:05:07.982016Z","end":"2026-06-15T20:05:08.107537Z","steps":["trace[198177500] 'process raft request' (duration: 125.363014ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:11.034753Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":5750708376984250541,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-15T20:05:11.444977Z","caller":"traceutil/trace.go:171","msg":"trace[788146058] transaction","detail":"{read_only:false; response_revision:1240; number_of_response:1; }","duration":"952.2282ms","start":"2026-06-15T20:05:10.492719Z","end":"2026-06-15T20:05:11.444947Z","steps":["trace[788146058] 'process raft request' (duration: 952.034196ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:11.445153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:10.492688Z","time spent":"952.381135ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:05:11.804078Z","caller":"traceutil/trace.go:171","msg":"trace[257953503] linearizableReadLoop","detail":"{readStateIndex:1291; appliedIndex:1289; }","duration":"1.269803991s","start":"2026-06-15T20:05:10.534252Z","end":"2026-06-15T20:05:11.804056Z","steps":["trace[257953503] 'read index received' (duration: 910.494567ms)","trace[257953503] 'applied index is now lower than readState.Index' (duration: 359.308424ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:05:11.804163Z","caller":"traceutil/trace.go:171","msg":"trace[720785840] transaction","detail":"{read_only:false; response_revision:1241; number_of_response:1; }","duration":"1.175607642s","start":"2026-06-15T20:05:10.628522Z","end":"2026-06-15T20:05:11.80413Z","steps":["trace[720785840] 'process raft request' (duration: 1.102873809s)","trace[720785840] 'compare' (duration: 72.081746ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:05:11.804362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.27009254s","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-15T20:05:11.804411Z","caller":"traceutil/trace.go:171","msg":"trace[130479595] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1241; }","duration":"1.270195233s","start":"2026-06-15T20:05:10.534205Z","end":"2026-06-15T20:05:11.8044Z","steps":["trace[130479595] 'agreement among raft nodes before linearized reading' (duration: 1.270003938s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:11.804444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:10.534183Z","time spent":"1.270252344s","remote":"127.0.0.1:59678","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-15T20:05:11.804343Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:10.6285Z","time spent":"1.175723666s","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:05:11.804489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.270168651s","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-15T20:05:11.804554Z","caller":"traceutil/trace.go:171","msg":"trace[1451997424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1241; }","duration":"1.270272273s","start":"2026-06-15T20:05:10.534267Z","end":"2026-06-15T20:05:11.804539Z","steps":["trace[1451997424] 'agreement among raft nodes before linearized reading' (duration: 1.270098519s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:11.804592Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:10.534246Z","time spent":"1.270337335s","remote":"127.0.0.1:59678","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-15T20:05:11.804631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.698979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies/\" range_end:\"/registry/cilium.io/ciliumclusterwidenetworkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:05:11.80468Z","caller":"traceutil/trace.go:171","msg":"trace[799189765] range","detail":"{range_begin:/registry/cilium.io/ciliumclusterwidenetworkpolicies/; range_end:/registry/cilium.io/ciliumclusterwidenetworkpolicies0; response_count:0; response_revision:1241; }","duration":"285.76088ms","start":"2026-06-15T20:05:11.518894Z","end":"2026-06-15T20:05:11.804655Z","steps":["trace[799189765] 'agreement among raft nodes before linearized reading' (duration: 285.687768ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:11.804726Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.100081978s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:05:11.804753Z","caller":"traceutil/trace.go:171","msg":"trace[870335893] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1241; }","duration":"1.100148189s","start":"2026-06-15T20:05:10.704597Z","end":"2026-06-15T20:05:11.804745Z","steps":["trace[870335893] 'agreement among raft nodes before linearized reading' (duration: 1.100105828s)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:11.80478Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:10.704576Z","time spent":"1.10019661s","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-15T20:05:15.062617Z","caller":"traceutil/trace.go:171","msg":"trace[164580306] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"106.172245ms","start":"2026-06-15T20:05:14.956423Z","end":"2026-06-15T20:05:15.062595Z","steps":["trace[164580306] 'process raft request' (duration: 105.98191ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:28.337218Z","caller":"traceutil/trace.go:171","msg":"trace[877567778] transaction","detail":"{read_only:false; response_revision:1314; number_of_response:1; }","duration":"479.071555ms","start":"2026-06-15T20:05:27.858127Z","end":"2026-06-15T20:05:28.337199Z","steps":["trace[877567778] 'process raft request' (duration: 478.967363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:28.337341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:27.858109Z","time spent":"479.172207ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:05:28.337285Z","caller":"traceutil/trace.go:171","msg":"trace[2011906951] linearizableReadLoop","detail":"{readStateIndex:1367; appliedIndex:1367; }","duration":"444.145015ms","start":"2026-06-15T20:05:27.893102Z","end":"2026-06-15T20:05:28.337247Z","steps":["trace[2011906951] 'read index received' (duration: 444.129515ms)","trace[2011906951] 'applied index is now lower than readState.Index' (duration: 12.81µs)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:05:28.337674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.556046ms","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-15T20:05:28.337769Z","caller":"traceutil/trace.go:171","msg":"trace[1568804584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1314; }","duration":"444.70419ms","start":"2026-06-15T20:05:27.893042Z","end":"2026-06-15T20:05:28.337746Z","steps":["trace[1568804584] 'agreement among raft nodes before linearized reading' (duration: 444.419772ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:28.337828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:27.893024Z","time spent":"444.793503ms","remote":"127.0.0.1:59678","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-15T20:05:28.491145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.395185ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T20:05:28.49134Z","caller":"traceutil/trace.go:171","msg":"trace[1097666297] transaction","detail":"{read_only:false; response_revision:1315; number_of_response:1; }","duration":"149.009747ms","start":"2026-06-15T20:05:28.342316Z","end":"2026-06-15T20:05:28.491326Z","steps":["trace[1097666297] 'process raft request' (duration: 148.913505ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:28.49132Z","caller":"traceutil/trace.go:171","msg":"trace[219892326] linearizableReadLoop","detail":"{readStateIndex:1368; appliedIndex:1367; }","duration":"153.607233ms","start":"2026-06-15T20:05:28.337675Z","end":"2026-06-15T20:05:28.491282Z","steps":["trace[219892326] 'read index received' (duration: 17.084094ms)","trace[219892326] 'applied index is now lower than readState.Index' (duration: 136.519499ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:05:28.491607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.453362ms","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-15T20:05:28.491581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.013572ms","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-15T20:05:28.491667Z","caller":"traceutil/trace.go:171","msg":"trace[2042542210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1315; }","duration":"597.583746ms","start":"2026-06-15T20:05:27.894072Z","end":"2026-06-15T20:05:28.491656Z","steps":["trace[2042542210] 'agreement among raft nodes before linearized reading' (duration: 597.324289ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:28.491702Z","caller":"traceutil/trace.go:171","msg":"trace[726975781] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1315; }","duration":"214.217478ms","start":"2026-06-15T20:05:28.277456Z","end":"2026-06-15T20:05:28.491673Z","steps":["trace[726975781] 'agreement among raft nodes before linearized reading' (duration: 213.848779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:28.491733Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:27.894039Z","time spent":"597.685508ms","remote":"127.0.0.1:59678","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-15T20:05:28.492463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"272.73157ms","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-15T20:05:28.492778Z","caller":"traceutil/trace.go:171","msg":"trace[660589523] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1315; }","duration":"272.884843ms","start":"2026-06-15T20:05:28.219655Z","end":"2026-06-15T20:05:28.49254Z","steps":["trace[660589523] 'agreement among raft nodes before linearized reading' (duration: 272.586855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:28.967549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.328563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:05:28.96764Z","caller":"traceutil/trace.go:171","msg":"trace[1671637673] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1319; }","duration":"260.471927ms","start":"2026-06-15T20:05:28.707147Z","end":"2026-06-15T20:05:28.967619Z","steps":["trace[1671637673] 'range keys from in-memory index tree' (duration: 260.245271ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:29.346519Z","caller":"traceutil/trace.go:171","msg":"trace[679057102] transaction","detail":"{read_only:false; response_revision:1320; number_of_response:1; }","duration":"131.743597ms","start":"2026-06-15T20:05:29.214754Z","end":"2026-06-15T20:05:29.346497Z","steps":["trace[679057102] 'process raft request' (duration: 131.611483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:39.051815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.713306ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:05:39.051895Z","caller":"traceutil/trace.go:171","msg":"trace[1159076674] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:1396; }","duration":"341.849551ms","start":"2026-06-15T20:05:38.710027Z","end":"2026-06-15T20:05:39.051877Z","steps":["trace[1159076674] 'count revisions from in-memory index tree' (duration: 341.631715ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:39.051931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:38.710011Z","time spent":"341.911712ms","remote":"127.0.0.1:59892","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":28,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"warn","ts":"2026-06-15T20:05:39.052237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.054822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:05:39.052271Z","caller":"traceutil/trace.go:171","msg":"trace[787948530] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1396; }","duration":"345.127824ms","start":"2026-06-15T20:05:38.707136Z","end":"2026-06-15T20:05:39.052264Z","steps":["trace[787948530] 'range keys from in-memory index tree' (duration: 344.494597ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:39.052291Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:38.707116Z","time spent":"345.170975ms","remote":"127.0.0.1:59406","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-15T20:05:39.167366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.078675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:05:39.167447Z","caller":"traceutil/trace.go:171","msg":"trace[2140396419] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1397; }","duration":"114.208401ms","start":"2026-06-15T20:05:39.053221Z","end":"2026-06-15T20:05:39.167429Z","steps":["trace[2140396419] 'agreement among raft nodes before linearized reading' (duration: 114.055286ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:05:39.167591Z","caller":"traceutil/trace.go:171","msg":"trace[800020714] linearizableReadLoop","detail":"{readStateIndex:1453; appliedIndex:1452; }","duration":"113.85507ms","start":"2026-06-15T20:05:39.053261Z","end":"2026-06-15T20:05:39.167116Z","steps":["trace[800020714] 'read index received' (duration: 113.491511ms)","trace[800020714] 'applied index is now lower than readState.Index' (duration: 361.969µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:05:39.168073Z","caller":"traceutil/trace.go:171","msg":"trace[32051897] transaction","detail":"{read_only:false; response_revision:1397; number_of_response:1; }","duration":"302.820895ms","start":"2026-06-15T20:05:38.864411Z","end":"2026-06-15T20:05:39.167232Z","steps":["trace[32051897] 'process raft request' (duration: 302.508387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:39.168356Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:38.864387Z","time spent":"303.736469ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:05:40.043224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"450.981939ms","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-15T20:05:40.043282Z","caller":"traceutil/trace.go:171","msg":"trace[1580534149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1397; }","duration":"451.094912ms","start":"2026-06-15T20:05:39.592173Z","end":"2026-06-15T20:05:40.043268Z","steps":["trace[1580534149] 'range keys from in-memory index tree' (duration: 450.736221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:40.043428Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:39.592152Z","time spent":"451.267775ms","remote":"127.0.0.1:59678","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-15T20:05:40.043576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"516.361653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:474"} {"level":"info","ts":"2026-06-15T20:05:40.04366Z","caller":"traceutil/trace.go:171","msg":"trace[978697362] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1397; }","duration":"516.490527ms","start":"2026-06-15T20:05:39.527151Z","end":"2026-06-15T20:05:40.043641Z","steps":["trace[978697362] 'range keys from in-memory index tree' (duration: 516.174959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:40.043682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"503.180298ms","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":"warn","ts":"2026-06-15T20:05:40.043705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:39.52713Z","time spent":"516.565238ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":497,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-15T20:05:40.043766Z","caller":"traceutil/trace.go:171","msg":"trace[895815466] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1397; }","duration":"503.306341ms","start":"2026-06-15T20:05:39.540441Z","end":"2026-06-15T20:05:40.043747Z","steps":["trace[895815466] 'range keys from in-memory index tree' (duration: 502.982852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:05:40.043847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:05:39.540431Z","time spent":"503.406543ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":1,"response size":549,"request content":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" "} {"level":"info","ts":"2026-06-15T20:07:58.980924Z","caller":"traceutil/trace.go:171","msg":"trace[1461262723] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"134.396758ms","start":"2026-06-15T20:07:58.846494Z","end":"2026-06-15T20:07:58.980891Z","steps":["trace[1461262723] 'process raft request' (duration: 102.677796ms)","trace[1461262723] 'compare' (duration: 31.600249ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:07:59.495733Z","caller":"traceutil/trace.go:171","msg":"trace[1153293169] transaction","detail":"{read_only:false; response_revision:2039; number_of_response:1; }","duration":"112.979515ms","start":"2026-06-15T20:07:59.382732Z","end":"2026-06-15T20:07:59.495712Z","steps":["trace[1153293169] 'process raft request' (duration: 82.975819ms)","trace[1153293169] 'compare' (duration: 29.908484ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:07:59.512039Z","caller":"traceutil/trace.go:171","msg":"trace[879373717] transaction","detail":"{read_only:false; response_revision:2041; number_of_response:1; }","duration":"127.56602ms","start":"2026-06-15T20:07:59.384452Z","end":"2026-06-15T20:07:59.512019Z","steps":["trace[879373717] 'process raft request' (duration: 127.508048ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:07:59.51208Z","caller":"traceutil/trace.go:171","msg":"trace[2130910054] transaction","detail":"{read_only:false; response_revision:2040; number_of_response:1; }","duration":"128.982185ms","start":"2026-06-15T20:07:59.383064Z","end":"2026-06-15T20:07:59.512046Z","steps":["trace[2130910054] 'process raft request' (duration: 128.771979ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:07:59.512217Z","caller":"traceutil/trace.go:171","msg":"trace[1217364336] transaction","detail":"{read_only:false; response_revision:2042; number_of_response:1; }","duration":"126.425088ms","start":"2026-06-15T20:07:59.385784Z","end":"2026-06-15T20:07:59.512209Z","steps":["trace[1217364336] 'process raft request' (duration: 126.205463ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:08:00.852445Z","caller":"traceutil/trace.go:171","msg":"trace[1746715268] transaction","detail":"{read_only:false; response_revision:2045; number_of_response:1; }","duration":"128.083882ms","start":"2026-06-15T20:08:00.724341Z","end":"2026-06-15T20:08:00.852425Z","steps":["trace[1746715268] 'process raft request' (duration: 127.974709ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:08:01.103414Z","caller":"traceutil/trace.go:171","msg":"trace[571964607] transaction","detail":"{read_only:false; response_revision:2046; number_of_response:1; }","duration":"117.887635ms","start":"2026-06-15T20:08:00.98551Z","end":"2026-06-15T20:08:01.103398Z","steps":["trace[571964607] 'process raft request' (duration: 117.779422ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:08:01.84054Z","caller":"traceutil/trace.go:171","msg":"trace[120045013] transaction","detail":"{read_only:false; response_revision:2050; number_of_response:1; }","duration":"268.958391ms","start":"2026-06-15T20:08:01.571551Z","end":"2026-06-15T20:08:01.840509Z","steps":["trace[120045013] 'process raft request' (duration: 189.478144ms)","trace[120045013] 'compare' (duration: 79.319812ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:08:01.84065Z","caller":"traceutil/trace.go:171","msg":"trace[1628737658] transaction","detail":"{read_only:false; response_revision:2051; number_of_response:1; }","duration":"267.962784ms","start":"2026-06-15T20:08:01.572678Z","end":"2026-06-15T20:08:01.840641Z","steps":["trace[1628737658] 'process raft request' (duration: 267.78173ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:08:01.840848Z","caller":"traceutil/trace.go:171","msg":"trace[473037363] linearizableReadLoop","detail":"{readStateIndex:2136; appliedIndex:2133; }","duration":"134.86139ms","start":"2026-06-15T20:08:01.705967Z","end":"2026-06-15T20:08:01.840829Z","steps":["trace[473037363] 'read index received' (duration: 55.037674ms)","trace[473037363] 'applied index is now lower than readState.Index' (duration: 79.821996ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:08:01.841031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.051145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:08:01.841135Z","caller":"traceutil/trace.go:171","msg":"trace[416976757] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2052; }","duration":"135.20327ms","start":"2026-06-15T20:08:01.705917Z","end":"2026-06-15T20:08:01.84112Z","steps":["trace[416976757] 'agreement among raft nodes before linearized reading' (duration: 135.041265ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:08:01.841031Z","caller":"traceutil/trace.go:171","msg":"trace[1904420607] transaction","detail":"{read_only:false; response_revision:2052; number_of_response:1; }","duration":"266.458644ms","start":"2026-06-15T20:08:01.574557Z","end":"2026-06-15T20:08:01.841016Z","steps":["trace[1904420607] 'process raft request' (duration: 266.041023ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:08:13.134735Z","caller":"traceutil/trace.go:171","msg":"trace[1153139847] transaction","detail":"{read_only:false; response_revision:2097; number_of_response:1; }","duration":"896.378698ms","start":"2026-06-15T20:08:12.238333Z","end":"2026-06-15T20:08:13.134712Z","steps":["trace[1153139847] 'process raft request' (duration: 894.256502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:08:13.134881Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:08:12.238326Z","time spent":"896.47391ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:08:13.135029Z","caller":"traceutil/trace.go:171","msg":"trace[2031107934] transaction","detail":"{read_only:false; response_revision:2098; number_of_response:1; }","duration":"895.057453ms","start":"2026-06-15T20:08:12.239949Z","end":"2026-06-15T20:08:13.135006Z","steps":["trace[2031107934] 'process raft request' (duration: 894.498129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:08:13.135148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:08:12.239929Z","time spent":"895.153927ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-15T20:09:30.941942Z","caller":"traceutil/trace.go:171","msg":"trace[208690650] transaction","detail":"{read_only:false; response_revision:2483; number_of_response:1; }","duration":"100.788708ms","start":"2026-06-15T20:09:30.841125Z","end":"2026-06-15T20:09:30.941914Z","steps":["trace[208690650] 'process raft request' (duration: 21.070921ms)","trace[208690650] 'compare' (duration: 79.582844ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:33.906493Z","caller":"traceutil/trace.go:171","msg":"trace[1189448572] transaction","detail":"{read_only:false; response_revision:2502; number_of_response:1; }","duration":"125.106895ms","start":"2026-06-15T20:09:33.781358Z","end":"2026-06-15T20:09:33.906465Z","steps":["trace[1189448572] 'process raft request' (duration: 124.934529ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:34.759791Z","caller":"traceutil/trace.go:171","msg":"trace[1697453116] transaction","detail":"{read_only:false; response_revision:2507; number_of_response:1; }","duration":"112.327471ms","start":"2026-06-15T20:09:34.647435Z","end":"2026-06-15T20:09:34.759762Z","steps":["trace[1697453116] 'process raft request' (duration: 33.403825ms)","trace[1697453116] 'compare' (duration: 78.812872ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:34.95699Z","caller":"traceutil/trace.go:171","msg":"trace[940581308] transaction","detail":"{read_only:false; response_revision:2508; number_of_response:1; }","duration":"182.884827ms","start":"2026-06-15T20:09:34.774076Z","end":"2026-06-15T20:09:34.956961Z","steps":["trace[940581308] 'process raft request' (duration: 151.204618ms)","trace[940581308] 'compare' (duration: 31.564766ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:35.657373Z","caller":"traceutil/trace.go:171","msg":"trace[323379182] transaction","detail":"{read_only:false; response_revision:2511; number_of_response:1; }","duration":"150.176201ms","start":"2026-06-15T20:09:35.50717Z","end":"2026-06-15T20:09:35.657347Z","steps":["trace[323379182] 'process raft request' (duration: 150.039197ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:35.999354Z","caller":"traceutil/trace.go:171","msg":"trace[2132373895] transaction","detail":"{read_only:false; response_revision:2514; number_of_response:1; }","duration":"185.901055ms","start":"2026-06-15T20:09:35.813427Z","end":"2026-06-15T20:09:35.999328Z","steps":["trace[2132373895] 'process raft request' (duration: 127.354492ms)","trace[2132373895] 'compare' (duration: 58.43252ms)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:37.852599Z","caller":"traceutil/trace.go:171","msg":"trace[1555617270] linearizableReadLoop","detail":"{readStateIndex:2623; appliedIndex:2622; }","duration":"261.660468ms","start":"2026-06-15T20:09:37.59092Z","end":"2026-06-15T20:09:37.85258Z","steps":["trace[1555617270] 'read index received' (duration: 261.497014ms)","trace[1555617270] 'applied index is now lower than readState.Index' (duration: 162.784µs)"],"step_count":2} {"level":"info","ts":"2026-06-15T20:09:37.852692Z","caller":"traceutil/trace.go:171","msg":"trace[1165877401] transaction","detail":"{read_only:false; response_revision:2519; number_of_response:1; }","duration":"350.71995ms","start":"2026-06-15T20:09:37.501921Z","end":"2026-06-15T20:09:37.852641Z","steps":["trace[1165877401] 'process raft request' (duration: 350.556106ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:09:37.852798Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.050271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"warn","ts":"2026-06-15T20:09:37.85277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.834563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-15T20:09:37.852841Z","caller":"traceutil/trace.go:171","msg":"trace[571739200] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2519; }","duration":"261.957277ms","start":"2026-06-15T20:09:37.590875Z","end":"2026-06-15T20:09:37.852832Z","steps":["trace[571739200] 'agreement among raft nodes before linearized reading' (duration: 261.804332ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:37.852841Z","caller":"traceutil/trace.go:171","msg":"trace[1002913277] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2519; }","duration":"191.133013ms","start":"2026-06-15T20:09:37.661698Z","end":"2026-06-15T20:09:37.852831Z","steps":["trace[1002913277] 'agreement among raft nodes before linearized reading' (duration: 191.025789ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:09:37.85283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.484555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:09:37.852889Z","caller":"traceutil/trace.go:171","msg":"trace[596951705] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2519; }","duration":"146.577887ms","start":"2026-06-15T20:09:37.706294Z","end":"2026-06-15T20:09:37.852872Z","steps":["trace[596951705] 'agreement among raft nodes before linearized reading' (duration: 146.457443ms)"],"step_count":1} {"level":"warn","ts":"2026-06-15T20:09:37.852873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-15T20:09:37.501899Z","time spent":"350.864174ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-15T20:09:37.852959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.190914ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-15T20:09:37.853028Z","caller":"traceutil/trace.go:171","msg":"trace[1408541908] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2519; }","duration":"170.277066ms","start":"2026-06-15T20:09:37.682736Z","end":"2026-06-15T20:09:37.853013Z","steps":["trace[1408541908] 'agreement among raft nodes before linearized reading' (duration: 170.041371ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:38.03536Z","caller":"traceutil/trace.go:171","msg":"trace[2117389612] transaction","detail":"{read_only:false; response_revision:2522; number_of_response:1; }","duration":"177.381282ms","start":"2026-06-15T20:09:37.857955Z","end":"2026-06-15T20:09:38.035337Z","steps":["trace[2117389612] 'process raft request' (duration: 177.342711ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:38.035662Z","caller":"traceutil/trace.go:171","msg":"trace[1975921746] transaction","detail":"{read_only:false; response_revision:2521; number_of_response:1; }","duration":"178.638546ms","start":"2026-06-15T20:09:37.856997Z","end":"2026-06-15T20:09:38.035636Z","steps":["trace[1975921746] 'process raft request' (duration: 92.667975ms)","trace[1975921746] 'compare' (duration: 85.478457ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:09:38.388926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.091183ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-15T20:09:38.389022Z","caller":"traceutil/trace.go:171","msg":"trace[980621416] linearizableReadLoop","detail":"{readStateIndex:2627; appliedIndex:2626; }","duration":"236.223682ms","start":"2026-06-15T20:09:38.15278Z","end":"2026-06-15T20:09:38.389004Z","steps":["trace[980621416] 'read index received' (duration: 128.976115ms)","trace[980621416] 'applied index is now lower than readState.Index' (duration: 107.246137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:09:38.389173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.388637ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" ","response":"range_response_count:1 size:531"} {"level":"info","ts":"2026-06-15T20:09:38.389201Z","caller":"traceutil/trace.go:171","msg":"trace[1358369916] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2522; }","duration":"236.452458ms","start":"2026-06-15T20:09:38.152738Z","end":"2026-06-15T20:09:38.38919Z","steps":["trace[1358369916] 'agreement among raft nodes before linearized reading' (duration: 236.311155ms)"],"step_count":1} {"level":"info","ts":"2026-06-15T20:09:38.577564Z","caller":"traceutil/trace.go:171","msg":"trace[551472573] transaction","detail":"{read_only:false; response_revision:2524; number_of_response:1; }","duration":"138.237199ms","start":"2026-06-15T20:09:38.439284Z","end":"2026-06-15T20:09:38.577521Z","steps":["trace[551472573] 'process raft request' (duration: 73.009672ms)","trace[551472573] 'compare' (duration: 65.00291ms)"],"step_count":2} {"level":"warn","ts":"2026-06-15T20:09:38.811062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.697581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-15T20:09:38.811132Z","caller":"traceutil/trace.go:171","msg":"trace[2006816161] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2525; }","duration":"101.826034ms","start":"2026-06-15T20:09:38.709287Z","end":"2026-06-15T20:09:38.811113Z","steps":["trace[2006816161] 'range keys from in-memory index tree' (duration: 101.62962ms)"],"step_count":1}