{"level":"warn","ts":"2026-05-05T13:48:00.260055Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T13:48:00.260184Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.170:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.170:2380","--initial-cluster=instance=https://199.19.213.170:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.170:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.170: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-05-05T13:48:00.260275Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-05T13:48:00.260289Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.170:2380"]} {"level":"info","ts":"2026-05-05T13:48:00.260316Z","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-05-05T13:48:00.261132Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"]} {"level":"info","ts":"2026-05-05T13:48:00.261231Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.170:2380"],"listen-peer-urls":["https://199.19.213.170:2380"],"advertise-client-urls":["https://199.19.213.170:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.170: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-05-05T13:48:00.268408Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"6.85244ms"} {"level":"info","ts":"2026-05-05T13:48:00.278016Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"80be33c6b0d5a492","cluster-id":"abad33c2eec87dc"} {"level":"info","ts":"2026-05-05T13:48:00.278102Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=()"} {"level":"info","ts":"2026-05-05T13:48:00.278127Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became follower at term 0"} {"level":"info","ts":"2026-05-05T13:48:00.278145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 80be33c6b0d5a492 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-05T13:48:00.278162Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became follower at term 1"} {"level":"info","ts":"2026-05-05T13:48:00.278206Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=(9276909210893132946)"} {"level":"warn","ts":"2026-05-05T13:48:00.285777Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-05T13:48:00.288438Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-05T13:48:00.289634Z","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-05-05T13:48:00.291881Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"80be33c6b0d5a492","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-05T13:48:00.292165Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"80be33c6b0d5a492","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-05T13:48:00.292182Z","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-05-05T13:48:00.293439Z","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-05-05T13:48:00.293491Z","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-05-05T13:48:00.292783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 switched to configuration voters=(9276909210893132946)"} {"level":"info","ts":"2026-05-05T13:48:00.293791Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"abad33c2eec87dc","local-member-id":"80be33c6b0d5a492","added-peer-id":"80be33c6b0d5a492","added-peer-peer-urls":["https://199.19.213.170:2380"]} {"level":"info","ts":"2026-05-05T13:48:00.298987Z","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-05-05T13:48:00.299322Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"80be33c6b0d5a492","initial-advertise-peer-urls":["https://199.19.213.170:2380"],"listen-peer-urls":["https://199.19.213.170:2380"],"advertise-client-urls":["https://199.19.213.170:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.170:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-05T13:48:00.299374Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-05T13:48:00.299446Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.170:2380"} {"level":"info","ts":"2026-05-05T13:48:00.299533Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.170:2380"} {"level":"info","ts":"2026-05-05T13:48:00.480104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 is starting a new election at term 1"} {"level":"info","ts":"2026-05-05T13:48:00.480145Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-05T13:48:00.480159Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 received MsgPreVoteResp from 80be33c6b0d5a492 at term 1"} {"level":"info","ts":"2026-05-05T13:48:00.480169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became candidate at term 2"} {"level":"info","ts":"2026-05-05T13:48:00.480175Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 received MsgVoteResp from 80be33c6b0d5a492 at term 2"} {"level":"info","ts":"2026-05-05T13:48:00.480182Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"80be33c6b0d5a492 became leader at term 2"} {"level":"info","ts":"2026-05-05T13:48:00.480189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 80be33c6b0d5a492 elected leader 80be33c6b0d5a492 at term 2"} {"level":"info","ts":"2026-05-05T13:48:00.486002Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:48:00.486301Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T13:48:00.486397Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-05T13:48:00.486842Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-05T13:48:00.486923Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-05T13:48:00.487085Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"abad33c2eec87dc","local-member-id":"80be33c6b0d5a492","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:48:00.487176Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:48:00.487202Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-05T13:48:00.488071Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-05T13:48:00.492149Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.170:2379"} {"level":"info","ts":"2026-05-05T13:48:00.487011Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"80be33c6b0d5a492","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.170:2379]}","request-path":"/0/members/80be33c6b0d5a492/attributes","cluster-id":"abad33c2eec87dc","publish-timeout":"7s"} {"level":"info","ts":"2026-05-05T13:48:02.111969Z","caller":"traceutil/trace.go:171","msg":"trace[604582251] transaction","detail":"{read_only:false; response_revision:2; number_of_response:1; }","duration":"158.908675ms","start":"2026-05-05T13:48:01.95304Z","end":"2026-05-05T13:48:02.111949Z","steps":["trace[604582251] 'process raft request' (duration: 158.68792ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.573565Z","caller":"traceutil/trace.go:171","msg":"trace[1233737522] transaction","detail":"{read_only:false; response_revision:3; number_of_response:1; }","duration":"620.345862ms","start":"2026-05-05T13:48:01.953173Z","end":"2026-05-05T13:48:02.573519Z","steps":["trace[1233737522] 'process raft request' (duration: 620.093707ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.574057Z","caller":"traceutil/trace.go:171","msg":"trace[1440166203] transaction","detail":"{read_only:false; response_revision:4; number_of_response:1; }","duration":"545.511793ms","start":"2026-05-05T13:48:02.028507Z","end":"2026-05-05T13:48:02.574019Z","steps":["trace[1440166203] 'process raft request' (duration: 544.880008ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.575228Z","caller":"traceutil/trace.go:171","msg":"trace[1463737961] linearizableReadLoop","detail":"{readStateIndex:6; appliedIndex:4; }","duration":"610.922762ms","start":"2026-05-05T13:48:01.964228Z","end":"2026-05-05T13:48:02.57515Z","steps":["trace[1463737961] 'read index received' (duration: 147.58993ms)","trace[1463737961] 'applied index is now lower than readState.Index' (duration: 463.2694ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:48:02.576894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:01.95316Z","time spent":"620.928746ms","remote":"127.0.0.1:60028","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":105,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T13:48:02.577172Z","caller":"traceutil/trace.go:171","msg":"trace[110742344] transaction","detail":"{read_only:false; response_revision:9; number_of_response:1; }","duration":"547.133791ms","start":"2026-05-05T13:48:02.029954Z","end":"2026-05-05T13:48:02.577088Z","steps":["trace[110742344] 'process raft request' (duration: 544.714644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.577386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.029935Z","time spent":"547.377307ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":920,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.577147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.028488Z","time spent":"545.652566ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.578172Z","caller":"traceutil/trace.go:171","msg":"trace[392526565] transaction","detail":"{read_only:false; response_revision:10; number_of_response:1; }","duration":"539.337808ms","start":"2026-05-05T13:48:02.03863Z","end":"2026-05-05T13:48:02.577968Z","steps":["trace[392526565] 'process raft request' (duration: 536.212645ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.578273Z","caller":"traceutil/trace.go:171","msg":"trace[433837423] transaction","detail":"{read_only:false; response_revision:6; number_of_response:1; }","duration":"549.066726ms","start":"2026-05-05T13:48:02.028941Z","end":"2026-05-05T13:48:02.578008Z","steps":["trace[433837423] 'process raft request' (duration: 545.423351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.578382Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.028931Z","time spent":"549.388314ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":883,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.578352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.038618Z","time spent":"539.679746ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3159,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.578395Z","caller":"traceutil/trace.go:171","msg":"trace[1293986919] transaction","detail":"{read_only:false; response_revision:7; number_of_response:1; }","duration":"549.370204ms","start":"2026-05-05T13:48:02.028995Z","end":"2026-05-05T13:48:02.578365Z","steps":["trace[1293986919] 'process raft request' (duration: 545.454012ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.578572Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.028991Z","time spent":"549.479336ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":992,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.578717Z","caller":"traceutil/trace.go:171","msg":"trace[2078990086] transaction","detail":"{read_only:false; response_revision:8; number_of_response:1; }","duration":"549.567658ms","start":"2026-05-05T13:48:02.029028Z","end":"2026-05-05T13:48:02.578596Z","steps":["trace[2078990086] 'process raft request' (duration: 545.581315ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.578941Z","caller":"traceutil/trace.go:171","msg":"trace[924995740] transaction","detail":"{read_only:false; response_revision:5; number_of_response:1; }","duration":"550.021158ms","start":"2026-05-05T13:48:02.028893Z","end":"2026-05-05T13:48:02.578914Z","steps":["trace[924995740] 'process raft request' (duration: 545.043532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.578965Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.029011Z","time spent":"549.796863ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":971,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.579019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.028868Z","time spent":"550.115211ms","remote":"127.0.0.1:60418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":698,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.579434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"499.549118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-05T13:48:02.579552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"549.405234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-05T13:48:02.579651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.11294ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-05T13:48:02.579663Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.989942ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-05T13:48:02.579669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.412016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csinodes/instance\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T13:48:02.579691Z","caller":"traceutil/trace.go:171","msg":"trace[498161835] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"476.164892ms","start":"2026-05-05T13:48:02.103512Z","end":"2026-05-05T13:48:02.579677Z","steps":["trace[498161835] 'agreement among raft nodes before linearized reading' (duration: 476.103421ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.579715Z","caller":"traceutil/trace.go:171","msg":"trace[1465900039] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"477.080174ms","start":"2026-05-05T13:48:02.102611Z","end":"2026-05-05T13:48:02.579691Z","steps":["trace[1465900039] 'agreement among raft nodes before linearized reading' (duration: 476.996122ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.579741Z","caller":"traceutil/trace.go:171","msg":"trace[1656257590] range","detail":"{range_begin:/registry/csinodes/instance; range_end:; response_count:0; response_revision:11; }","duration":"615.506659ms","start":"2026-05-05T13:48:01.964206Z","end":"2026-05-05T13:48:02.579712Z","steps":["trace[1656257590] 'agreement among raft nodes before linearized reading' (duration: 615.399767ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.579794Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:01.964193Z","time spent":"615.587541ms","remote":"127.0.0.1:60356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/csinodes/instance\" "} {"level":"warn","ts":"2026-05-05T13:48:02.579837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.102524Z","time spent":"477.225337ms","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-05T13:48:02.580094Z","caller":"traceutil/trace.go:171","msg":"trace[1603368205] transaction","detail":"{read_only:false; response_revision:11; number_of_response:1; }","duration":"537.039475ms","start":"2026-05-05T13:48:02.043037Z","end":"2026-05-05T13:48:02.580077Z","steps":["trace[1603368205] 'process raft request' (duration: 531.964806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.58023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.043014Z","time spent":"537.163788ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":845,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.580307Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.890199ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T13:48:02.580358Z","caller":"traceutil/trace.go:171","msg":"trace[1446295163] range","detail":"{range_begin:/registry/resourcequotas/kube-system/; range_end:/registry/resourcequotas/kube-system0; response_count:0; response_revision:11; }","duration":"550.982881ms","start":"2026-05-05T13:48:02.029356Z","end":"2026-05-05T13:48:02.580339Z","steps":["trace[1446295163] 'agreement among raft nodes before linearized reading' (duration: 550.916509ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.580387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.029339Z","time spent":"551.042063ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":27,"request content":"key:\"/registry/resourcequotas/kube-system/\" range_end:\"/registry/resourcequotas/kube-system0\" "} {"level":"warn","ts":"2026-05-05T13:48:02.579724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.103504Z","time spent":"476.214743ms","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-05T13:48:02.579562Z","caller":"traceutil/trace.go:171","msg":"trace[383685556] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"499.759343ms","start":"2026-05-05T13:48:02.079766Z","end":"2026-05-05T13:48:02.579525Z","steps":["trace[383685556] 'agreement among raft nodes before linearized reading' (duration: 499.550428ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.581956Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.07972Z","time spent":"502.21906ms","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"warn","ts":"2026-05-05T13:48:02.579442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"553.282134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.170\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T13:48:02.582196Z","caller":"traceutil/trace.go:171","msg":"trace[687782734] range","detail":"{range_begin:/registry/masterleases/199.19.213.170; range_end:; response_count:0; response_revision:11; }","duration":"556.48665ms","start":"2026-05-05T13:48:02.025685Z","end":"2026-05-05T13:48:02.582172Z","steps":["trace[687782734] 'agreement among raft nodes before linearized reading' (duration: 552.447355ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.58224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.025665Z","time spent":"556.564041ms","remote":"127.0.0.1:59994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":0,"response size":27,"request content":"key:\"/registry/masterleases/199.19.213.170\" "} {"level":"warn","ts":"2026-05-05T13:48:02.579429Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"476.192212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T13:48:02.582522Z","caller":"traceutil/trace.go:171","msg":"trace[589036314] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"479.395297ms","start":"2026-05-05T13:48:02.103113Z","end":"2026-05-05T13:48:02.582509Z","steps":["trace[589036314] 'agreement among raft nodes before linearized reading' (duration: 476.174352ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.582566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.103102Z","time spent":"479.446698ms","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-05T13:48:02.579672Z","caller":"traceutil/trace.go:171","msg":"trace[1256527384] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:0; response_revision:11; }","duration":"549.577928ms","start":"2026-05-05T13:48:02.030074Z","end":"2026-05-05T13:48:02.579652Z","steps":["trace[1256527384] 'agreement among raft nodes before linearized reading' (duration: 549.436854ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.583488Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.030046Z","time spent":"553.382397ms","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Range","request count":0,"request size":34,"response count":0,"response size":27,"request content":"key:\"/registry/namespaces/kube-system\" "} {"level":"info","ts":"2026-05-05T13:48:02.90564Z","caller":"traceutil/trace.go:171","msg":"trace[1683231466] linearizableReadLoop","detail":"{readStateIndex:15; appliedIndex:14; }","duration":"319.331375ms","start":"2026-05-05T13:48:02.586277Z","end":"2026-05-05T13:48:02.905609Z","steps":["trace[1683231466] 'read index received' (duration: 317.38993ms)","trace[1683231466] 'applied index is now lower than readState.Index' (duration: 1.940485ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:48:02.90575Z","caller":"traceutil/trace.go:171","msg":"trace[1332432720] transaction","detail":"{read_only:false; response_revision:12; number_of_response:1; }","duration":"319.686994ms","start":"2026-05-05T13:48:02.586054Z","end":"2026-05-05T13:48:02.905741Z","steps":["trace[1332432720] 'process raft request' (duration: 317.600855ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.905847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586044Z","time spent":"319.736655ms","remote":"127.0.0.1:60418","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":704,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.905957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.659734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-05T13:48:02.906032Z","caller":"traceutil/trace.go:171","msg":"trace[112230273] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:12; }","duration":"319.748756ms","start":"2026-05-05T13:48:02.586262Z","end":"2026-05-05T13:48:02.906011Z","steps":["trace[112230273] 'agreement among raft nodes before linearized reading' (duration: 319.546791ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.906073Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586257Z","time spent":"319.808217ms","remote":"127.0.0.1:59964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-05T13:48:02.90847Z","caller":"traceutil/trace.go:171","msg":"trace[657841766] transaction","detail":"{read_only:false; response_revision:13; number_of_response:1; }","duration":"322.109921ms","start":"2026-05-05T13:48:02.58634Z","end":"2026-05-05T13:48:02.90845Z","steps":["trace[657841766] 'process raft request' (duration: 321.845805ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.908561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586334Z","time spent":"322.181922ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":965,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.908755Z","caller":"traceutil/trace.go:171","msg":"trace[1342619508] transaction","detail":"{read_only:false; response_revision:14; number_of_response:1; }","duration":"322.199483ms","start":"2026-05-05T13:48:02.586545Z","end":"2026-05-05T13:48:02.908745Z","steps":["trace[1342619508] 'process raft request' (duration: 321.746362ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.908814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586537Z","time spent":"322.248234ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":923,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.90891Z","caller":"traceutil/trace.go:171","msg":"trace[248133693] transaction","detail":"{read_only:false; response_revision:16; number_of_response:1; }","duration":"322.298225ms","start":"2026-05-05T13:48:02.586597Z","end":"2026-05-05T13:48:02.908895Z","steps":["trace[248133693] 'process raft request' (duration: 321.798183ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.908982Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586575Z","time spent":"322.375847ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":968,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.909101Z","caller":"traceutil/trace.go:171","msg":"trace[370517198] transaction","detail":"{read_only:false; response_revision:15; number_of_response:1; }","duration":"322.469379ms","start":"2026-05-05T13:48:02.586591Z","end":"2026-05-05T13:48:02.90906Z","steps":["trace[370517198] 'process raft request' (duration: 321.773813ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:02.90915Z","caller":"traceutil/trace.go:171","msg":"trace[1692686469] transaction","detail":"{read_only:false; number_of_response:0; response_revision:18; }","duration":"320.883462ms","start":"2026-05-05T13:48:02.58817Z","end":"2026-05-05T13:48:02.909053Z","steps":["trace[1692686469] 'process raft request' (duration: 320.312318ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.910468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586585Z","time spent":"323.81801ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.910571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.588163Z","time spent":"322.354866ms","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.909407Z","caller":"traceutil/trace.go:171","msg":"trace[1858003060] transaction","detail":"{read_only:false; response_revision:17; number_of_response:1; }","duration":"322.527081ms","start":"2026-05-05T13:48:02.586824Z","end":"2026-05-05T13:48:02.909351Z","steps":["trace[1858003060] 'process raft request' (duration: 321.598249ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.910821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586795Z","time spent":"323.994814ms","remote":"127.0.0.1:60080","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":338,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.909531Z","caller":"traceutil/trace.go:171","msg":"trace[945576814] transaction","detail":"{read_only:false; response_revision:19; number_of_response:1; }","duration":"321.027196ms","start":"2026-05-05T13:48:02.588488Z","end":"2026-05-05T13:48:02.909515Z","steps":["trace[945576814] 'process raft request' (duration: 320.020612ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.911252Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.588484Z","time spent":"322.688844ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3479,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T13:48:02.908981Z","caller":"traceutil/trace.go:171","msg":"trace[759620033] transaction","detail":"{read_only:false; response_revision:18; number_of_response:1; }","duration":"321.989717ms","start":"2026-05-05T13:48:02.586965Z","end":"2026-05-05T13:48:02.908955Z","steps":["trace[759620033] 'process raft request' (duration: 321.486866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.911469Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.58695Z","time spent":"324.494197ms","remote":"127.0.0.1:60506","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":941,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-05T13:48:02.909944Z","caller":"traceutil/trace.go:171","msg":"trace[492545055] transaction","detail":"{read_only:false; response_revision:20; number_of_response:1; }","duration":"320.512523ms","start":"2026-05-05T13:48:02.589415Z","end":"2026-05-05T13:48:02.909928Z","steps":["trace[492545055] 'process raft request' (duration: 319.165072ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.912136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.589408Z","time spent":"322.621572ms","remote":"127.0.0.1:60356","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":651,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:02.910096Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.249068ms","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-05-05T13:48:02.912242Z","caller":"traceutil/trace.go:171","msg":"trace[1938151286] range","detail":"{range_begin:/registry/leases/kube-system/apiserver-f3tcohoifagyom4bbi4wgeu7te; range_end:; response_count:0; response_revision:20; }","duration":"127.45011ms","start":"2026-05-05T13:48:02.784768Z","end":"2026-05-05T13:48:02.912218Z","steps":["trace[1938151286] 'agreement among raft nodes before linearized reading' (duration: 125.262369ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.910139Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"267.116835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/kube-system\" ","response":"range_response_count:1 size:350"} {"level":"info","ts":"2026-05-05T13:48:02.912363Z","caller":"traceutil/trace.go:171","msg":"trace[1305145097] range","detail":"{range_begin:/registry/namespaces/kube-system; range_end:; response_count:1; response_revision:20; }","duration":"269.382578ms","start":"2026-05-05T13:48:02.642959Z","end":"2026-05-05T13:48:02.912341Z","steps":["trace[1305145097] 'agreement among raft nodes before linearized reading' (duration: 267.160806ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.910242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.254667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/csr-llddt\" ","response":"range_response_count:1 size:857"} {"level":"info","ts":"2026-05-05T13:48:02.912575Z","caller":"traceutil/trace.go:171","msg":"trace[758667821] range","detail":"{range_begin:/registry/certificatesigningrequests/csr-llddt; range_end:; response_count:1; response_revision:20; }","duration":"325.736436ms","start":"2026-05-05T13:48:02.58683Z","end":"2026-05-05T13:48:02.912566Z","steps":["trace[758667821] 'agreement among raft nodes before linearized reading' (duration: 323.003392ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:02.912638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:02.586815Z","time spent":"325.793847ms","remote":"127.0.0.1:60244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":880,"request content":"key:\"/registry/certificatesigningrequests/csr-llddt\" "} {"level":"info","ts":"2026-05-05T13:48:29.641184Z","caller":"traceutil/trace.go:171","msg":"trace[101408718] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"154.962689ms","start":"2026-05-05T13:48:29.486194Z","end":"2026-05-05T13:48:29.641156Z","steps":["trace[101408718] 'process raft request' (duration: 131.644ms)","trace[101408718] 'compare' (duration: 23.190376ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:48:29.648324Z","caller":"traceutil/trace.go:171","msg":"trace[71600796] transaction","detail":"{read_only:false; number_of_response:1; response_revision:512; }","duration":"141.13484ms","start":"2026-05-05T13:48:29.50717Z","end":"2026-05-05T13:48:29.648305Z","steps":["trace[71600796] 'process raft request' (duration: 141.049098ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:29.648458Z","caller":"traceutil/trace.go:171","msg":"trace[1404438308] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"154.080838ms","start":"2026-05-05T13:48:29.494366Z","end":"2026-05-05T13:48:29.648447Z","steps":["trace[1404438308] 'process raft request' (duration: 153.75581ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:29.648866Z","caller":"traceutil/trace.go:171","msg":"trace[341031419] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"127.085465ms","start":"2026-05-05T13:48:29.521766Z","end":"2026-05-05T13:48:29.648851Z","steps":["trace[341031419] 'process raft request' (duration: 126.795898ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:29.648967Z","caller":"traceutil/trace.go:171","msg":"trace[1784253175] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"127.265129ms","start":"2026-05-05T13:48:29.521693Z","end":"2026-05-05T13:48:29.648958Z","steps":["trace[1784253175] 'process raft request' (duration: 126.562702ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:29.648999Z","caller":"traceutil/trace.go:171","msg":"trace[1326843609] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"107.767669ms","start":"2026-05-05T13:48:29.541213Z","end":"2026-05-05T13:48:29.64898Z","steps":["trace[1326843609] 'process raft request' (duration: 107.395021ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:29.649115Z","caller":"traceutil/trace.go:171","msg":"trace[1188242015] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"103.173003ms","start":"2026-05-05T13:48:29.545933Z","end":"2026-05-05T13:48:29.649106Z","steps":["trace[1188242015] 'process raft request' (duration: 102.732563ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:33.781808Z","caller":"traceutil/trace.go:171","msg":"trace[1881481497] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"184.566943ms","start":"2026-05-05T13:48:33.597212Z","end":"2026-05-05T13:48:33.781779Z","steps":["trace[1881481497] 'process raft request' (duration: 169.610727ms)","trace[1881481497] 'compare' (duration: 14.750791ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:48:33.867785Z","caller":"traceutil/trace.go:171","msg":"trace[2145294048] linearizableReadLoop","detail":"{readStateIndex:620; appliedIndex:618; }","duration":"153.751211ms","start":"2026-05-05T13:48:33.714011Z","end":"2026-05-05T13:48:33.867763Z","steps":["trace[2145294048] 'read index received' (duration: 52.890502ms)","trace[2145294048] 'applied index is now lower than readState.Index' (duration: 100.859679ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:48:33.867911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.884754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.170\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T13:48:33.867887Z","caller":"traceutil/trace.go:171","msg":"trace[733230247] transaction","detail":"{read_only:false; response_revision:600; number_of_response:1; }","duration":"201.496884ms","start":"2026-05-05T13:48:33.666361Z","end":"2026-05-05T13:48:33.867858Z","steps":["trace[733230247] 'process raft request' (duration: 200.929991ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:33.867945Z","caller":"traceutil/trace.go:171","msg":"trace[1957794981] range","detail":"{range_begin:/registry/masterleases/199.19.213.170; range_end:; response_count:1; response_revision:600; }","duration":"153.961476ms","start":"2026-05-05T13:48:33.713973Z","end":"2026-05-05T13:48:33.867934Z","steps":["trace[1957794981] 'agreement among raft nodes before linearized reading' (duration: 153.878454ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:35.82001Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.427617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-8b2dd\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-05-05T13:48:35.820099Z","caller":"traceutil/trace.go:171","msg":"trace[995893403] range","detail":"{range_begin:/registry/pods/kube-system/cilium-8b2dd; range_end:; response_count:1; response_revision:615; }","duration":"248.562931ms","start":"2026-05-05T13:48:35.571517Z","end":"2026-05-05T13:48:35.82008Z","steps":["trace[995893403] 'range keys from in-memory index tree' (duration: 248.235523ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:36.732898Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714458996579070,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T13:48:36.775866Z","caller":"traceutil/trace.go:171","msg":"trace[2063712028] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"942.994757ms","start":"2026-05-05T13:48:35.832842Z","end":"2026-05-05T13:48:36.775836Z","steps":["trace[2063712028] 'process raft request' (duration: 942.749782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:36.776017Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:35.832807Z","time spent":"943.130741ms","remote":"127.0.0.1:60160","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T13:48:37.169739Z","caller":"traceutil/trace.go:171","msg":"trace[1195547594] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"1.313986196s","start":"2026-05-05T13:48:35.855722Z","end":"2026-05-05T13:48:37.169708Z","steps":["trace[1195547594] 'process raft request' (duration: 1.3132901s)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:37.169855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"937.753127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:37.169936Z","caller":"traceutil/trace.go:171","msg":"trace[1284288313] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:619; }","duration":"937.84879ms","start":"2026-05-05T13:48:36.232039Z","end":"2026-05-05T13:48:37.169888Z","steps":["trace[1284288313] 'agreement among raft nodes before linearized reading' (duration: 937.769808ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:37.169984Z","caller":"traceutil/trace.go:171","msg":"trace[1014865026] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"877.873075ms","start":"2026-05-05T13:48:36.2921Z","end":"2026-05-05T13:48:37.169973Z","steps":["trace[1014865026] 'process raft request' (duration: 877.587498ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:37.170023Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:36.232019Z","time spent":"937.951202ms","remote":"127.0.0.1:59976","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-05-05T13:48:37.16999Z","caller":"traceutil/trace.go:171","msg":"trace[1085556965] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"886.33283ms","start":"2026-05-05T13:48:36.283605Z","end":"2026-05-05T13:48:37.169938Z","steps":["trace[1085556965] 'process raft request' (duration: 886.015092ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:37.170468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:36.283563Z","time spent":"886.78995ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:48:37.169931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:35.855667Z","time spent":"1.314156489s","remote":"127.0.0.1:60060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T13:48:37.169767Z","caller":"traceutil/trace.go:171","msg":"trace[1503185664] linearizableReadLoop","detail":"{readStateIndex:640; appliedIndex:636; }","duration":"937.649425ms","start":"2026-05-05T13:48:36.232095Z","end":"2026-05-05T13:48:37.169744Z","steps":["trace[1503185664] 'read index received' (duration: 543.576754ms)","trace[1503185664] 'applied index is now lower than readState.Index' (duration: 394.071611ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:48:37.170033Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:36.292071Z","time spent":"877.935546ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4539,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:48:37.170893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"735.332913ms","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-05-05T13:48:37.170933Z","caller":"traceutil/trace.go:171","msg":"trace[1213247897] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:619; }","duration":"735.433985ms","start":"2026-05-05T13:48:36.435487Z","end":"2026-05-05T13:48:37.170921Z","steps":["trace[1213247897] 'agreement among raft nodes before linearized reading' (duration: 735.304112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:37.170963Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:36.435456Z","time spent":"735.501046ms","remote":"127.0.0.1:60250","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-05-05T13:48:37.172112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.761624ms","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-05-05T13:48:37.172178Z","caller":"traceutil/trace.go:171","msg":"trace[2110086323] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:619; }","duration":"390.872947ms","start":"2026-05-05T13:48:36.781287Z","end":"2026-05-05T13:48:37.17216Z","steps":["trace[2110086323] 'agreement among raft nodes before linearized reading' (duration: 390.677593ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:37.171173Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.062252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-05T13:48:37.17222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:36.781264Z","time spent":"390.946569ms","remote":"127.0.0.1:60250","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-05-05T13:48:37.172217Z","caller":"traceutil/trace.go:171","msg":"trace[158466743] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:619; }","duration":"111.142047ms","start":"2026-05-05T13:48:37.061065Z","end":"2026-05-05T13:48:37.172207Z","steps":["trace[158466743] 'agreement among raft nodes before linearized reading' (duration: 110.046232ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:37.723762Z","caller":"traceutil/trace.go:171","msg":"trace[1285994778] transaction","detail":"{read_only:false; response_revision:623; number_of_response:1; }","duration":"490.417427ms","start":"2026-05-05T13:48:37.233295Z","end":"2026-05-05T13:48:37.723712Z","steps":["trace[1285994778] 'process raft request' (duration: 490.157901ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:37.723923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:37.23327Z","time spent":"490.58438ms","remote":"127.0.0.1:60494","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-05T13:48:37.724027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.621821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-05T13:48:37.724103Z","caller":"traceutil/trace.go:171","msg":"trace[633094932] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:623; }","duration":"225.758404ms","start":"2026-05-05T13:48:37.498328Z","end":"2026-05-05T13:48:37.724086Z","steps":["trace[633094932] 'agreement among raft nodes before linearized reading' (duration: 225.505348ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:37.723702Z","caller":"traceutil/trace.go:171","msg":"trace[1043913224] linearizableReadLoop","detail":"{readStateIndex:644; appliedIndex:643; }","duration":"225.18873ms","start":"2026-05-05T13:48:37.498476Z","end":"2026-05-05T13:48:37.723665Z","steps":["trace[1043913224] 'read index received' (duration: 224.836772ms)","trace[1043913224] 'applied index is now lower than readState.Index' (duration: 350.458µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:48:39.974188Z","caller":"traceutil/trace.go:171","msg":"trace[1126065910] linearizableReadLoop","detail":"{readStateIndex:684; appliedIndex:683; }","duration":"188.278508ms","start":"2026-05-05T13:48:39.785883Z","end":"2026-05-05T13:48:39.974162Z","steps":["trace[1126065910] 'read index received' (duration: 186.20199ms)","trace[1126065910] 'applied index is now lower than readState.Index' (duration: 2.075548ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:48:39.974314Z","caller":"traceutil/trace.go:171","msg":"trace[367417194] transaction","detail":"{read_only:false; response_revision:662; number_of_response:1; }","duration":"220.102273ms","start":"2026-05-05T13:48:39.754201Z","end":"2026-05-05T13:48:39.974303Z","steps":["trace[367417194] 'process raft request' (duration: 217.903853ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:39.974497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.598925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:39.974544Z","caller":"traceutil/trace.go:171","msg":"trace[1371658523] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:662; }","duration":"188.745509ms","start":"2026-05-05T13:48:39.785785Z","end":"2026-05-05T13:48:39.974531Z","steps":["trace[1371658523] 'agreement among raft nodes before linearized reading' (duration: 188.660437ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:39.979841Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.822336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T13:48:39.979865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.677318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:39.979899Z","caller":"traceutil/trace.go:171","msg":"trace[859116277] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:663; }","duration":"194.027791ms","start":"2026-05-05T13:48:39.78586Z","end":"2026-05-05T13:48:39.979888Z","steps":["trace[859116277] 'agreement among raft nodes before linearized reading' (duration: 193.876077ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:39.97992Z","caller":"traceutil/trace.go:171","msg":"trace[830949398] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:663; }","duration":"104.78058ms","start":"2026-05-05T13:48:39.875123Z","end":"2026-05-05T13:48:39.979904Z","steps":["trace[830949398] 'agreement among raft nodes before linearized reading' (duration: 104.680688ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:39.980074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.73359ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:39.980127Z","caller":"traceutil/trace.go:171","msg":"trace[538970727] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:663; }","duration":"143.7785ms","start":"2026-05-05T13:48:39.836319Z","end":"2026-05-05T13:48:39.980097Z","steps":["trace[538970727] 'agreement among raft nodes before linearized reading' (duration: 143.726489ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:39.980284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.729053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:39.980312Z","caller":"traceutil/trace.go:171","msg":"trace[1225568875] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:663; }","duration":"144.768723ms","start":"2026-05-05T13:48:39.835537Z","end":"2026-05-05T13:48:39.980306Z","steps":["trace[1225568875] 'agreement among raft nodes before linearized reading' (duration: 144.725842ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:39.98079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.971074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:39.980864Z","caller":"traceutil/trace.go:171","msg":"trace[694786931] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:663; }","duration":"105.088937ms","start":"2026-05-05T13:48:39.875758Z","end":"2026-05-05T13:48:39.980847Z","steps":["trace[694786931] 'agreement among raft nodes before linearized reading' (duration: 104.986754ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:39.98152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.100181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:39.981569Z","caller":"traceutil/trace.go:171","msg":"trace[1713958657] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:663; }","duration":"146.183176ms","start":"2026-05-05T13:48:39.835377Z","end":"2026-05-05T13:48:39.98156Z","steps":["trace[1713958657] 'agreement among raft nodes before linearized reading' (duration: 145.009569ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:39.980707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.172215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:48:39.982336Z","caller":"traceutil/trace.go:171","msg":"trace[1965451457] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:663; }","duration":"195.846783ms","start":"2026-05-05T13:48:39.786472Z","end":"2026-05-05T13:48:39.982319Z","steps":["trace[1965451457] 'agreement among raft nodes before linearized reading' (duration: 194.156764ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:48:39.980495Z","caller":"traceutil/trace.go:171","msg":"trace[2147459016] transaction","detail":"{read_only:false; response_revision:663; number_of_response:1; }","duration":"103.562462ms","start":"2026-05-05T13:48:39.876901Z","end":"2026-05-05T13:48:39.980463Z","steps":["trace[2147459016] 'process raft request' (duration: 102.754213ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:53.805749Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714458996579440,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T13:48:53.951729Z","caller":"traceutil/trace.go:171","msg":"trace[435730586] transaction","detail":"{read_only:false; response_revision:783; number_of_response:1; }","duration":"675.626584ms","start":"2026-05-05T13:48:53.275719Z","end":"2026-05-05T13:48:53.951346Z","steps":["trace[435730586] 'process raft request' (duration: 675.288326ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:53.95189Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:53.275692Z","time spent":"676.121236ms","remote":"127.0.0.1:60250","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-05-05T13:48:54.067563Z","caller":"traceutil/trace.go:171","msg":"trace[1720994909] transaction","detail":"{read_only:false; response_revision:784; number_of_response:1; }","duration":"787.849254ms","start":"2026-05-05T13:48:53.279682Z","end":"2026-05-05T13:48:54.067532Z","steps":["trace[1720994909] 'process raft request' (duration: 787.589518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:54.067882Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:53.279653Z","time spent":"788.135031ms","remote":"127.0.0.1:60250","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-05-05T13:48:54.067906Z","caller":"traceutil/trace.go:171","msg":"trace[1760031926] linearizableReadLoop","detail":"{readStateIndex:810; appliedIndex:807; }","duration":"762.808846ms","start":"2026-05-05T13:48:53.305043Z","end":"2026-05-05T13:48:54.067852Z","steps":["trace[1760031926] 'read index received' (duration: 646.057941ms)","trace[1760031926] 'applied index is now lower than readState.Index' (duration: 116.747705ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:48:54.068291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.223796ms","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-05-05T13:48:54.068325Z","caller":"traceutil/trace.go:171","msg":"trace[1446872469] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:785; }","duration":"763.350049ms","start":"2026-05-05T13:48:53.304966Z","end":"2026-05-05T13:48:54.068316Z","steps":["trace[1446872469] 'agreement among raft nodes before linearized reading' (duration: 763.088513ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:54.068352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:53.304952Z","time spent":"763.39458ms","remote":"127.0.0.1:60250","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-05-05T13:48:54.068447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"500.226202ms","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-05-05T13:48:54.068546Z","caller":"traceutil/trace.go:171","msg":"trace[253146896] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:785; }","duration":"500.363795ms","start":"2026-05-05T13:48:53.568164Z","end":"2026-05-05T13:48:54.068528Z","steps":["trace[253146896] 'agreement among raft nodes before linearized reading' (duration: 500.042708ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:54.068606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:53.568135Z","time spent":"500.460088ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T13:48:54.068507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"352.967061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.170\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T13:48:54.068743Z","caller":"traceutil/trace.go:171","msg":"trace[63793039] range","detail":"{range_begin:/registry/masterleases/199.19.213.170; range_end:; response_count:1; response_revision:785; }","duration":"353.244047ms","start":"2026-05-05T13:48:53.715462Z","end":"2026-05-05T13:48:54.068706Z","steps":["trace[63793039] 'agreement among raft nodes before linearized reading' (duration: 352.816647ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:54.068808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:53.715435Z","time spent":"353.35758ms","remote":"127.0.0.1:59994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.170\" "} {"level":"info","ts":"2026-05-05T13:48:54.068146Z","caller":"traceutil/trace.go:171","msg":"trace[1663876920] transaction","detail":"{read_only:false; response_revision:785; number_of_response:1; }","duration":"349.780687ms","start":"2026-05-05T13:48:53.718322Z","end":"2026-05-05T13:48:54.068103Z","steps":["trace[1663876920] 'process raft request' (duration: 349.113142ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:48:54.069571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:48:53.718305Z","time spent":"350.616746ms","remote":"127.0.0.1:60228","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2785,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:49:29.604462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"456.876392ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-05T13:49:29.604793Z","caller":"traceutil/trace.go:171","msg":"trace[1604052831] linearizableReadLoop","detail":"{readStateIndex:1037; appliedIndex:1035; }","duration":"372.022428ms","start":"2026-05-05T13:49:29.232756Z","end":"2026-05-05T13:49:29.604779Z","steps":["trace[1604052831] 'read index received' (duration: 42.201µs)","trace[1604052831] 'applied index is now lower than readState.Index' (duration: 371.979297ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:49:29.604897Z","caller":"traceutil/trace.go:171","msg":"trace[1139873295] transaction","detail":"{read_only:false; response_revision:1002; number_of_response:1; }","duration":"691.575372ms","start":"2026-05-05T13:49:28.913284Z","end":"2026-05-05T13:49:29.604859Z","steps":["trace[1139873295] 'process raft request' (duration: 691.263815ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:29.605056Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:28.913218Z","time spent":"691.750597ms","remote":"127.0.0.1:60250","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-05-05T13:49:30.037102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"804.31744ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:49:30.037209Z","caller":"traceutil/trace.go:171","msg":"trace[199102062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1002; }","duration":"804.486844ms","start":"2026-05-05T13:49:29.2327Z","end":"2026-05-05T13:49:30.037187Z","steps":["trace[199102062] 'agreement among raft nodes before linearized reading' (duration: 372.155921ms)","trace[199102062] 'range keys from in-memory index tree' (duration: 432.175859ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:49:30.03719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"790.730446ms","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":"warn","ts":"2026-05-05T13:49:30.037274Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:29.232678Z","time spent":"804.585457ms","remote":"127.0.0.1:59976","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-05-05T13:49:30.03731Z","caller":"traceutil/trace.go:171","msg":"trace[57881577] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1002; }","duration":"790.92049ms","start":"2026-05-05T13:49:29.246366Z","end":"2026-05-05T13:49:30.037287Z","steps":["trace[57881577] 'agreement among raft nodes before linearized reading' (duration: 358.505975ms)","trace[57881577] 'count revisions from in-memory index tree' (duration: 432.20772ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:49:30.037269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.4193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T13:49:30.037374Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:29.246343Z","time spent":"791.017933ms","remote":"127.0.0.1:60284","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":"info","ts":"2026-05-05T13:49:30.037384Z","caller":"traceutil/trace.go:171","msg":"trace[1024295949] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1002; }","duration":"354.563653ms","start":"2026-05-05T13:49:29.682806Z","end":"2026-05-05T13:49:30.037369Z","steps":["trace[1024295949] 'count revisions from in-memory index tree' (duration: 354.278337ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:30.037419Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:29.682787Z","time spent":"354.624635ms","remote":"127.0.0.1:60044","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-05-05T13:49:30.435129Z","caller":"traceutil/trace.go:171","msg":"trace[80004893] linearizableReadLoop","detail":"{readStateIndex:1038; appliedIndex:1037; }","duration":"166.81954ms","start":"2026-05-05T13:49:30.268289Z","end":"2026-05-05T13:49:30.435109Z","steps":["trace[80004893] 'read index received' (duration: 166.617466ms)","trace[80004893] 'applied index is now lower than readState.Index' (duration: 201.074µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:49:30.435216Z","caller":"traceutil/trace.go:171","msg":"trace[2146270013] transaction","detail":"{read_only:false; response_revision:1003; number_of_response:1; }","duration":"301.339724ms","start":"2026-05-05T13:49:30.133862Z","end":"2026-05-05T13:49:30.435202Z","steps":["trace[2146270013] 'process raft request' (duration: 301.111398ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:30.435317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:30.133843Z","time spent":"301.406175ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:49:30.435313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.022445ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"warn","ts":"2026-05-05T13:49:30.435326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.212434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T13:49:30.435354Z","caller":"traceutil/trace.go:171","msg":"trace[2152855] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1003; }","duration":"167.106977ms","start":"2026-05-05T13:49:30.268236Z","end":"2026-05-05T13:49:30.435343Z","steps":["trace[2152855] 'agreement among raft nodes before linearized reading' (duration: 166.976814ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:49:30.435372Z","caller":"traceutil/trace.go:171","msg":"trace[1607391412] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1003; }","duration":"162.280915ms","start":"2026-05-05T13:49:30.273079Z","end":"2026-05-05T13:49:30.43536Z","steps":["trace[1607391412] 'agreement among raft nodes before linearized reading' (duration: 162.158252ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:30.435481Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.015496ms","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-05-05T13:49:30.435508Z","caller":"traceutil/trace.go:171","msg":"trace[1507811489] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1003; }","duration":"161.075337ms","start":"2026-05-05T13:49:30.274425Z","end":"2026-05-05T13:49:30.4355Z","steps":["trace[1507811489] 'agreement among raft nodes before linearized reading' (duration: 160.995836ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:30.435506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.164177ms","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-05-05T13:49:30.435561Z","caller":"traceutil/trace.go:171","msg":"trace[771127031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1003; }","duration":"154.25153ms","start":"2026-05-05T13:49:30.281295Z","end":"2026-05-05T13:49:30.435547Z","steps":["trace[771127031] 'agreement among raft nodes before linearized reading' (duration: 154.104186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:54.220414Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":11858714458996580094,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-05T13:49:54.334167Z","caller":"traceutil/trace.go:171","msg":"trace[2109754995] linearizableReadLoop","detail":"{readStateIndex:1119; appliedIndex:1118; }","duration":"614.855237ms","start":"2026-05-05T13:49:53.71928Z","end":"2026-05-05T13:49:54.334136Z","steps":["trace[2109754995] 'read index received' (duration: 613.961586ms)","trace[2109754995] 'applied index is now lower than readState.Index' (duration: 892.261µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:49:54.334327Z","caller":"traceutil/trace.go:171","msg":"trace[2051493429] transaction","detail":"{read_only:false; response_revision:1080; number_of_response:1; }","duration":"639.022866ms","start":"2026-05-05T13:49:53.695257Z","end":"2026-05-05T13:49:54.33428Z","steps":["trace[2051493429] 'process raft request' (duration: 638.634997ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:54.334394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.361297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:49:54.334435Z","caller":"traceutil/trace.go:171","msg":"trace[109395734] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:1080; }","duration":"560.530801ms","start":"2026-05-05T13:49:53.773892Z","end":"2026-05-05T13:49:54.334423Z","steps":["trace[109395734] 'agreement among raft nodes before linearized reading' (duration: 560.427268ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:54.334496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:53.773866Z","time spent":"560.619673ms","remote":"127.0.0.1:44066","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true "} {"level":"warn","ts":"2026-05-05T13:49:54.33447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"615.173045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.170\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-05-05T13:49:54.334594Z","caller":"traceutil/trace.go:171","msg":"trace[4683160] range","detail":"{range_begin:/registry/masterleases/199.19.213.170; range_end:; response_count:1; response_revision:1080; }","duration":"615.357969ms","start":"2026-05-05T13:49:53.719202Z","end":"2026-05-05T13:49:54.33456Z","steps":["trace[4683160] 'agreement among raft nodes before linearized reading' (duration: 615.101063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:54.334667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.063045ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-05T13:49:54.334697Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:53.719177Z","time spent":"615.506573ms","remote":"127.0.0.1:59994","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.19.213.170\" "} {"level":"info","ts":"2026-05-05T13:49:54.334716Z","caller":"traceutil/trace.go:171","msg":"trace[592886554] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1080; }","duration":"103.188988ms","start":"2026-05-05T13:49:54.231511Z","end":"2026-05-05T13:49:54.3347Z","steps":["trace[592886554] 'agreement among raft nodes before linearized reading' (duration: 103.044915ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:54.334508Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:49:53.695227Z","time spent":"639.17544ms","remote":"127.0.0.1:60250","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-05-05T13:49:54.334884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.458507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:49:54.334922Z","caller":"traceutil/trace.go:171","msg":"trace[1983940587] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:1080; }","duration":"123.540409ms","start":"2026-05-05T13:49:54.211372Z","end":"2026-05-05T13:49:54.334912Z","steps":["trace[1983940587] 'agreement among raft nodes before linearized reading' (duration: 123.481347ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:54.335091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.791915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllerrevisions/\" range_end:\"/registry/controllerrevisions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T13:49:54.335117Z","caller":"traceutil/trace.go:171","msg":"trace[346198781] range","detail":"{range_begin:/registry/controllerrevisions/; range_end:/registry/controllerrevisions0; response_count:0; response_revision:1080; }","duration":"222.913018ms","start":"2026-05-05T13:49:54.112197Z","end":"2026-05-05T13:49:54.33511Z","steps":["trace[346198781] 'agreement among raft nodes before linearized reading' (duration: 222.865907ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:49:55.386714Z","caller":"traceutil/trace.go:171","msg":"trace[1894252594] transaction","detail":"{read_only:false; response_revision:1087; number_of_response:1; }","duration":"145.436235ms","start":"2026-05-05T13:49:55.241245Z","end":"2026-05-05T13:49:55.386681Z","steps":["trace[1894252594] 'process raft request' (duration: 145.238761ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:49:56.498551Z","caller":"traceutil/trace.go:171","msg":"trace[788938047] linearizableReadLoop","detail":"{readStateIndex:1128; appliedIndex:1127; }","duration":"141.049433ms","start":"2026-05-05T13:49:56.357476Z","end":"2026-05-05T13:49:56.498526Z","steps":["trace[788938047] 'read index received' (duration: 140.807418ms)","trace[788938047] 'applied index is now lower than readState.Index' (duration: 241.295µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:49:56.49869Z","caller":"traceutil/trace.go:171","msg":"trace[1616057579] transaction","detail":"{read_only:false; response_revision:1088; number_of_response:1; }","duration":"157.7172ms","start":"2026-05-05T13:49:56.340944Z","end":"2026-05-05T13:49:56.498661Z","steps":["trace[1616057579] 'process raft request' (duration: 157.408592ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:49:56.498808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.31277ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/grpcroutes/\" range_end:\"/registry/gateway.networking.k8s.io/grpcroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:49:56.498852Z","caller":"traceutil/trace.go:171","msg":"trace[1040032227] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/grpcroutes/; range_end:/registry/gateway.networking.k8s.io/grpcroutes0; response_count:0; response_revision:1088; }","duration":"141.429463ms","start":"2026-05-05T13:49:56.357412Z","end":"2026-05-05T13:49:56.498841Z","steps":["trace[1040032227] 'agreement among raft nodes before linearized reading' (duration: 141.333051ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:08.84485Z","caller":"traceutil/trace.go:171","msg":"trace[1303661520] linearizableReadLoop","detail":"{readStateIndex:1222; appliedIndex:1221; }","duration":"161.764323ms","start":"2026-05-05T13:50:08.683062Z","end":"2026-05-05T13:50:08.844826Z","steps":["trace[1303661520] 'read index received' (duration: 161.519228ms)","trace[1303661520] 'applied index is now lower than readState.Index' (duration: 243.915µs)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:50:08.844962Z","caller":"traceutil/trace.go:171","msg":"trace[423553553] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"283.812817ms","start":"2026-05-05T13:50:08.561101Z","end":"2026-05-05T13:50:08.844914Z","steps":["trace[423553553] 'process raft request' (duration: 283.557712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:08.845128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.033769ms","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-05-05T13:50:08.845167Z","caller":"traceutil/trace.go:171","msg":"trace[484019398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1178; }","duration":"162.136042ms","start":"2026-05-05T13:50:08.683019Z","end":"2026-05-05T13:50:08.845155Z","steps":["trace[484019398] 'agreement among raft nodes before linearized reading' (duration: 161.966358ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:08.845193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.37245ms","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-05-05T13:50:08.845251Z","caller":"traceutil/trace.go:171","msg":"trace[1118592717] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1178; }","duration":"131.487783ms","start":"2026-05-05T13:50:08.713748Z","end":"2026-05-05T13:50:08.845236Z","steps":["trace[1118592717] 'agreement among raft nodes before linearized reading' (duration: 131.273128ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:09.130798Z","caller":"traceutil/trace.go:171","msg":"trace[1683937356] transaction","detail":"{read_only:false; response_revision:1179; number_of_response:1; }","duration":"281.219737ms","start":"2026-05-05T13:50:08.849556Z","end":"2026-05-05T13:50:09.130776Z","steps":["trace[1683937356] 'process raft request' (duration: 274.839469ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:09.133636Z","caller":"traceutil/trace.go:171","msg":"trace[1260203294] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"283.905239ms","start":"2026-05-05T13:50:08.84971Z","end":"2026-05-05T13:50:09.133615Z","steps":["trace[1260203294] 'process raft request' (duration: 283.755096ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:09.134016Z","caller":"traceutil/trace.go:171","msg":"trace[2061160056] transaction","detail":"{read_only:false; response_revision:1183; number_of_response:1; }","duration":"282.700641ms","start":"2026-05-05T13:50:08.85129Z","end":"2026-05-05T13:50:09.133991Z","steps":["trace[2061160056] 'process raft request' (duration: 282.63861ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:09.134062Z","caller":"traceutil/trace.go:171","msg":"trace[208503320] transaction","detail":"{read_only:false; response_revision:1181; number_of_response:1; }","duration":"284.252327ms","start":"2026-05-05T13:50:08.8498Z","end":"2026-05-05T13:50:09.134052Z","steps":["trace[208503320] 'process raft request' (duration: 283.782456ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:09.134191Z","caller":"traceutil/trace.go:171","msg":"trace[1981313663] transaction","detail":"{read_only:false; response_revision:1182; number_of_response:1; }","duration":"284.301658ms","start":"2026-05-05T13:50:08.849865Z","end":"2026-05-05T13:50:09.134167Z","steps":["trace[1981313663] 'process raft request' (duration: 283.95214ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:25.542841Z","caller":"traceutil/trace.go:171","msg":"trace[1397248842] transaction","detail":"{read_only:false; response_revision:1259; number_of_response:1; }","duration":"327.748836ms","start":"2026-05-05T13:50:25.215066Z","end":"2026-05-05T13:50:25.542814Z","steps":["trace[1397248842] 'process raft request' (duration: 327.592023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:25.542999Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:25.215054Z","time spent":"327.867749ms","remote":"127.0.0.1:60250","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-05-05T13:50:25.834006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.849223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-05T13:50:25.834133Z","caller":"traceutil/trace.go:171","msg":"trace[1958584251] linearizableReadLoop","detail":"{readStateIndex:1308; appliedIndex:1306; }","duration":"616.784204ms","start":"2026-05-05T13:50:25.21733Z","end":"2026-05-05T13:50:25.834114Z","steps":["trace[1958584251] 'read index received' (duration: 325.294009ms)","trace[1958584251] 'applied index is now lower than readState.Index' (duration: 291.488785ms)"],"step_count":2} {"level":"info","ts":"2026-05-05T13:50:25.834253Z","caller":"traceutil/trace.go:171","msg":"trace[2138623343] transaction","detail":"{read_only:false; response_revision:1260; number_of_response:1; }","duration":"618.505004ms","start":"2026-05-05T13:50:25.215714Z","end":"2026-05-05T13:50:25.834219Z","steps":["trace[2138623343] 'process raft request' (duration: 382.110398ms)","trace[2138623343] 'compare' (duration: 235.69777ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:50:25.834434Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.099801ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T13:50:25.834468Z","caller":"traceutil/trace.go:171","msg":"trace[1914406396] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1260; }","duration":"617.162353ms","start":"2026-05-05T13:50:25.217296Z","end":"2026-05-05T13:50:25.834459Z","steps":["trace[1914406396] 'agreement among raft nodes before linearized reading' (duration: 616.945958ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:25.834506Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:25.217282Z","time spent":"617.214864ms","remote":"127.0.0.1:60250","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-05-05T13:50:25.834552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"604.53562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:50:25.834577Z","caller":"traceutil/trace.go:171","msg":"trace[890388494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1260; }","duration":"604.56461ms","start":"2026-05-05T13:50:25.230004Z","end":"2026-05-05T13:50:25.834569Z","steps":["trace[890388494] 'agreement among raft nodes before linearized reading' (duration: 604.514989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:25.834593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:25.229942Z","time spent":"604.647373ms","remote":"127.0.0.1:59976","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-05-05T13:50:25.834593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.482424ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-05T13:50:25.83465Z","caller":"traceutil/trace.go:171","msg":"trace[1668844783] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1260; }","duration":"244.593047ms","start":"2026-05-05T13:50:25.590042Z","end":"2026-05-05T13:50:25.834635Z","steps":["trace[1668844783] 'agreement among raft nodes before linearized reading' (duration: 244.460634ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:25.834704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"611.810819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"warn","ts":"2026-05-05T13:50:25.834711Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:25.21569Z","time spent":"618.630237ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T13:50:25.834779Z","caller":"traceutil/trace.go:171","msg":"trace[257843151] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1260; }","duration":"611.924182ms","start":"2026-05-05T13:50:25.222837Z","end":"2026-05-05T13:50:25.834761Z","steps":["trace[257843151] 'agreement among raft nodes before linearized reading' (duration: 611.734377ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:25.834837Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:25.222824Z","time spent":"611.998843ms","remote":"127.0.0.1:60250","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-05-05T13:50:25.835205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"617.535332ms","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-05-05T13:50:25.835281Z","caller":"traceutil/trace.go:171","msg":"trace[1541331956] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1260; }","duration":"617.640964ms","start":"2026-05-05T13:50:25.217604Z","end":"2026-05-05T13:50:25.835245Z","steps":["trace[1541331956] 'agreement among raft nodes before linearized reading' (duration: 616.829735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:25.835328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:25.217458Z","time spent":"617.863179ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-05T13:50:27.025026Z","caller":"traceutil/trace.go:171","msg":"trace[1391024991] transaction","detail":"{read_only:false; response_revision:1265; number_of_response:1; }","duration":"123.430055ms","start":"2026-05-05T13:50:26.901572Z","end":"2026-05-05T13:50:27.025002Z","steps":["trace[1391024991] 'process raft request' (duration: 123.242871ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:39.552705Z","caller":"traceutil/trace.go:171","msg":"trace[250591916] transaction","detail":"{read_only:false; response_revision:1346; number_of_response:1; }","duration":"488.5853ms","start":"2026-05-05T13:50:39.064092Z","end":"2026-05-05T13:50:39.552677Z","steps":["trace[250591916] 'process raft request' (duration: 488.422036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:39.553133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:39.064069Z","time spent":"488.714452ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-05T13:50:40.186478Z","caller":"traceutil/trace.go:171","msg":"trace[1402933785] transaction","detail":"{read_only:false; response_revision:1347; number_of_response:1; }","duration":"765.998406ms","start":"2026-05-05T13:50:39.420437Z","end":"2026-05-05T13:50:40.186435Z","steps":["trace[1402933785] 'process raft request' (duration: 765.72576ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:50:40.186524Z","caller":"traceutil/trace.go:171","msg":"trace[222282897] linearizableReadLoop","detail":"{readStateIndex:1397; appliedIndex:1395; }","duration":"954.226085ms","start":"2026-05-05T13:50:39.23225Z","end":"2026-05-05T13:50:40.186476Z","steps":["trace[222282897] 'read index received' (duration: 320.272973ms)","trace[222282897] 'applied index is now lower than readState.Index' (duration: 633.951092ms)"],"step_count":2} {"level":"warn","ts":"2026-05-05T13:50:40.186621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:39.420399Z","time spent":"766.15031ms","remote":"127.0.0.1:60146","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6758,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-05T13:50:40.188975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"956.724423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-05T13:50:40.189019Z","caller":"traceutil/trace.go:171","msg":"trace[1194788214] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1347; }","duration":"956.769664ms","start":"2026-05-05T13:50:39.232238Z","end":"2026-05-05T13:50:40.189007Z","steps":["trace[1194788214] 'agreement among raft nodes before linearized reading' (duration: 954.44716ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.189144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:39.232182Z","time spent":"956.954168ms","remote":"127.0.0.1:59976","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-05-05T13:50:40.189411Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.82687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-05T13:50:40.189443Z","caller":"traceutil/trace.go:171","msg":"trace[1386924923] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1348; }","duration":"125.906742ms","start":"2026-05-05T13:50:40.063529Z","end":"2026-05-05T13:50:40.189436Z","steps":["trace[1386924923] 'agreement among raft nodes before linearized reading' (duration: 125.739168ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.189575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"798.150863ms","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-05-05T13:50:40.189677Z","caller":"traceutil/trace.go:171","msg":"trace[1515868523] range","detail":"{range_begin:/registry/leases/kube-system/rbd.csi.ceph.com-kube-system; range_end:; response_count:1; response_revision:1348; }","duration":"798.316777ms","start":"2026-05-05T13:50:39.391338Z","end":"2026-05-05T13:50:40.189655Z","steps":["trace[1515868523] 'agreement among raft nodes before linearized reading' (duration: 797.889247ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.189752Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:39.391299Z","time spent":"798.4421ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":59,"response count":1,"response size":555,"request content":"key:\"/registry/leases/kube-system/rbd.csi.ceph.com-kube-system\" "} {"level":"info","ts":"2026-05-05T13:50:40.18985Z","caller":"traceutil/trace.go:171","msg":"trace[340585894] transaction","detail":"{read_only:false; response_revision:1348; number_of_response:1; }","duration":"276.268852ms","start":"2026-05-05T13:50:39.913568Z","end":"2026-05-05T13:50:40.189837Z","steps":["trace[340585894] 'process raft request' (duration: 272.895664ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.190065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.492043ms","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-05-05T13:50:40.190093Z","caller":"traceutil/trace.go:171","msg":"trace[6649313] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1348; }","duration":"119.560825ms","start":"2026-05-05T13:50:40.070524Z","end":"2026-05-05T13:50:40.190085Z","steps":["trace[6649313] 'agreement among raft nodes before linearized reading' (duration: 119.461402ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.190194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.497769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-05T13:50:40.190714Z","caller":"traceutil/trace.go:171","msg":"trace[532893289] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1348; }","duration":"234.144564ms","start":"2026-05-05T13:50:39.956549Z","end":"2026-05-05T13:50:40.190694Z","steps":["trace[532893289] 'agreement among raft nodes before linearized reading' (duration: 233.003627ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.190305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.77097ms","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-05-05T13:50:40.190823Z","caller":"traceutil/trace.go:171","msg":"trace[2016358554] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1348; }","duration":"120.321343ms","start":"2026-05-05T13:50:40.070493Z","end":"2026-05-05T13:50:40.190814Z","steps":["trace[2016358554] 'agreement among raft nodes before linearized reading' (duration: 119.75784ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.190276Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.807928ms","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-05-05T13:50:40.191369Z","caller":"traceutil/trace.go:171","msg":"trace[54156874] range","detail":"{range_begin:/registry/leases/kube-system/rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1348; }","duration":"406.7693ms","start":"2026-05-05T13:50:39.784392Z","end":"2026-05-05T13:50:40.191162Z","steps":["trace[54156874] 'agreement among raft nodes before linearized reading' (duration: 405.774427ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.191449Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:39.784359Z","time spent":"407.070447ms","remote":"127.0.0.1:60250","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":"warn","ts":"2026-05-05T13:50:40.19047Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"566.109538ms","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-05-05T13:50:40.191633Z","caller":"traceutil/trace.go:171","msg":"trace[1160791634] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1348; }","duration":"567.331236ms","start":"2026-05-05T13:50:39.624286Z","end":"2026-05-05T13:50:40.191617Z","steps":["trace[1160791634] 'agreement among raft nodes before linearized reading' (duration: 566.095158ms)"],"step_count":1} {"level":"warn","ts":"2026-05-05T13:50:40.191682Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-05T13:50:39.624259Z","time spent":"567.412169ms","remote":"127.0.0.1:60250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-05T13:50:40.190556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.070367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-05-05T13:50:40.191798Z","caller":"traceutil/trace.go:171","msg":"trace[437182133] range","detail":"{range_begin:/registry/leases/kube-system/external-snapshotter-leader-rbd-csi-ceph-com; range_end:; response_count:1; response_revision:1348; }","duration":"149.363106ms","start":"2026-05-05T13:50:40.04242Z","end":"2026-05-05T13:50:40.191783Z","steps":["trace[437182133] 'agreement among raft nodes before linearized reading' (duration: 148.064726ms)"],"step_count":1} {"level":"info","ts":"2026-05-05T13:53:56.854379Z","caller":"traceutil/trace.go:171","msg":"trace[1223252711] transaction","detail":"{read_only:false; response_revision:2276; number_of_response:1; }","duration":"166.388979ms","start":"2026-05-05T13:53:56.687961Z","end":"2026-05-05T13:53:56.85435Z","steps":["trace[1223252711] 'process raft request' (duration: 166.209315ms)"],"step_count":1}