{"level":"warn","ts":"2026-06-26T03:34:14.314656Z","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-26T03:34:14.314782Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-26T03:34:14.315067Z","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-26T03:34:14.315081Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-06-26T03:34:14.315099Z","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-26T03:34:14.31578Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-06-26T03:34:14.315908Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-26T03:34:14.320211Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.047315ms"} {"level":"info","ts":"2026-06-26T03:34:14.327515Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-06-26T03:34:14.327572Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-06-26T03:34:14.327589Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-06-26T03:34:14.327602Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-26T03:34:14.327609Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-06-26T03:34:14.32764Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-06-26T03:34:14.335271Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-26T03:34:14.338171Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-26T03:34:14.33943Z","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-26T03:34:14.341657Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-26T03:34:14.342581Z","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-26T03:34:14.342657Z","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-26T03:34:14.342669Z","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-26T03:34:14.342628Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-26T03:34:14.343933Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-06-26T03:34:14.344106Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-06-26T03:34:14.345946Z","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-26T03:34:14.346109Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-06-26T03:34:14.346153Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-06-26T03:34:14.34633Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-26T03:34:14.346377Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-26T03:34:14.928593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-06-26T03:34:14.92866Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-26T03:34:14.928682Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-06-26T03:34:14.928701Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-06-26T03:34:14.928712Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-06-26T03:34:14.928733Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-06-26T03:34:14.928751Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-06-26T03:34:14.929904Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-06-26T03:34:14.929946Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:34:14.93001Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-26T03:34:14.930064Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:34:14.930139Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-26T03:34:14.93021Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-26T03:34:14.931539Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:34:14.93164Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:34:14.931672Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-26T03:34:14.932276Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-26T03:34:14.934Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-06-26T03:34:16.51995Z","caller":"traceutil/trace.go:171","msg":"trace[2140563167] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"293.362018ms","start":"2026-06-26T03:34:16.226562Z","end":"2026-06-26T03:34:16.519924Z","steps":["trace[2140563167] 'process raft request' (duration: 291.507426ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.52167Z","caller":"traceutil/trace.go:171","msg":"trace[337247417] transaction","detail":"{read_only:false; number_of_response:0; response_revision:5; }","duration":"294.160151ms","start":"2026-06-26T03:34:16.227485Z","end":"2026-06-26T03:34:16.521645Z","steps":["trace[337247417] 'process raft request' (duration: 294.001787ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.521729Z","caller":"traceutil/trace.go:171","msg":"trace[1933945752] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"290.967761ms","start":"2026-06-26T03:34:16.230733Z","end":"2026-06-26T03:34:16.521701Z","steps":["trace[1933945752] 'process raft request' (duration: 290.840868ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.521721Z","caller":"traceutil/trace.go:171","msg":"trace[591945434] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"291.195698ms","start":"2026-06-26T03:34:16.230471Z","end":"2026-06-26T03:34:16.521667Z","steps":["trace[591945434] 'process raft request' (duration: 291.041064ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.521909Z","caller":"traceutil/trace.go:171","msg":"trace[2072405994] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"291.006992ms","start":"2026-06-26T03:34:16.230879Z","end":"2026-06-26T03:34:16.521886Z","steps":["trace[2072405994] 'process raft request' (duration: 290.725104ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.521968Z","caller":"traceutil/trace.go:171","msg":"trace[947829473] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"294.594464ms","start":"2026-06-26T03:34:16.227315Z","end":"2026-06-26T03:34:16.52191Z","steps":["trace[947829473] 'process raft request' (duration: 294.072659ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.522129Z","caller":"traceutil/trace.go:171","msg":"trace[1998510774] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"291.195497ms","start":"2026-06-26T03:34:16.23088Z","end":"2026-06-26T03:34:16.522076Z","steps":["trace[1998510774] 'process raft request' (duration: 290.754635ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.5223Z","caller":"traceutil/trace.go:171","msg":"trace[1285529125] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"291.358001ms","start":"2026-06-26T03:34:16.23093Z","end":"2026-06-26T03:34:16.522288Z","steps":["trace[1285529125] 'process raft request' (duration: 290.741104ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.522488Z","caller":"traceutil/trace.go:171","msg":"trace[1025048600] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"291.074164ms","start":"2026-06-26T03:34:16.231339Z","end":"2026-06-26T03:34:16.522413Z","steps":["trace[1025048600] 'process raft request' (duration: 290.368254ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.522458Z","caller":"traceutil/trace.go:171","msg":"trace[1160409963] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"283.51913ms","start":"2026-06-26T03:34:16.23891Z","end":"2026-06-26T03:34:16.522429Z","steps":["trace[1160409963] 'process raft request' (duration: 283.364516ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.522469Z","caller":"traceutil/trace.go:171","msg":"trace[1080817635] linearizableReadLoop","detail":"{readStateIndex:16; appliedIndex:6; }","duration":"244.050354ms","start":"2026-06-26T03:34:16.278391Z","end":"2026-06-26T03:34:16.522441Z","steps":["trace[1080817635] 'read index received' (duration: 239.69218ms)","trace[1080817635] 'applied index is now lower than readState.Index' (duration: 4.356254ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:34:16.522773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.371023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"warn","ts":"2026-06-26T03:34:16.522818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.066824ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:34:16.52285Z","caller":"traceutil/trace.go:171","msg":"trace[1465314344] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:12; }","duration":"244.479996ms","start":"2026-06-26T03:34:16.278358Z","end":"2026-06-26T03:34:16.522838Z","steps":["trace[1465314344] 'agreement among raft nodes before linearized reading' (duration: 244.298081ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:16.522868Z","caller":"traceutil/trace.go:171","msg":"trace[733499530] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:12; }","duration":"122.162805ms","start":"2026-06-26T03:34:16.40069Z","end":"2026-06-26T03:34:16.522852Z","steps":["trace[733499530] 'agreement among raft nodes before linearized reading' (duration: 122.062192ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:17.233664Z","caller":"traceutil/trace.go:171","msg":"trace[36279110] linearizableReadLoop","detail":"{readStateIndex:76; appliedIndex:75; }","duration":"105.046461ms","start":"2026-06-26T03:34:17.128602Z","end":"2026-06-26T03:34:17.233648Z","steps":["trace[36279110] 'read index received' (duration: 104.887097ms)","trace[36279110] 'applied index is now lower than readState.Index' (duration: 158.684µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:34:17.233773Z","caller":"traceutil/trace.go:171","msg":"trace[1686384138] transaction","detail":"{read_only:false; response_revision:72; number_of_response:1; }","duration":"105.538746ms","start":"2026-06-26T03:34:17.128216Z","end":"2026-06-26T03:34:17.233755Z","steps":["trace[1686384138] 'process raft request' (duration: 105.330391ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:17.233998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.394831ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:34:17.234034Z","caller":"traceutil/trace.go:171","msg":"trace[1431916801] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:72; }","duration":"105.472723ms","start":"2026-06-26T03:34:17.128553Z","end":"2026-06-26T03:34:17.234026Z","steps":["trace[1431916801] 'agreement among raft nodes before linearized reading' (duration: 105.199315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:17.783758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"349.544348ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-06-26T03:34:17.78388Z","caller":"traceutil/trace.go:171","msg":"trace[1026185452] linearizableReadLoop","detail":"{readStateIndex:77; appliedIndex:76; }","duration":"542.840515ms","start":"2026-06-26T03:34:17.241022Z","end":"2026-06-26T03:34:17.783862Z","steps":["trace[1026185452] 'read index received' (duration: 192.64685ms)","trace[1026185452] 'applied index is now lower than readState.Index' (duration: 350.192325ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:34:17.783966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"542.933868ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-edit\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-06-26T03:34:17.783993Z","caller":"traceutil/trace.go:171","msg":"trace[1812193335] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-edit; range_end:; response_count:0; response_revision:73; }","duration":"542.97884ms","start":"2026-06-26T03:34:17.241005Z","end":"2026-06-26T03:34:17.783983Z","steps":["trace[1812193335] 'agreement among raft nodes before linearized reading' (duration: 542.904557ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:17.78398Z","caller":"traceutil/trace.go:171","msg":"trace[965964843] transaction","detail":"{read_only:false; response_revision:73; number_of_response:1; }","duration":"544.804522ms","start":"2026-06-26T03:34:17.239134Z","end":"2026-06-26T03:34:17.783939Z","steps":["trace[965964843] 'process raft request' (duration: 194.481262ms)","trace[965964843] 'compare' (duration: 349.387113ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:34:17.784029Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:17.240997Z","time spent":"543.02424ms","remote":"127.0.0.1:53544","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-edit\" "} {"level":"warn","ts":"2026-06-26T03:34:17.784167Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:17.23912Z","time spent":"544.965867ms","remote":"127.0.0.1:53558","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-26T03:34:42.802094Z","caller":"traceutil/trace.go:171","msg":"trace[1066858876] transaction","detail":"{read_only:false; response_revision:431; number_of_response:1; }","duration":"101.361507ms","start":"2026-06-26T03:34:42.700705Z","end":"2026-06-26T03:34:42.802066Z","steps":["trace[1066858876] 'process raft request' (duration: 101.206522ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.203385Z","caller":"traceutil/trace.go:171","msg":"trace[1798556840] transaction","detail":"{read_only:false; response_revision:488; number_of_response:1; }","duration":"278.127386ms","start":"2026-06-26T03:34:51.925229Z","end":"2026-06-26T03:34:52.203356Z","steps":["trace[1798556840] 'process raft request' (duration: 277.968992ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.210197Z","caller":"traceutil/trace.go:171","msg":"trace[1596032327] transaction","detail":"{read_only:false; response_revision:489; number_of_response:1; }","duration":"268.698431ms","start":"2026-06-26T03:34:51.94145Z","end":"2026-06-26T03:34:52.210148Z","steps":["trace[1596032327] 'process raft request' (duration: 268.466684ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.210421Z","caller":"traceutil/trace.go:171","msg":"trace[374544561] transaction","detail":"{read_only:false; response_revision:491; number_of_response:1; }","duration":"257.567176ms","start":"2026-06-26T03:34:51.952838Z","end":"2026-06-26T03:34:52.210405Z","steps":["trace[374544561] 'process raft request' (duration: 257.277918ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.210583Z","caller":"traceutil/trace.go:171","msg":"trace[1531002560] transaction","detail":"{read_only:false; response_revision:490; number_of_response:1; }","duration":"257.75756ms","start":"2026-06-26T03:34:51.952793Z","end":"2026-06-26T03:34:52.21055Z","steps":["trace[1531002560] 'process raft request' (duration: 257.288527ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.210929Z","caller":"traceutil/trace.go:171","msg":"trace[1983704810] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"248.360575ms","start":"2026-06-26T03:34:51.962554Z","end":"2026-06-26T03:34:52.210915Z","steps":["trace[1983704810] 'process raft request' (duration: 247.697647ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.211071Z","caller":"traceutil/trace.go:171","msg":"trace[776053809] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"100.417261ms","start":"2026-06-26T03:34:52.110539Z","end":"2026-06-26T03:34:52.210956Z","steps":["trace[776053809] 'process raft request' (duration: 100.353649ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.211205Z","caller":"traceutil/trace.go:171","msg":"trace[1869270434] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"252.107361ms","start":"2026-06-26T03:34:51.959085Z","end":"2026-06-26T03:34:52.211192Z","steps":["trace[1869270434] 'process raft request' (duration: 251.108513ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.211452Z","caller":"traceutil/trace.go:171","msg":"trace[904774384] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"252.031238ms","start":"2026-06-26T03:34:51.959379Z","end":"2026-06-26T03:34:52.21141Z","steps":["trace[904774384] 'process raft request' (duration: 250.847135ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.211468Z","caller":"traceutil/trace.go:171","msg":"trace[700997151] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"230.057118ms","start":"2026-06-26T03:34:51.981377Z","end":"2026-06-26T03:34:52.211434Z","steps":["trace[700997151] 'process raft request' (duration: 229.252926ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.211607Z","caller":"traceutil/trace.go:171","msg":"trace[39352549] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"240.211335ms","start":"2026-06-26T03:34:51.971374Z","end":"2026-06-26T03:34:52.211585Z","steps":["trace[39352549] 'process raft request' (duration: 239.036602ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.211732Z","caller":"traceutil/trace.go:171","msg":"trace[2103380940] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"202.445756ms","start":"2026-06-26T03:34:52.009277Z","end":"2026-06-26T03:34:52.211723Z","steps":["trace[2103380940] 'process raft request' (duration: 201.472529ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:52.211387Z","caller":"traceutil/trace.go:171","msg":"trace[765202976] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"230.063339ms","start":"2026-06-26T03:34:51.981298Z","end":"2026-06-26T03:34:52.211361Z","steps":["trace[765202976] 'process raft request' (duration: 229.211294ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:58.845466Z","caller":"traceutil/trace.go:171","msg":"trace[2059351014] linearizableReadLoop","detail":"{readStateIndex:622; appliedIndex:621; }","duration":"215.561006ms","start":"2026-06-26T03:34:58.629882Z","end":"2026-06-26T03:34:58.845443Z","steps":["trace[2059351014] 'read index received' (duration: 213.784797ms)","trace[2059351014] 'applied index is now lower than readState.Index' (duration: 1.775299ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:34:58.845595Z","caller":"traceutil/trace.go:171","msg":"trace[244974512] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"272.136048ms","start":"2026-06-26T03:34:58.573409Z","end":"2026-06-26T03:34:58.845545Z","steps":["trace[244974512] 'process raft request' (duration: 270.530073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:58.846219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.310888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-26T03:34:58.846315Z","caller":"traceutil/trace.go:171","msg":"trace[1948520512] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:595; }","duration":"216.448113ms","start":"2026-06-26T03:34:58.629845Z","end":"2026-06-26T03:34:58.846293Z","steps":["trace[1948520512] 'agreement among raft nodes before linearized reading' (duration: 215.729833ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:58.846906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.962278ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:34:58.846987Z","caller":"traceutil/trace.go:171","msg":"trace[248941503] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"211.06293ms","start":"2026-06-26T03:34:58.635894Z","end":"2026-06-26T03:34:58.846956Z","steps":["trace[248941503] 'agreement among raft nodes before linearized reading' (duration: 210.927147ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:58.847482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.317579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-ppfpc\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-26T03:34:58.847549Z","caller":"traceutil/trace.go:171","msg":"trace[598374236] range","detail":"{range_begin:/registry/pods/kube-system/cilium-ppfpc; range_end:; response_count:1; response_revision:595; }","duration":"204.401122ms","start":"2026-06-26T03:34:58.64312Z","end":"2026-06-26T03:34:58.847521Z","steps":["trace[598374236] 'agreement among raft nodes before linearized reading' (duration: 203.706722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:59.376076Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605521677827397,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:34:59.909584Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.148046ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:34:59.909715Z","caller":"traceutil/trace.go:171","msg":"trace[215338768] transaction","detail":"{read_only:false; response_revision:596; number_of_response:1; }","duration":"1.046620434s","start":"2026-06-26T03:34:58.863074Z","end":"2026-06-26T03:34:59.909695Z","steps":["trace[215338768] 'process raft request' (duration: 626.858111ms)","trace[215338768] 'compare' (duration: 418.712384ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:34:59.909836Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:58.86306Z","time spent":"1.046689516s","remote":"127.0.0.1:53406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:34:59.923748Z","caller":"traceutil/trace.go:171","msg":"trace[594066555] linearizableReadLoop","detail":"{readStateIndex:626; appliedIndex:623; }","duration":"1.048077466s","start":"2026-06-26T03:34:58.875646Z","end":"2026-06-26T03:34:59.923723Z","steps":["trace[594066555] 'read index received' (duration: 614.269435ms)","trace[594066555] 'applied index is now lower than readState.Index' (duration: 433.807101ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:34:59.923914Z","caller":"traceutil/trace.go:171","msg":"trace[1271783940] transaction","detail":"{read_only:false; response_revision:597; number_of_response:1; }","duration":"1.049282229s","start":"2026-06-26T03:34:58.874619Z","end":"2026-06-26T03:34:59.923901Z","steps":["trace[1271783940] 'process raft request' (duration: 1.048931709s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:59.924162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:58.874597Z","time spent":"1.049403323s","remote":"127.0.0.1:53274","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:34:59.924235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"694.088903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-26T03:34:59.924286Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.616101ms","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-26T03:34:59.924301Z","caller":"traceutil/trace.go:171","msg":"trace[1092717498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:598; }","duration":"694.154845ms","start":"2026-06-26T03:34:59.230125Z","end":"2026-06-26T03:34:59.924279Z","steps":["trace[1092717498] 'agreement among raft nodes before linearized reading' (duration: 693.95327ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:59.924351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:59.230068Z","time spent":"694.271898ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T03:34:59.924346Z","caller":"traceutil/trace.go:171","msg":"trace[1844937920] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:598; }","duration":"348.698073ms","start":"2026-06-26T03:34:59.57563Z","end":"2026-06-26T03:34:59.924328Z","steps":["trace[1844937920] 'agreement among raft nodes before linearized reading' (duration: 348.59785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:59.924416Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:59.575616Z","time spent":"348.789057ms","remote":"127.0.0.1:53476","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-26T03:34:59.924435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"686.217271ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-26T03:34:59.924501Z","caller":"traceutil/trace.go:171","msg":"trace[2094075835] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:598; }","duration":"686.333893ms","start":"2026-06-26T03:34:59.238151Z","end":"2026-06-26T03:34:59.924484Z","steps":["trace[2094075835] 'agreement among raft nodes before linearized reading' (duration: 686.121177ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:34:59.924519Z","caller":"traceutil/trace.go:171","msg":"trace[906696854] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"1.007603061s","start":"2026-06-26T03:34:58.916903Z","end":"2026-06-26T03:34:59.924506Z","steps":["trace[906696854] 'process raft request' (duration: 1.006775227s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:59.924536Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:59.238131Z","time spent":"686.398515ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:34:59.924574Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:58.916877Z","time spent":"1.007664781s","remote":"127.0.0.1:53448","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:34:59.924556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"288.15681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:34:59.924747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.049097874s","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-26T03:34:59.924785Z","caller":"traceutil/trace.go:171","msg":"trace[1170743952] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:598; }","duration":"1.049147705s","start":"2026-06-26T03:34:58.875628Z","end":"2026-06-26T03:34:59.924776Z","steps":["trace[1170743952] 'agreement among raft nodes before linearized reading' (duration: 1.048411895s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:34:59.924807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:34:58.875622Z","time spent":"1.049180056s","remote":"127.0.0.1:53476","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-26T03:34:59.924729Z","caller":"traceutil/trace.go:171","msg":"trace[1902666172] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:598; }","duration":"288.351336ms","start":"2026-06-26T03:34:59.636353Z","end":"2026-06-26T03:34:59.924704Z","steps":["trace[1902666172] 'agreement among raft nodes before linearized reading' (duration: 287.951925ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:35:15.21433Z","caller":"traceutil/trace.go:171","msg":"trace[78494093] transaction","detail":"{read_only:false; response_revision:760; number_of_response:1; }","duration":"472.781873ms","start":"2026-06-26T03:35:14.741523Z","end":"2026-06-26T03:35:15.214305Z","steps":["trace[78494093] 'process raft request' (duration: 472.640319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:35:15.214597Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:14.741502Z","time spent":"473.009409ms","remote":"127.0.0.1:53406","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4027,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:35:15.519465Z","caller":"traceutil/trace.go:171","msg":"trace[1094416385] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"299.662716ms","start":"2026-06-26T03:35:15.219516Z","end":"2026-06-26T03:35:15.519179Z","steps":["trace[1094416385] 'process raft request' (duration: 299.4765ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:35:15.519668Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:15.219494Z","time spent":"300.047177ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:35:29.364545Z","caller":"traceutil/trace.go:171","msg":"trace[697383162] transaction","detail":"{read_only:false; response_revision:895; number_of_response:1; }","duration":"169.376491ms","start":"2026-06-26T03:35:29.19514Z","end":"2026-06-26T03:35:29.364517Z","steps":["trace[697383162] 'process raft request' (duration: 169.232547ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:35:29.36741Z","caller":"traceutil/trace.go:171","msg":"trace[1884591031] transaction","detail":"{read_only:false; response_revision:897; number_of_response:1; }","duration":"169.863084ms","start":"2026-06-26T03:35:29.197513Z","end":"2026-06-26T03:35:29.367376Z","steps":["trace[1884591031] 'process raft request' (duration: 169.751051ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:35:29.367465Z","caller":"traceutil/trace.go:171","msg":"trace[1404709299] transaction","detail":"{read_only:false; response_revision:896; number_of_response:1; }","duration":"172.253043ms","start":"2026-06-26T03:35:29.195169Z","end":"2026-06-26T03:35:29.367422Z","steps":["trace[1404709299] 'process raft request' (duration: 171.888002ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:35:50.059601Z","caller":"traceutil/trace.go:171","msg":"trace[700218288] transaction","detail":"{read_only:false; response_revision:971; number_of_response:1; }","duration":"349.480096ms","start":"2026-06-26T03:35:49.710098Z","end":"2026-06-26T03:35:50.059578Z","steps":["trace[700218288] 'process raft request' (duration: 349.345131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:35:50.059849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:49.710082Z","time spent":"349.678401ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:35:51.013899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"568.506031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:35:51.014026Z","caller":"traceutil/trace.go:171","msg":"trace[1891691071] linearizableReadLoop","detail":"{readStateIndex:1014; appliedIndex:1013; }","duration":"476.792857ms","start":"2026-06-26T03:35:50.537205Z","end":"2026-06-26T03:35:51.013998Z","steps":["trace[1891691071] 'read index received' (duration: 44.381µs)","trace[1891691071] 'applied index is now lower than readState.Index' (duration: 476.746416ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:35:51.014091Z","caller":"traceutil/trace.go:171","msg":"trace[1483002424] transaction","detail":"{read_only:false; response_revision:972; number_of_response:1; }","duration":"980.008221ms","start":"2026-06-26T03:35:50.034037Z","end":"2026-06-26T03:35:51.014045Z","steps":["trace[1483002424] 'process raft request' (duration: 411.15883ms)","trace[1483002424] 'compare' (duration: 568.344107ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:35:51.01423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"477.028524ms","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-26T03:35:51.01427Z","caller":"traceutil/trace.go:171","msg":"trace[395632178] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:972; }","duration":"477.090725ms","start":"2026-06-26T03:35:50.537164Z","end":"2026-06-26T03:35:51.014255Z","steps":["trace[395632178] 'agreement among raft nodes before linearized reading' (duration: 476.950561ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:35:51.014278Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:50.034012Z","time spent":"980.162935ms","remote":"127.0.0.1:53476","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-26T03:35:51.014305Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:50.537146Z","time spent":"477.150758ms","remote":"127.0.0.1:53476","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-26T03:35:51.014321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"446.339545ms","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-26T03:35:51.014402Z","caller":"traceutil/trace.go:171","msg":"trace[1977609951] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:972; }","duration":"446.471718ms","start":"2026-06-26T03:35:50.567913Z","end":"2026-06-26T03:35:51.014384Z","steps":["trace[1977609951] 'agreement among raft nodes before linearized reading' (duration: 446.210031ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:35:51.014476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:50.567893Z","time spent":"446.573831ms","remote":"127.0.0.1:53476","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-26T03:35:51.014667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"444.954247ms","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-26T03:35:51.014717Z","caller":"traceutil/trace.go:171","msg":"trace[1046142648] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:972; }","duration":"445.034188ms","start":"2026-06-26T03:35:50.569674Z","end":"2026-06-26T03:35:51.014708Z","steps":["trace[1046142648] 'agreement among raft nodes before linearized reading' (duration: 444.922375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:35:51.014744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:50.569656Z","time spent":"445.08217ms","remote":"127.0.0.1:53476","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-26T03:35:51.014582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.973311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:35:51.014896Z","caller":"traceutil/trace.go:171","msg":"trace[7676822] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:972; }","duration":"378.340042ms","start":"2026-06-26T03:35:50.636539Z","end":"2026-06-26T03:35:51.014879Z","steps":["trace[7676822] 'agreement among raft nodes before linearized reading' (duration: 377.960111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:35:51.01495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:35:50.636521Z","time spent":"378.409714ms","remote":"127.0.0.1:53228","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-26T03:36:06.440591Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.477222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:36:06.440887Z","caller":"traceutil/trace.go:171","msg":"trace[171718479] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1023; }","duration":"104.824741ms","start":"2026-06-26T03:36:06.336041Z","end":"2026-06-26T03:36:06.440866Z","steps":["trace[171718479] 'range keys from in-memory index tree' (duration: 104.392109ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:12.309415Z","caller":"traceutil/trace.go:171","msg":"trace[380812867] transaction","detail":"{read_only:false; response_revision:1043; number_of_response:1; }","duration":"135.257628ms","start":"2026-06-26T03:36:12.174135Z","end":"2026-06-26T03:36:12.309392Z","steps":["trace[380812867] 'process raft request' (duration: 135.123365ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:12.921284Z","caller":"traceutil/trace.go:171","msg":"trace[528745908] transaction","detail":"{read_only:false; response_revision:1044; number_of_response:1; }","duration":"183.037253ms","start":"2026-06-26T03:36:12.73821Z","end":"2026-06-26T03:36:12.921247Z","steps":["trace[528745908] 'process raft request' (duration: 182.815647ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:13.509144Z","caller":"traceutil/trace.go:171","msg":"trace[735501914] linearizableReadLoop","detail":"{readStateIndex:1091; appliedIndex:1090; }","duration":"371.790738ms","start":"2026-06-26T03:36:13.137327Z","end":"2026-06-26T03:36:13.509118Z","steps":["trace[735501914] 'read index received' (duration: 371.618713ms)","trace[735501914] 'applied index is now lower than readState.Index' (duration: 171.235µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:13.509237Z","caller":"traceutil/trace.go:171","msg":"trace[783956349] transaction","detail":"{read_only:false; response_revision:1045; number_of_response:1; }","duration":"420.896181ms","start":"2026-06-26T03:36:13.088332Z","end":"2026-06-26T03:36:13.509228Z","steps":["trace[783956349] 'process raft request' (duration: 420.664834ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:13.509327Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:13.088304Z","time spent":"420.953881ms","remote":"127.0.0.1:53476","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-26T03:36:13.509511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.917327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-26T03:36:13.509578Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.469567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:36:13.509589Z","caller":"traceutil/trace.go:171","msg":"trace[669997348] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1045; }","duration":"369.017509ms","start":"2026-06-26T03:36:13.140553Z","end":"2026-06-26T03:36:13.50957Z","steps":["trace[669997348] 'agreement among raft nodes before linearized reading' (duration: 368.795603ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:13.509605Z","caller":"traceutil/trace.go:171","msg":"trace[1696539300] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:1045; }","duration":"128.52678ms","start":"2026-06-26T03:36:13.381071Z","end":"2026-06-26T03:36:13.509598Z","steps":["trace[1696539300] 'agreement among raft nodes before linearized reading' (duration: 128.477348ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:13.509632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:13.140544Z","time spent":"369.079762ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:36:13.509848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"372.527299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"warn","ts":"2026-06-26T03:36:13.509865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"367.558898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-06-26T03:36:13.509883Z","caller":"traceutil/trace.go:171","msg":"trace[318939520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1045; }","duration":"372.598311ms","start":"2026-06-26T03:36:13.137276Z","end":"2026-06-26T03:36:13.509874Z","steps":["trace[318939520] 'agreement among raft nodes before linearized reading' (duration: 372.477107ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:13.509898Z","caller":"traceutil/trace.go:171","msg":"trace[948833850] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1045; }","duration":"367.60046ms","start":"2026-06-26T03:36:13.142285Z","end":"2026-06-26T03:36:13.509886Z","steps":["trace[948833850] 'agreement among raft nodes before linearized reading' (duration: 367.518527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:13.50994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:13.142276Z","time spent":"367.657512ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-26T03:36:13.50991Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:13.137255Z","time spent":"372.648282ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-26T03:36:13.510121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"368.794263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-26T03:36:13.510168Z","caller":"traceutil/trace.go:171","msg":"trace[1327573875] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1045; }","duration":"368.874566ms","start":"2026-06-26T03:36:13.141284Z","end":"2026-06-26T03:36:13.510159Z","steps":["trace[1327573875] 'agreement among raft nodes before linearized reading' (duration: 368.771643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:13.5102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:13.141268Z","time spent":"368.925548ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-26T03:36:14.414802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.057075ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-26T03:36:14.414911Z","caller":"traceutil/trace.go:171","msg":"trace[1328669876] linearizableReadLoop","detail":"{readStateIndex:1096; appliedIndex:1095; }","duration":"101.314773ms","start":"2026-06-26T03:36:14.313576Z","end":"2026-06-26T03:36:14.414891Z","steps":["trace[1328669876] 'read index received' (duration: 38.931µs)","trace[1328669876] 'applied index is now lower than readState.Index' (duration: 101.273052ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:14.415093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.509997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-06-26T03:36:14.415141Z","caller":"traceutil/trace.go:171","msg":"trace[673745822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1049; }","duration":"101.594741ms","start":"2026-06-26T03:36:14.313534Z","end":"2026-06-26T03:36:14.415129Z","steps":["trace[673745822] 'agreement among raft nodes before linearized reading' (duration: 101.405446ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:14.606286Z","caller":"traceutil/trace.go:171","msg":"trace[335538437] transaction","detail":"{read_only:false; response_revision:1050; number_of_response:1; }","duration":"187.599332ms","start":"2026-06-26T03:36:14.418668Z","end":"2026-06-26T03:36:14.606267Z","steps":["trace[335538437] 'process raft request' (duration: 187.394966ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:17.62553Z","caller":"traceutil/trace.go:171","msg":"trace[1678996767] transaction","detail":"{read_only:false; response_revision:1057; number_of_response:1; }","duration":"101.070797ms","start":"2026-06-26T03:36:17.52441Z","end":"2026-06-26T03:36:17.625481Z","steps":["trace[1678996767] 'process raft request' (duration: 100.056048ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:19.855945Z","caller":"traceutil/trace.go:171","msg":"trace[1811923185] transaction","detail":"{read_only:false; response_revision:1069; number_of_response:1; }","duration":"128.510518ms","start":"2026-06-26T03:36:19.727405Z","end":"2026-06-26T03:36:19.855916Z","steps":["trace[1811923185] 'process raft request' (duration: 100.713176ms)","trace[1811923185] 'compare' (duration: 27.677869ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:35.91684Z","caller":"traceutil/trace.go:171","msg":"trace[668735552] linearizableReadLoop","detail":"{readStateIndex:1223; appliedIndex:1222; }","duration":"117.756646ms","start":"2026-06-26T03:36:35.799056Z","end":"2026-06-26T03:36:35.916813Z","steps":["trace[668735552] 'read index received' (duration: 117.631832ms)","trace[668735552] 'applied index is now lower than readState.Index' (duration: 123.344µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:35.916924Z","caller":"traceutil/trace.go:171","msg":"trace[255277642] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"144.989152ms","start":"2026-06-26T03:36:35.771889Z","end":"2026-06-26T03:36:35.916878Z","steps":["trace[255277642] 'process raft request' (duration: 144.737876ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:35.917171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.085174ms","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-26T03:36:35.917211Z","caller":"traceutil/trace.go:171","msg":"trace[159208417] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1170; }","duration":"118.204968ms","start":"2026-06-26T03:36:35.798992Z","end":"2026-06-26T03:36:35.917197Z","steps":["trace[159208417] 'agreement among raft nodes before linearized reading' (duration: 117.983092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:35.917304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.079956ms","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-26T03:36:35.917395Z","caller":"traceutil/trace.go:171","msg":"trace[1318185360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1170; }","duration":"118.2449ms","start":"2026-06-26T03:36:35.799124Z","end":"2026-06-26T03:36:35.917369Z","steps":["trace[1318185360] 'agreement among raft nodes before linearized reading' (duration: 117.974972ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:37.921967Z","caller":"traceutil/trace.go:171","msg":"trace[1300004790] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"210.759534ms","start":"2026-06-26T03:36:37.711173Z","end":"2026-06-26T03:36:37.921933Z","steps":["trace[1300004790] 'process raft request' (duration: 210.61102ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:38.13655Z","caller":"traceutil/trace.go:171","msg":"trace[847897579] linearizableReadLoop","detail":"{readStateIndex:1229; appliedIndex:1228; }","duration":"141.302018ms","start":"2026-06-26T03:36:37.995217Z","end":"2026-06-26T03:36:38.136519Z","steps":["trace[847897579] 'read index received' (duration: 99.516182ms)","trace[847897579] 'applied index is now lower than readState.Index' (duration: 41.784526ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:38.136821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.568586ms","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-26T03:36:38.136887Z","caller":"traceutil/trace.go:171","msg":"trace[2067248224] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1176; }","duration":"141.69821ms","start":"2026-06-26T03:36:37.995173Z","end":"2026-06-26T03:36:38.136871Z","steps":["trace[2067248224] 'agreement among raft nodes before linearized reading' (duration: 141.457903ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:38.136616Z","caller":"traceutil/trace.go:171","msg":"trace[945706748] transaction","detail":"{read_only:false; response_revision:1176; number_of_response:1; }","duration":"210.842486ms","start":"2026-06-26T03:36:37.92573Z","end":"2026-06-26T03:36:38.136572Z","steps":["trace[945706748] 'process raft request' (duration: 168.946297ms)","trace[945706748] 'compare' (duration: 41.718744ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:38.137438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.589616ms","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-26T03:36:38.137498Z","caller":"traceutil/trace.go:171","msg":"trace[1742010658] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1176; }","duration":"136.680099ms","start":"2026-06-26T03:36:38.000803Z","end":"2026-06-26T03:36:38.137483Z","steps":["trace[1742010658] 'agreement among raft nodes before linearized reading' (duration: 136.489634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:38.137525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.650888ms","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-26T03:36:38.137643Z","caller":"traceutil/trace.go:171","msg":"trace[1048438639] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1176; }","duration":"141.812933ms","start":"2026-06-26T03:36:37.995804Z","end":"2026-06-26T03:36:38.137617Z","steps":["trace[1048438639] 'agreement among raft nodes before linearized reading' (duration: 141.448802ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:50.101123Z","caller":"traceutil/trace.go:171","msg":"trace[238262917] transaction","detail":"{read_only:false; response_revision:1216; number_of_response:1; }","duration":"127.677995ms","start":"2026-06-26T03:36:49.973412Z","end":"2026-06-26T03:36:50.10109Z","steps":["trace[238262917] 'process raft request' (duration: 127.440118ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:52.215817Z","caller":"traceutil/trace.go:171","msg":"trace[136748382] transaction","detail":"{read_only:false; response_revision:1230; number_of_response:1; }","duration":"108.103903ms","start":"2026-06-26T03:36:52.107682Z","end":"2026-06-26T03:36:52.215786Z","steps":["trace[136748382] 'process raft request' (duration: 107.696332ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:54.635548Z","caller":"traceutil/trace.go:171","msg":"trace[113171323] linearizableReadLoop","detail":"{readStateIndex:1310; appliedIndex:1308; }","duration":"113.415493ms","start":"2026-06-26T03:36:54.522106Z","end":"2026-06-26T03:36:54.635521Z","steps":["trace[113171323] 'read index received' (duration: 33.577306ms)","trace[113171323] 'applied index is now lower than readState.Index' (duration: 79.837257ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:54.635713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.553266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:36:54.635742Z","caller":"traceutil/trace.go:171","msg":"trace[1553282352] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1253; }","duration":"113.684531ms","start":"2026-06-26T03:36:54.522049Z","end":"2026-06-26T03:36:54.635733Z","steps":["trace[1553282352] 'agreement among raft nodes before linearized reading' (duration: 113.567188ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:54.635851Z","caller":"traceutil/trace.go:171","msg":"trace[1244206046] transaction","detail":"{read_only:false; response_revision:1252; number_of_response:1; }","duration":"293.70115ms","start":"2026-06-26T03:36:54.342108Z","end":"2026-06-26T03:36:54.635809Z","steps":["trace[1244206046] 'process raft request' (duration: 213.627566ms)","trace[1244206046] 'compare' (duration: 79.59354ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:54.63592Z","caller":"traceutil/trace.go:171","msg":"trace[2067885152] transaction","detail":"{read_only:false; response_revision:1253; number_of_response:1; }","duration":"293.671138ms","start":"2026-06-26T03:36:54.342238Z","end":"2026-06-26T03:36:54.63591Z","steps":["trace[2067885152] 'process raft request' (duration: 293.229055ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:55.190434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.068959ms","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-26T03:36:55.191368Z","caller":"traceutil/trace.go:171","msg":"trace[1763757839] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1253; }","duration":"294.993055ms","start":"2026-06-26T03:36:54.896287Z","end":"2026-06-26T03:36:55.19128Z","steps":["trace[1763757839] 'range keys from in-memory index tree' (duration: 293.790412ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:55.557948Z","caller":"traceutil/trace.go:171","msg":"trace[813301729] transaction","detail":"{read_only:false; response_revision:1254; number_of_response:1; }","duration":"362.304341ms","start":"2026-06-26T03:36:55.195611Z","end":"2026-06-26T03:36:55.557915Z","steps":["trace[813301729] 'process raft request' (duration: 362.102375ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:55.558149Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:55.195591Z","time spent":"362.459785ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:36:56.027304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.935057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:36:56.027418Z","caller":"traceutil/trace.go:171","msg":"trace[1279913458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1254; }","duration":"391.110902ms","start":"2026-06-26T03:36:55.636286Z","end":"2026-06-26T03:36:56.027397Z","steps":["trace[1279913458] 'range keys from in-memory index tree' (duration: 390.857125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:56.027464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:55.636262Z","time spent":"391.193254ms","remote":"127.0.0.1:53228","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-26T03:36:56.027505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.607646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:36:56.027558Z","caller":"traceutil/trace.go:171","msg":"trace[2075188826] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1254; }","duration":"125.72124ms","start":"2026-06-26T03:36:55.901829Z","end":"2026-06-26T03:36:56.02755Z","steps":["trace[2075188826] 'count revisions from in-memory index tree' (duration: 125.258637ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:56.346539Z","caller":"traceutil/trace.go:171","msg":"trace[1584516641] transaction","detail":"{read_only:false; response_revision:1255; number_of_response:1; }","duration":"113.554648ms","start":"2026-06-26T03:36:56.232952Z","end":"2026-06-26T03:36:56.346507Z","steps":["trace[1584516641] 'process raft request' (duration: 113.310141ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:57.470801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.970802ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:36:57.470931Z","caller":"traceutil/trace.go:171","msg":"trace[2091664137] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"746.464528ms","start":"2026-06-26T03:36:56.724446Z","end":"2026-06-26T03:36:57.470911Z","steps":["trace[2091664137] 'process raft request' (duration: 404.277391ms)","trace[2091664137] 'compare' (duration: 341.026614ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:57.470998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:56.724421Z","time spent":"746.547561ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:36:57.810104Z","caller":"traceutil/trace.go:171","msg":"trace[173837228] linearizableReadLoop","detail":"{readStateIndex:1317; appliedIndex:1315; }","duration":"971.496757ms","start":"2026-06-26T03:36:56.83858Z","end":"2026-06-26T03:36:57.810077Z","steps":["trace[173837228] 'read index received' (duration: 290.231479ms)","trace[173837228] 'applied index is now lower than readState.Index' (duration: 681.263918ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:57.810291Z","caller":"traceutil/trace.go:171","msg":"trace[90149551] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"1.083648386s","start":"2026-06-26T03:36:56.726531Z","end":"2026-06-26T03:36:57.810179Z","steps":["trace[90149551] 'process raft request' (duration: 1.083372779s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:57.810569Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.657102ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T03:36:57.810551Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"971.93307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:36:57.810599Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:56.726511Z","time spent":"1.083902122s","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:36:57.810629Z","caller":"traceutil/trace.go:171","msg":"trace[160236200] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:1260; }","duration":"206.781856ms","start":"2026-06-26T03:36:57.603831Z","end":"2026-06-26T03:36:57.810613Z","steps":["trace[160236200] 'agreement among raft nodes before linearized reading' (duration: 206.492469ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:57.810598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.674236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:36:57.810729Z","caller":"traceutil/trace.go:171","msg":"trace[443745661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1260; }","duration":"173.856872ms","start":"2026-06-26T03:36:57.636826Z","end":"2026-06-26T03:36:57.810683Z","steps":["trace[443745661] 'agreement among raft nodes before linearized reading' (duration: 173.468221ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:57.810662Z","caller":"traceutil/trace.go:171","msg":"trace[822776547] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1260; }","duration":"972.119803ms","start":"2026-06-26T03:36:56.838518Z","end":"2026-06-26T03:36:57.810638Z","steps":["trace[822776547] 'agreement among raft nodes before linearized reading' (duration: 971.718233ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:57.810795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:56.838479Z","time spent":"972.30127ms","remote":"127.0.0.1:53228","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-26T03:36:57.813248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.044099ms","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-26T03:36:57.81331Z","caller":"traceutil/trace.go:171","msg":"trace[747492043] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1260; }","duration":"251.166301ms","start":"2026-06-26T03:36:57.562129Z","end":"2026-06-26T03:36:57.813295Z","steps":["trace[747492043] 'agreement among raft nodes before linearized reading' (duration: 248.121766ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:57.961991Z","caller":"traceutil/trace.go:171","msg":"trace[1366095659] transaction","detail":"{read_only:false; response_revision:1261; number_of_response:1; }","duration":"144.142027ms","start":"2026-06-26T03:36:57.817793Z","end":"2026-06-26T03:36:57.961935Z","steps":["trace[1366095659] 'process raft request' (duration: 128.768356ms)","trace[1366095659] 'compare' (duration: 15.206026ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:58.605902Z","caller":"traceutil/trace.go:171","msg":"trace[1249126737] transaction","detail":"{read_only:false; response_revision:1264; number_of_response:1; }","duration":"155.66714ms","start":"2026-06-26T03:36:58.450198Z","end":"2026-06-26T03:36:58.605865Z","steps":["trace[1249126737] 'process raft request' (duration: 63.041469ms)","trace[1249126737] 'compare' (duration: 92.488088ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:58.636257Z","caller":"traceutil/trace.go:171","msg":"trace[1266005320] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"118.95828ms","start":"2026-06-26T03:36:58.517272Z","end":"2026-06-26T03:36:58.63623Z","steps":["trace[1266005320] 'process raft request' (duration: 118.562429ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.253459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.868537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:36:59.253779Z","caller":"traceutil/trace.go:171","msg":"trace[1641743448] linearizableReadLoop","detail":"{readStateIndex:1323; appliedIndex:1322; }","duration":"612.93278ms","start":"2026-06-26T03:36:58.640827Z","end":"2026-06-26T03:36:59.253759Z","steps":["trace[1641743448] 'read index received' (duration: 285.682632ms)","trace[1641743448] 'applied index is now lower than readState.Index' (duration: 327.248848ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:59.253869Z","caller":"traceutil/trace.go:171","msg":"trace[244101647] transaction","detail":"{read_only:false; response_revision:1266; number_of_response:1; }","duration":"613.109814ms","start":"2026-06-26T03:36:58.640746Z","end":"2026-06-26T03:36:59.253856Z","steps":["trace[244101647] 'process raft request' (duration: 285.742823ms)","trace[244101647] 'compare' (duration: 326.684462ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:59.253932Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:58.640732Z","time spent":"613.173936ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":459,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:36:59.254122Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"613.276039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.78\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-06-26T03:36:59.254207Z","caller":"traceutil/trace.go:171","msg":"trace[274784314] range","detail":"{range_begin:/registry/masterleases/199.204.45.78; range_end:; response_count:1; response_revision:1266; }","duration":"613.411162ms","start":"2026-06-26T03:36:58.640775Z","end":"2026-06-26T03:36:59.254186Z","steps":["trace[274784314] 'agreement among raft nodes before linearized reading' (duration: 613.118615ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.254256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:58.640757Z","time spent":"613.488475ms","remote":"127.0.0.1:53274","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.78\" "} {"level":"info","ts":"2026-06-26T03:36:59.275947Z","caller":"traceutil/trace.go:171","msg":"trace[601154582] transaction","detail":"{read_only:false; response_revision:1267; number_of_response:1; }","duration":"606.496239ms","start":"2026-06-26T03:36:58.669405Z","end":"2026-06-26T03:36:59.275901Z","steps":["trace[601154582] 'process raft request' (duration: 606.286953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.276141Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:58.669375Z","time spent":"606.665213ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":788,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:36:59.276009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.111624ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:36:59.276388Z","caller":"traceutil/trace.go:171","msg":"trace[109105418] range","detail":"{range_begin:/registry/deployments/; range_end:/registry/deployments0; response_count:0; response_revision:1267; }","duration":"421.565356ms","start":"2026-06-26T03:36:58.854795Z","end":"2026-06-26T03:36:59.276361Z","steps":["trace[109105418] 'agreement among raft nodes before linearized reading' (duration: 421.102043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.276575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:58.854771Z","time spent":"421.748852ms","remote":"127.0.0.1:53658","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":4,"response size":30,"request content":"key:\"/registry/deployments/\" range_end:\"/registry/deployments0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:36:59.686242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.418174ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"warn","ts":"2026-06-26T03:36:59.686448Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:59.255255Z","time spent":"431.187777ms","remote":"127.0.0.1:53274","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-26T03:36:59.686811Z","caller":"traceutil/trace.go:171","msg":"trace[113840872] transaction","detail":"{read_only:false; response_revision:1268; number_of_response:1; }","duration":"427.348658ms","start":"2026-06-26T03:36:59.259442Z","end":"2026-06-26T03:36:59.686791Z","steps":["trace[113840872] 'process raft request' (duration: 426.907136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.686905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:59.25938Z","time spent":"427.477272ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":773,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:36:59.687625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"429.097877ms","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-26T03:36:59.687721Z","caller":"traceutil/trace.go:171","msg":"trace[559093702] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1268; }","duration":"429.18474ms","start":"2026-06-26T03:36:59.258474Z","end":"2026-06-26T03:36:59.687659Z","steps":["trace[559093702] 'agreement among raft nodes before linearized reading' (duration: 429.006495ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.687764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:59.258453Z","time spent":"429.302574ms","remote":"127.0.0.1:53476","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-26T03:36:59.688285Z","caller":"traceutil/trace.go:171","msg":"trace[772437866] linearizableReadLoop","detail":"{readStateIndex:1326; appliedIndex:1324; }","duration":"410.779683ms","start":"2026-06-26T03:36:59.275851Z","end":"2026-06-26T03:36:59.686631Z","steps":["trace[772437866] 'read index received' (duration: 245.074621ms)","trace[772437866] 'applied index is now lower than readState.Index' (duration: 165.703052ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:36:59.716534Z","caller":"traceutil/trace.go:171","msg":"trace[1583797470] transaction","detail":"{read_only:false; response_revision:1269; number_of_response:1; }","duration":"436.583888ms","start":"2026-06-26T03:36:59.279919Z","end":"2026-06-26T03:36:59.716503Z","steps":["trace[1583797470] 'process raft request' (duration: 436.400314ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:59.716541Z","caller":"traceutil/trace.go:171","msg":"trace[382333473] transaction","detail":"{read_only:false; response_revision:1270; number_of_response:1; }","duration":"401.845722ms","start":"2026-06-26T03:36:59.314666Z","end":"2026-06-26T03:36:59.716512Z","steps":["trace[382333473] 'process raft request' (duration: 401.769771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.716696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:59.279898Z","time spent":"436.713982ms","remote":"127.0.0.1:53318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":836,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-26T03:36:59.716876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:36:59.314632Z","time spent":"401.988506ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:36:59.724156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.119946ms","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-26T03:36:59.724223Z","caller":"traceutil/trace.go:171","msg":"trace[1305541786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1272; }","duration":"248.24989ms","start":"2026-06-26T03:36:59.475958Z","end":"2026-06-26T03:36:59.724208Z","steps":["trace[1305541786] 'agreement among raft nodes before linearized reading' (duration: 248.010593ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:36:59.942282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.047528ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:36:59.942391Z","caller":"traceutil/trace.go:171","msg":"trace[1579855060] linearizableReadLoop","detail":"{readStateIndex:1331; appliedIndex:1330; }","duration":"127.13469ms","start":"2026-06-26T03:36:59.815237Z","end":"2026-06-26T03:36:59.942371Z","steps":["trace[1579855060] 'read index received' (duration: 20.811695ms)","trace[1579855060] 'applied index is now lower than readState.Index' (duration: 106.321845ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:36:59.942568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.335755ms","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-26T03:36:59.942593Z","caller":"traceutil/trace.go:171","msg":"trace[917382382] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1273; }","duration":"127.403187ms","start":"2026-06-26T03:36:59.815181Z","end":"2026-06-26T03:36:59.942584Z","steps":["trace[917382382] 'agreement among raft nodes before linearized reading' (duration: 127.238422ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:36:59.942816Z","caller":"traceutil/trace.go:171","msg":"trace[113721912] transaction","detail":"{read_only:false; response_revision:1273; number_of_response:1; }","duration":"206.95485ms","start":"2026-06-26T03:36:59.735812Z","end":"2026-06-26T03:36:59.942767Z","steps":["trace[113721912] 'process raft request' (duration: 100.333316ms)","trace[113721912] 'compare' (duration: 105.937445ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:00.243193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.478965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:37:00.243296Z","caller":"traceutil/trace.go:171","msg":"trace[1085194380] transaction","detail":"{read_only:false; response_revision:1275; number_of_response:1; }","duration":"222.60567ms","start":"2026-06-26T03:37:00.020671Z","end":"2026-06-26T03:37:00.243277Z","steps":["trace[1085194380] 'process raft request' (duration: 71.9593ms)","trace[1085194380] 'compare' (duration: 150.336361ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:07.135931Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605521677828985,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-26T03:37:08.089199Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.818269ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:08.089344Z","caller":"traceutil/trace.go:171","msg":"trace[280568287] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:1329; }","duration":"382.984853ms","start":"2026-06-26T03:37:07.706337Z","end":"2026-06-26T03:37:08.089321Z","steps":["trace[280568287] 'range keys from in-memory index tree' (duration: 382.798688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:08.089946Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"907.921873ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:37:08.090489Z","caller":"traceutil/trace.go:171","msg":"trace[213481389] linearizableReadLoop","detail":"{readStateIndex:1389; appliedIndex:1388; }","duration":"1.455507357s","start":"2026-06-26T03:37:06.634966Z","end":"2026-06-26T03:37:08.090474Z","steps":["trace[213481389] 'read index received' (duration: 546.653879ms)","trace[213481389] 'applied index is now lower than readState.Index' (duration: 908.852638ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:08.090585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.455631852s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:08.090609Z","caller":"traceutil/trace.go:171","msg":"trace[1427755584] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1330; }","duration":"1.455703382s","start":"2026-06-26T03:37:06.634897Z","end":"2026-06-26T03:37:08.0906Z","steps":["trace[1427755584] 'agreement among raft nodes before linearized reading' (duration: 1.45565567s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:08.090632Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:06.634844Z","time spent":"1.455782954s","remote":"127.0.0.1:53238","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-26T03:37:08.090629Z","caller":"traceutil/trace.go:171","msg":"trace[2087649751] transaction","detail":"{read_only:false; response_revision:1330; number_of_response:1; }","duration":"1.56357388s","start":"2026-06-26T03:37:06.526973Z","end":"2026-06-26T03:37:08.090547Z","steps":["trace[2087649751] 'process raft request' (duration: 654.725082ms)","trace[2087649751] 'compare' (duration: 907.522761ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:37:08.090844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.591009ms","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:532"} {"level":"info","ts":"2026-06-26T03:37:08.090905Z","caller":"traceutil/trace.go:171","msg":"trace[1490957476] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1330; }","duration":"243.698313ms","start":"2026-06-26T03:37:07.847191Z","end":"2026-06-26T03:37:08.090889Z","steps":["trace[1490957476] 'agreement among raft nodes before linearized reading' (duration: 243.494417ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:08.090911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.446098273s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T03:37:08.090862Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.136378856s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-26T03:37:08.090894Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.448447468s","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-26T03:37:08.090989Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:06.526952Z","time spent":"1.563858109s","remote":"127.0.0.1:53476","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-26T03:37:08.090946Z","caller":"traceutil/trace.go:171","msg":"trace[140341299] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1330; }","duration":"1.446147944s","start":"2026-06-26T03:37:06.644792Z","end":"2026-06-26T03:37:08.09094Z","steps":["trace[140341299] 'agreement among raft nodes before linearized reading' (duration: 1.446070661s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:08.091013Z","caller":"traceutil/trace.go:171","msg":"trace[680406034] range","detail":"{range_begin:/registry/clusterrolebindings/; range_end:/registry/clusterrolebindings0; response_count:0; response_revision:1330; }","duration":"1.136589101s","start":"2026-06-26T03:37:06.954388Z","end":"2026-06-26T03:37:08.090977Z","steps":["trace[680406034] 'agreement among raft nodes before linearized reading' (duration: 1.136302534s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:08.091094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:06.644785Z","time spent":"1.446295827s","remote":"127.0.0.1:53418","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":45,"response size":30,"request content":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:37:08.091126Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:06.95436Z","time spent":"1.136754608s","remote":"127.0.0.1:53552","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":55,"response size":30,"request content":"key:\"/registry/clusterrolebindings/\" range_end:\"/registry/clusterrolebindings0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:37:08.091132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.014631689s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-26T03:37:08.091111Z","caller":"traceutil/trace.go:171","msg":"trace[564083765] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1330; }","duration":"1.448631644s","start":"2026-06-26T03:37:06.642415Z","end":"2026-06-26T03:37:08.091047Z","steps":["trace[564083765] 'agreement among raft nodes before linearized reading' (duration: 1.448196431s)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:08.091244Z","caller":"traceutil/trace.go:171","msg":"trace[952952948] range","detail":"{range_begin:/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1330; }","duration":"1.014746721s","start":"2026-06-26T03:37:07.076448Z","end":"2026-06-26T03:37:08.091194Z","steps":["trace[952952948] 'agreement among raft nodes before linearized reading' (duration: 1.014559557s)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:08.091286Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:07.076423Z","time spent":"1.014853324s","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/external-resizer-rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-26T03:37:08.091351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:06.642407Z","time spent":"1.448929842s","remote":"127.0.0.1:53476","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-26T03:37:08.092109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.760366ms","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-26T03:37:08.092649Z","caller":"traceutil/trace.go:171","msg":"trace[1882662158] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1330; }","duration":"109.212106ms","start":"2026-06-26T03:37:07.983419Z","end":"2026-06-26T03:37:08.092631Z","steps":["trace[1882662158] 'agreement among raft nodes before linearized reading' (duration: 107.320943ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:08.216649Z","caller":"traceutil/trace.go:171","msg":"trace[1985462911] transaction","detail":"{read_only:false; response_revision:1331; number_of_response:1; }","duration":"120.836332ms","start":"2026-06-26T03:37:08.095787Z","end":"2026-06-26T03:37:08.216623Z","steps":["trace[1985462911] 'process raft request' (duration: 120.647297ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:08.22198Z","caller":"traceutil/trace.go:171","msg":"trace[1142915286] transaction","detail":"{read_only:false; response_revision:1332; number_of_response:1; }","duration":"126.001888ms","start":"2026-06-26T03:37:08.095949Z","end":"2026-06-26T03:37:08.221951Z","steps":["trace[1142915286] 'process raft request' (duration: 125.699259ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:08.222486Z","caller":"traceutil/trace.go:171","msg":"trace[1717710582] linearizableReadLoop","detail":"{readStateIndex:1394; appliedIndex:1389; }","duration":"122.947622ms","start":"2026-06-26T03:37:08.09951Z","end":"2026-06-26T03:37:08.222457Z","steps":["trace[1717710582] 'read index received' (duration: 116.890062ms)","trace[1717710582] 'applied index is now lower than readState.Index' (duration: 6.05619ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:08.222634Z","caller":"traceutil/trace.go:171","msg":"trace[1047925072] transaction","detail":"{read_only:false; response_revision:1333; number_of_response:1; }","duration":"125.34143ms","start":"2026-06-26T03:37:08.097267Z","end":"2026-06-26T03:37:08.222608Z","steps":["trace[1047925072] 'process raft request' (duration: 124.63089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:08.222655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.119017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:08.222697Z","caller":"traceutil/trace.go:171","msg":"trace[26867819] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1335; }","duration":"123.183678ms","start":"2026-06-26T03:37:08.099501Z","end":"2026-06-26T03:37:08.222685Z","steps":["trace[26867819] 'agreement among raft nodes before linearized reading' (duration: 123.066375ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:08.222724Z","caller":"traceutil/trace.go:171","msg":"trace[52589089] transaction","detail":"{read_only:false; response_revision:1334; number_of_response:1; }","duration":"124.676931ms","start":"2026-06-26T03:37:08.098031Z","end":"2026-06-26T03:37:08.222708Z","steps":["trace[52589089] 'process raft request' (duration: 124.166206ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:08.222854Z","caller":"traceutil/trace.go:171","msg":"trace[3247917] transaction","detail":"{read_only:false; response_revision:1335; number_of_response:1; }","duration":"124.744612ms","start":"2026-06-26T03:37:08.098099Z","end":"2026-06-26T03:37:08.222844Z","steps":["trace[3247917] 'process raft request' (duration: 124.189347ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:30.509412Z","caller":"traceutil/trace.go:171","msg":"trace[196924987] transaction","detail":"{read_only:false; response_revision:1436; number_of_response:1; }","duration":"179.726537ms","start":"2026-06-26T03:37:30.329658Z","end":"2026-06-26T03:37:30.509384Z","steps":["trace[196924987] 'process raft request' (duration: 178.954025ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:30.50952Z","caller":"traceutil/trace.go:171","msg":"trace[386462559] linearizableReadLoop","detail":"{readStateIndex:1501; appliedIndex:1498; }","duration":"176.797144ms","start":"2026-06-26T03:37:30.332686Z","end":"2026-06-26T03:37:30.509483Z","steps":["trace[386462559] 'read index received' (duration: 19.132497ms)","trace[386462559] 'applied index is now lower than readState.Index' (duration: 157.662247ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:30.509565Z","caller":"traceutil/trace.go:171","msg":"trace[180692421] transaction","detail":"{read_only:false; response_revision:1437; number_of_response:1; }","duration":"178.631796ms","start":"2026-06-26T03:37:30.330919Z","end":"2026-06-26T03:37:30.509551Z","steps":["trace[180692421] 'process raft request' (duration: 178.42468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.509835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.118643ms","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:532"} {"level":"info","ts":"2026-06-26T03:37:30.509899Z","caller":"traceutil/trace.go:171","msg":"trace[2035235577] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1437; }","duration":"177.215496ms","start":"2026-06-26T03:37:30.332666Z","end":"2026-06-26T03:37:30.509881Z","steps":["trace[2035235577] 'agreement among raft nodes before linearized reading' (duration: 176.959779ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:30.893836Z","caller":"traceutil/trace.go:171","msg":"trace[1596025984] linearizableReadLoop","detail":"{readStateIndex:1503; appliedIndex:1502; }","duration":"336.15537ms","start":"2026-06-26T03:37:30.557645Z","end":"2026-06-26T03:37:30.893801Z","steps":["trace[1596025984] 'read index received' (duration: 335.969814ms)","trace[1596025984] 'applied index is now lower than readState.Index' (duration: 184.246µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:30.893868Z","caller":"traceutil/trace.go:171","msg":"trace[618648983] transaction","detail":"{read_only:false; response_revision:1439; number_of_response:1; }","duration":"379.530146ms","start":"2026-06-26T03:37:30.514305Z","end":"2026-06-26T03:37:30.893836Z","steps":["trace[618648983] 'process raft request' (duration: 379.31717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.894058Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:30.514278Z","time spent":"379.666969ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:37:30.894145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.465228ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-26T03:37:30.894258Z","caller":"traceutil/trace.go:171","msg":"trace[786776582] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:1439; }","duration":"336.669713ms","start":"2026-06-26T03:37:30.557568Z","end":"2026-06-26T03:37:30.894238Z","steps":["trace[786776582] 'agreement among raft nodes before linearized reading' (duration: 336.401345ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.894311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:30.557545Z","time spent":"336.753644ms","remote":"127.0.0.1:53408","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":5,"response size":30,"request content":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true "} {"level":"info","ts":"2026-06-26T03:37:30.902151Z","caller":"traceutil/trace.go:171","msg":"trace[1607593556] transaction","detail":"{read_only:false; response_revision:1440; number_of_response:1; }","duration":"325.495808ms","start":"2026-06-26T03:37:30.576635Z","end":"2026-06-26T03:37:30.902131Z","steps":["trace[1607593556] 'process raft request' (duration: 325.313963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.902308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:30.576599Z","time spent":"325.605672ms","remote":"127.0.0.1:53476","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-26T03:37:30.902465Z","caller":"traceutil/trace.go:171","msg":"trace[1262673829] transaction","detail":"{read_only:false; response_revision:1441; number_of_response:1; }","duration":"290.518847ms","start":"2026-06-26T03:37:30.611922Z","end":"2026-06-26T03:37:30.902441Z","steps":["trace[1262673829] 'process raft request' (duration: 290.154547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:30.902642Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.477019ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:526"} {"level":"info","ts":"2026-06-26T03:37:30.90275Z","caller":"traceutil/trace.go:171","msg":"trace[1869439457] range","detail":"{range_begin:/registry/leases/kube-system/external-attacher-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1441; }","duration":"111.674915ms","start":"2026-06-26T03:37:30.791049Z","end":"2026-06-26T03:37:30.902724Z","steps":["trace[1869439457] 'agreement among raft nodes before linearized reading' (duration: 111.326425ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:37:53.058422Z","caller":"traceutil/trace.go:171","msg":"trace[1303465114] linearizableReadLoop","detail":"{readStateIndex:1604; appliedIndex:1603; }","duration":"459.156352ms","start":"2026-06-26T03:37:52.599239Z","end":"2026-06-26T03:37:53.058395Z","steps":["trace[1303465114] 'read index received' (duration: 459.07758ms)","trace[1303465114] 'applied index is now lower than readState.Index' (duration: 77.142µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:37:53.058528Z","caller":"traceutil/trace.go:171","msg":"trace[2051726683] transaction","detail":"{read_only:false; response_revision:1536; number_of_response:1; }","duration":"552.100582ms","start":"2026-06-26T03:37:52.50638Z","end":"2026-06-26T03:37:53.05848Z","steps":["trace[2051726683] 'process raft request' (duration: 551.830384ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.058624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"459.361498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:37:53.058665Z","caller":"traceutil/trace.go:171","msg":"trace[563303651] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1536; }","duration":"459.432699ms","start":"2026-06-26T03:37:52.599221Z","end":"2026-06-26T03:37:53.058654Z","steps":["trace[563303651] 'agreement among raft nodes before linearized reading' (duration: 459.310666ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.058714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.599126Z","time spent":"459.574584ms","remote":"127.0.0.1:53512","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:37:53.058821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.506362Z","time spent":"552.290496ms","remote":"127.0.0.1:53476","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-26T03:37:53.063134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.390947ms","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-26T03:37:53.06319Z","caller":"traceutil/trace.go:171","msg":"trace[1119014186] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1537; }","duration":"455.495468ms","start":"2026-06-26T03:37:52.60768Z","end":"2026-06-26T03:37:53.063176Z","steps":["trace[1119014186] 'agreement among raft nodes before linearized reading' (duration: 455.337794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.063168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.784093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-26T03:37:53.063229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.607655Z","time spent":"455.565591ms","remote":"127.0.0.1:53476","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-26T03:37:53.06324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.413167ms","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-26T03:37:53.063269Z","caller":"traceutil/trace.go:171","msg":"trace[66314067] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1537; }","duration":"455.495238ms","start":"2026-06-26T03:37:52.607764Z","end":"2026-06-26T03:37:53.06326Z","steps":["trace[66314067] 'agreement among raft nodes before linearized reading' (duration: 455.418036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.063289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.607738Z","time spent":"455.54542ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-26T03:37:53.063266Z","caller":"traceutil/trace.go:171","msg":"trace[1398564534] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1537; }","duration":"426.912916ms","start":"2026-06-26T03:37:52.636327Z","end":"2026-06-26T03:37:53.06324Z","steps":["trace[1398564534] 'agreement among raft nodes before linearized reading' (duration: 426.788953ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.0633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.681386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-06-26T03:37:53.063329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.636315Z","time spent":"426.997008ms","remote":"127.0.0.1:53228","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-26T03:37:53.063345Z","caller":"traceutil/trace.go:171","msg":"trace[1666979753] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1537; }","duration":"454.748118ms","start":"2026-06-26T03:37:52.608584Z","end":"2026-06-26T03:37:53.063332Z","steps":["trace[1666979753] 'agreement among raft nodes before linearized reading' (duration: 454.590783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:37:53.063379Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:37:52.608575Z","time spent":"454.79798ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-26T03:38:45.39608Z","caller":"traceutil/trace.go:171","msg":"trace[1267389123] transaction","detail":"{read_only:false; response_revision:1776; number_of_response:1; }","duration":"101.053917ms","start":"2026-06-26T03:38:45.295003Z","end":"2026-06-26T03:38:45.396057Z","steps":["trace[1267389123] 'process raft request' (duration: 100.903842ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:05.161437Z","caller":"traceutil/trace.go:171","msg":"trace[1750842071] transaction","detail":"{read_only:false; response_revision:1867; number_of_response:1; }","duration":"170.853907ms","start":"2026-06-26T03:39:04.990538Z","end":"2026-06-26T03:39:05.161392Z","steps":["trace[1750842071] 'process raft request' (duration: 140.001621ms)","trace[1750842071] 'compare' (duration: 30.402474ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:05.807277Z","caller":"traceutil/trace.go:171","msg":"trace[1041220205] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"222.031746ms","start":"2026-06-26T03:39:05.585222Z","end":"2026-06-26T03:39:05.807254Z","steps":["trace[1041220205] 'process raft request' (duration: 221.81225ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:05.807648Z","caller":"traceutil/trace.go:171","msg":"trace[388811090] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"222.375894ms","start":"2026-06-26T03:39:05.58526Z","end":"2026-06-26T03:39:05.807636Z","steps":["trace[388811090] 'process raft request' (duration: 221.953802ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:05.807656Z","caller":"traceutil/trace.go:171","msg":"trace[1352417983] linearizableReadLoop","detail":"{readStateIndex:1956; appliedIndex:1951; }","duration":"168.402749ms","start":"2026-06-26T03:39:05.639207Z","end":"2026-06-26T03:39:05.80761Z","steps":["trace[1352417983] 'read index received' (duration: 8.505879ms)","trace[1352417983] 'applied index is now lower than readState.Index' (duration: 159.89587ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:05.807785Z","caller":"traceutil/trace.go:171","msg":"trace[1584073963] transaction","detail":"{read_only:false; response_revision:1873; number_of_response:1; }","duration":"221.315726ms","start":"2026-06-26T03:39:05.586404Z","end":"2026-06-26T03:39:05.80772Z","steps":["trace[1584073963] 'process raft request' (duration: 221.156992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:05.807962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:05.808014Z","caller":"traceutil/trace.go:171","msg":"trace[1343620271] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1873; }","duration":"168.858573ms","start":"2026-06-26T03:39:05.639142Z","end":"2026-06-26T03:39:05.808001Z","steps":["trace[1343620271] 'agreement among raft nodes before linearized reading' (duration: 168.717858ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:05.807952Z","caller":"traceutil/trace.go:171","msg":"trace[1823479372] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"222.224922ms","start":"2026-06-26T03:39:05.58545Z","end":"2026-06-26T03:39:05.807675Z","steps":["trace[1823479372] 'process raft request' (duration: 222.001125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:25.698243Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":7967605521677830524,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-26T03:39:26.055808Z","caller":"traceutil/trace.go:171","msg":"trace[2035484640] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"941.494028ms","start":"2026-06-26T03:39:25.114294Z","end":"2026-06-26T03:39:26.055788Z","steps":["trace[2035484640] 'process raft request' (duration: 941.327364ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.055934Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.114279Z","time spent":"941.591611ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:39:26.057516Z","caller":"traceutil/trace.go:171","msg":"trace[1024539802] linearizableReadLoop","detail":"{readStateIndex:2047; appliedIndex:2045; }","duration":"859.876285ms","start":"2026-06-26T03:39:25.19763Z","end":"2026-06-26T03:39:26.057506Z","steps":["trace[1024539802] 'read index received' (duration: 857.980853ms)","trace[1024539802] 'applied index is now lower than readState.Index' (duration: 1.894522ms)"],"step_count":2} {"level":"warn","ts":"2026-06-26T03:39:26.057825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"421.231578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:26.057845Z","caller":"traceutil/trace.go:171","msg":"trace[1096079306] transaction","detail":"{read_only:false; response_revision:1960; number_of_response:1; }","duration":"477.111397ms","start":"2026-06-26T03:39:25.580713Z","end":"2026-06-26T03:39:26.057824Z","steps":["trace[1096079306] 'process raft request' (duration: 476.748238ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:26.057908Z","caller":"traceutil/trace.go:171","msg":"trace[80734786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1960; }","duration":"421.358442ms","start":"2026-06-26T03:39:25.636522Z","end":"2026-06-26T03:39:26.057881Z","steps":["trace[80734786] 'agreement among raft nodes before linearized reading' (duration: 421.226009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.057923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.09917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-26T03:39:26.057954Z","caller":"traceutil/trace.go:171","msg":"trace[775060380] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1960; }","duration":"142.189083ms","start":"2026-06-26T03:39:25.915756Z","end":"2026-06-26T03:39:26.057945Z","steps":["trace[775060380] 'agreement among raft nodes before linearized reading' (duration: 142.111581ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.057946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.636503Z","time spent":"421.437554ms","remote":"127.0.0.1:53228","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-26T03:39:26.057959Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.580687Z","time spent":"477.213621ms","remote":"127.0.0.1:53476","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-26T03:39:26.05796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"860.319088ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" ","response":"range_response_count:1 size:473"} {"level":"info","ts":"2026-06-26T03:39:26.058025Z","caller":"traceutil/trace.go:171","msg":"trace[1748906390] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1960; }","duration":"860.425861ms","start":"2026-06-26T03:39:25.197579Z","end":"2026-06-26T03:39:26.058004Z","steps":["trace[1748906390] 'agreement among raft nodes before linearized reading' (duration: 860.221725ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.058079Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.197552Z","time spent":"860.515305ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":496,"request content":"key:\"/registry/leases/kube-system/rbd-csi-ceph-com\" "} {"level":"warn","ts":"2026-06-26T03:39:26.057848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.596495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-26T03:39:26.058124Z","caller":"traceutil/trace.go:171","msg":"trace[1281222170] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1960; }","duration":"152.895304ms","start":"2026-06-26T03:39:25.905221Z","end":"2026-06-26T03:39:26.058117Z","steps":["trace[1281222170] 'agreement among raft nodes before linearized reading' (duration: 152.539274ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.058127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.570084ms","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-26T03:39:26.058157Z","caller":"traceutil/trace.go:171","msg":"trace[1546316897] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1960; }","duration":"329.626336ms","start":"2026-06-26T03:39:25.728525Z","end":"2026-06-26T03:39:26.058151Z","steps":["trace[1546316897] 'agreement among raft nodes before linearized reading' (duration: 329.509932ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.058174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:25.728508Z","time spent":"329.662618ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-26T03:39:26.05825Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.346744ms","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-26T03:39:26.058266Z","caller":"traceutil/trace.go:171","msg":"trace[524100404] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1960; }","duration":"154.405206ms","start":"2026-06-26T03:39:25.903857Z","end":"2026-06-26T03:39:26.058263Z","steps":["trace[524100404] 'agreement among raft nodes before linearized reading' (duration: 154.361915ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:26.058442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.366722ms","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:532"} {"level":"info","ts":"2026-06-26T03:39:26.058552Z","caller":"traceutil/trace.go:171","msg":"trace[344923899] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1960; }","duration":"156.520245ms","start":"2026-06-26T03:39:25.902014Z","end":"2026-06-26T03:39:26.058534Z","steps":["trace[344923899] 'agreement among raft nodes before linearized reading' (duration: 156.00724ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:38.366029Z","caller":"traceutil/trace.go:171","msg":"trace[1274746578] transaction","detail":"{read_only:false; response_revision:2016; number_of_response:1; }","duration":"172.109243ms","start":"2026-06-26T03:39:38.193901Z","end":"2026-06-26T03:39:38.36601Z","steps":["trace[1274746578] 'process raft request' (duration: 171.974369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:38.539482Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.138597ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-26T03:39:38.539665Z","caller":"traceutil/trace.go:171","msg":"trace[1238269415] linearizableReadLoop","detail":"{readStateIndex:2107; appliedIndex:2104; }","duration":"320.581162ms","start":"2026-06-26T03:39:38.219069Z","end":"2026-06-26T03:39:38.53965Z","steps":["trace[1238269415] 'read index received' (duration: 146.919726ms)","trace[1238269415] 'applied index is now lower than readState.Index' (duration: 173.660536ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:38.539714Z","caller":"traceutil/trace.go:171","msg":"trace[1908617598] transaction","detail":"{read_only:false; response_revision:2017; number_of_response:1; }","duration":"345.627146ms","start":"2026-06-26T03:39:38.194073Z","end":"2026-06-26T03:39:38.5397Z","steps":["trace[1908617598] 'process raft request' (duration: 227.18024ms)","trace[1908617598] 'compare' (duration: 117.993472ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:39:38.539758Z","caller":"traceutil/trace.go:171","msg":"trace[1319826892] transaction","detail":"{read_only:false; response_revision:2018; number_of_response:1; }","duration":"345.676697ms","start":"2026-06-26T03:39:38.194073Z","end":"2026-06-26T03:39:38.53975Z","steps":["trace[1319826892] 'process raft request' (duration: 345.510723ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:38.539764Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.19405Z","time spent":"345.690808ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:38.539811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.194051Z","time spent":"345.728188ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:39:38.539907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"308.863644ms","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":"warn","ts":"2026-06-26T03:39:38.539947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.878971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:39:38.539976Z","caller":"traceutil/trace.go:171","msg":"trace[1162322356] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:2018; }","duration":"308.944126ms","start":"2026-06-26T03:39:38.231008Z","end":"2026-06-26T03:39:38.539952Z","steps":["trace[1162322356] 'agreement among raft nodes before linearized reading' (duration: 308.834963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:38.539986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.087639ms","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-26T03:39:38.539981Z","caller":"traceutil/trace.go:171","msg":"trace[1432498095] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:2018; }","duration":"320.936662ms","start":"2026-06-26T03:39:38.219033Z","end":"2026-06-26T03:39:38.539969Z","steps":["trace[1432498095] 'agreement among raft nodes before linearized reading' (duration: 320.873401ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:38.54002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.230993Z","time spent":"309.017508ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":554,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-06-26T03:39:38.540024Z","caller":"traceutil/trace.go:171","msg":"trace[1817767496] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2018; }","duration":"309.132971ms","start":"2026-06-26T03:39:38.230878Z","end":"2026-06-26T03:39:38.540011Z","steps":["trace[1817767496] 'agreement among raft nodes before linearized reading' (duration: 309.059188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:38.54003Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.219022Z","time spent":"320.997654ms","remote":"127.0.0.1:58972","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true "} {"level":"warn","ts":"2026-06-26T03:39:38.540057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.230869Z","time spent":"309.181203ms","remote":"127.0.0.1:53476","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-26T03:39:38.539899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.932806ms","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-26T03:39:38.540105Z","caller":"traceutil/trace.go:171","msg":"trace[1258333414] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2018; }","duration":"313.176294ms","start":"2026-06-26T03:39:38.226921Z","end":"2026-06-26T03:39:38.540097Z","steps":["trace[1258333414] 'agreement among raft nodes before linearized reading' (duration: 312.852855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:39:38.54013Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:39:38.226906Z","time spent":"313.218966ms","remote":"127.0.0.1:53476","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-26T03:39:38.743627Z","caller":"traceutil/trace.go:171","msg":"trace[1585139538] transaction","detail":"{read_only:false; response_revision:2022; number_of_response:1; }","duration":"100.265935ms","start":"2026-06-26T03:39:38.643336Z","end":"2026-06-26T03:39:38.743602Z","steps":["trace[1585139538] 'process raft request' (duration: 100.054479ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:39:39.413353Z","caller":"traceutil/trace.go:171","msg":"trace[546892982] transaction","detail":"{read_only:false; response_revision:2024; number_of_response:1; }","duration":"233.849457ms","start":"2026-06-26T03:39:39.179155Z","end":"2026-06-26T03:39:39.413005Z","steps":["trace[546892982] 'process raft request' (duration: 233.668262ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:40:16.692193Z","caller":"traceutil/trace.go:171","msg":"trace[1581628115] linearizableReadLoop","detail":"{readStateIndex:2288; appliedIndex:2287; }","duration":"160.296667ms","start":"2026-06-26T03:40:16.531871Z","end":"2026-06-26T03:40:16.692168Z","steps":["trace[1581628115] 'read index received' (duration: 159.150335ms)","trace[1581628115] 'applied index is now lower than readState.Index' (duration: 1.145492ms)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:40:16.692264Z","caller":"traceutil/trace.go:171","msg":"trace[365230195] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"353.043394ms","start":"2026-06-26T03:40:16.339193Z","end":"2026-06-26T03:40:16.692236Z","steps":["trace[365230195] 'process raft request' (duration: 351.932462ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:16.692438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:16.339168Z","time spent":"353.184978ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":511,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:40:16.692485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.598516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-26T03:40:16.692564Z","caller":"traceutil/trace.go:171","msg":"trace[2048476527] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"160.729141ms","start":"2026-06-26T03:40:16.531818Z","end":"2026-06-26T03:40:16.692547Z","steps":["trace[2048476527] 'agreement among raft nodes before linearized reading' (duration: 160.491583ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:40:17.128664Z","caller":"traceutil/trace.go:171","msg":"trace[536256445] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"302.609732ms","start":"2026-06-26T03:40:16.826032Z","end":"2026-06-26T03:40:17.128642Z","steps":["trace[536256445] 'process raft request' (duration: 302.467559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:17.128812Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:16.826018Z","time spent":"302.721245ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":517,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:40:17.131472Z","caller":"traceutil/trace.go:171","msg":"trace[379749842] transaction","detail":"{read_only:false; response_revision:2197; number_of_response:1; }","duration":"304.437523ms","start":"2026-06-26T03:40:16.82702Z","end":"2026-06-26T03:40:17.131457Z","steps":["trace[379749842] 'process raft request' (duration: 304.361161ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:17.131552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:16.827002Z","time spent":"304.510776ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:40:18.46685Z","caller":"traceutil/trace.go:171","msg":"trace[1774424964] linearizableReadLoop","detail":"{readStateIndex:2295; appliedIndex:2294; }","duration":"134.739353ms","start":"2026-06-26T03:40:18.332081Z","end":"2026-06-26T03:40:18.46682Z","steps":["trace[1774424964] 'read index received' (duration: 134.478365ms)","trace[1774424964] 'applied index is now lower than readState.Index' (duration: 259.648µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:40:18.466971Z","caller":"traceutil/trace.go:171","msg":"trace[793360892] transaction","detail":"{read_only:false; response_revision:2198; number_of_response:1; }","duration":"456.751297ms","start":"2026-06-26T03:40:18.010187Z","end":"2026-06-26T03:40:18.466938Z","steps":["trace[793360892] 'process raft request' (duration: 456.418208ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.467051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.929838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-26T03:40:18.467114Z","caller":"traceutil/trace.go:171","msg":"trace[109984713] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:2198; }","duration":"135.053401ms","start":"2026-06-26T03:40:18.332042Z","end":"2026-06-26T03:40:18.467096Z","steps":["trace[109984713] 'agreement among raft nodes before linearized reading' (duration: 134.911657ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:18.467144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:18.010162Z","time spent":"456.893352ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-26T03:40:18.467785Z","caller":"traceutil/trace.go:171","msg":"trace[1988073943] transaction","detail":"{read_only:false; response_revision:2199; number_of_response:1; }","duration":"124.883746ms","start":"2026-06-26T03:40:18.34288Z","end":"2026-06-26T03:40:18.467764Z","steps":["trace[1988073943] 'process raft request' (duration: 124.743472ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:40:51.008377Z","caller":"traceutil/trace.go:171","msg":"trace[1458121354] linearizableReadLoop","detail":"{readStateIndex:2474; appliedIndex:2473; }","duration":"157.208161ms","start":"2026-06-26T03:40:50.851143Z","end":"2026-06-26T03:40:51.008351Z","steps":["trace[1458121354] 'read index received' (duration: 157.073307ms)","trace[1458121354] 'applied index is now lower than readState.Index' (duration: 133.704µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:40:51.008416Z","caller":"traceutil/trace.go:171","msg":"trace[101673850] transaction","detail":"{read_only:false; response_revision:2369; number_of_response:1; }","duration":"159.015691ms","start":"2026-06-26T03:40:50.849373Z","end":"2026-06-26T03:40:51.008389Z","steps":["trace[101673850] 'process raft request' (duration: 158.765254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:51.008659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.505819ms","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-26T03:40:51.008703Z","caller":"traceutil/trace.go:171","msg":"trace[1457308363] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2369; }","duration":"157.645153ms","start":"2026-06-26T03:40:50.851048Z","end":"2026-06-26T03:40:51.008693Z","steps":["trace[1457308363] 'agreement among raft nodes before linearized reading' (duration: 157.455268ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:51.008705Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.993929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-26T03:40:51.008741Z","caller":"traceutil/trace.go:171","msg":"trace[360069463] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2369; }","duration":"155.064781ms","start":"2026-06-26T03:40:50.853665Z","end":"2026-06-26T03:40:51.00873Z","steps":["trace[360069463] 'agreement among raft nodes before linearized reading' (duration: 154.921557ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:51.008881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.272043ms","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-26T03:40:51.008922Z","caller":"traceutil/trace.go:171","msg":"trace[2037730857] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2369; }","duration":"152.345966ms","start":"2026-06-26T03:40:50.856565Z","end":"2026-06-26T03:40:51.008911Z","steps":["trace[2037730857] 'agreement among raft nodes before linearized reading' (duration: 152.252073ms)"],"step_count":1} {"level":"info","ts":"2026-06-26T03:40:59.423014Z","caller":"traceutil/trace.go:171","msg":"trace[409425237] linearizableReadLoop","detail":"{readStateIndex:2518; appliedIndex:2517; }","duration":"379.286029ms","start":"2026-06-26T03:40:59.043707Z","end":"2026-06-26T03:40:59.422993Z","steps":["trace[409425237] 'read index received' (duration: 379.129564ms)","trace[409425237] 'applied index is now lower than readState.Index' (duration: 155.335µs)"],"step_count":2} {"level":"info","ts":"2026-06-26T03:40:59.423097Z","caller":"traceutil/trace.go:171","msg":"trace[710730513] transaction","detail":"{read_only:false; response_revision:2411; number_of_response:1; }","duration":"424.835343ms","start":"2026-06-26T03:40:58.998231Z","end":"2026-06-26T03:40:59.423066Z","steps":["trace[710730513] 'process raft request' (duration: 424.615457ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:59.42324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.513415ms","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-26T03:40:59.423299Z","caller":"traceutil/trace.go:171","msg":"trace[1280763563] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2411; }","duration":"379.620898ms","start":"2026-06-26T03:40:59.043663Z","end":"2026-06-26T03:40:59.423284Z","steps":["trace[1280763563] 'agreement among raft nodes before linearized reading' (duration: 379.419272ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:59.423339Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:59.043641Z","time spent":"379.6899ms","remote":"127.0.0.1:53476","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-26T03:40:59.423494Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:58.998204Z","time spent":"424.992609ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":493,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-26T03:40:59.426495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.118844ms","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-26T03:40:59.427693Z","caller":"traceutil/trace.go:171","msg":"trace[2004918067] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2412; }","duration":"380.349287ms","start":"2026-06-26T03:40:59.047326Z","end":"2026-06-26T03:40:59.427676Z","steps":["trace[2004918067] 'agreement among raft nodes before linearized reading' (duration: 378.9992ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:59.427751Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:59.047316Z","time spent":"380.423911ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-26T03:40:59.426777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.677653ms","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-26T03:40:59.42794Z","caller":"traceutil/trace.go:171","msg":"trace[2077768597] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2412; }","duration":"378.897988ms","start":"2026-06-26T03:40:59.049025Z","end":"2026-06-26T03:40:59.427923Z","steps":["trace[2077768597] 'agreement among raft nodes before linearized reading' (duration: 377.621472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:59.426845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.122416ms","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-26T03:40:59.428074Z","caller":"traceutil/trace.go:171","msg":"trace[1948276116] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2412; }","duration":"379.388571ms","start":"2026-06-26T03:40:59.048667Z","end":"2026-06-26T03:40:59.428055Z","steps":["trace[1948276116] 'agreement among raft nodes before linearized reading' (duration: 378.042503ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:59.42802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:59.049017Z","time spent":"378.98742ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-26T03:40:59.426712Z","caller":"traceutil/trace.go:171","msg":"trace[486720121] transaction","detail":"{read_only:false; response_revision:2412; number_of_response:1; }","duration":"145.604436ms","start":"2026-06-26T03:40:59.281086Z","end":"2026-06-26T03:40:59.42669Z","steps":["trace[486720121] 'process raft request' (duration: 145.126083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-26T03:40:59.428144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-26T03:40:59.048654Z","time spent":"379.474844ms","remote":"127.0.0.1:53476","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\" "}