{"level":"warn","ts":"2026-05-06T08:55:08.486783Z","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-06T08:55:08.486877Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.53:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.53:2380","--initial-cluster=instance=https://199.204.45.53:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.53:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.53: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-06T08:55:08.486964Z","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-06T08:55:08.486981Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-06T08:55:08.487003Z","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-06T08:55:08.487832Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"]} {"level":"info","ts":"2026-05-06T08:55:08.487915Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.53: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-06T08:55:08.493049Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.882994ms"} {"level":"info","ts":"2026-05-06T08:55:08.499896Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"c47ca1a7b1fe506b","cluster-id":"95bd21e158fabf07"} {"level":"info","ts":"2026-05-06T08:55:08.49996Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=()"} {"level":"info","ts":"2026-05-06T08:55:08.499983Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 0"} {"level":"info","ts":"2026-05-06T08:55:08.499992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft c47ca1a7b1fe506b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-06T08:55:08.500008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became follower at term 1"} {"level":"info","ts":"2026-05-06T08:55:08.500043Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"warn","ts":"2026-05-06T08:55:08.509218Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-06T08:55:08.512727Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-06T08:55:08.514014Z","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-06T08:55:08.517725Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"c47ca1a7b1fe506b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-06T08:55:08.518221Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"c47ca1a7b1fe506b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-06T08:55:08.518476Z","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-06T08:55:08.518545Z","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-06T08:55:08.518563Z","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-06T08:55:08.519118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b switched to configuration voters=(14158369070163841131)"} {"level":"info","ts":"2026-05-06T08:55:08.519246Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","added-peer-id":"c47ca1a7b1fe506b","added-peer-peer-urls":["https://199.204.45.53:2380"]} {"level":"info","ts":"2026-05-06T08:55:08.52113Z","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-06T08:55:08.521287Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"c47ca1a7b1fe506b","initial-advertise-peer-urls":["https://199.204.45.53:2380"],"listen-peer-urls":["https://199.204.45.53:2380"],"advertise-client-urls":["https://199.204.45.53:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.53:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-06T08:55:08.521311Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-06T08:55:08.521394Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-06T08:55:08.521407Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.53:2380"} {"level":"info","ts":"2026-05-06T08:55:09.20081Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b is starting a new election at term 1"} {"level":"info","ts":"2026-05-06T08:55:09.200874Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became pre-candidate at term 1"} {"level":"info","ts":"2026-05-06T08:55:09.200918Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgPreVoteResp from c47ca1a7b1fe506b at term 1"} {"level":"info","ts":"2026-05-06T08:55:09.200938Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became candidate at term 2"} {"level":"info","ts":"2026-05-06T08:55:09.20095Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b received MsgVoteResp from c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-06T08:55:09.200966Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"c47ca1a7b1fe506b became leader at term 2"} {"level":"info","ts":"2026-05-06T08:55:09.200987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: c47ca1a7b1fe506b elected leader c47ca1a7b1fe506b at term 2"} {"level":"info","ts":"2026-05-06T08:55:09.437384Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"c47ca1a7b1fe506b","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.53:2379]}","request-path":"/0/members/c47ca1a7b1fe506b/attributes","cluster-id":"95bd21e158fabf07","publish-timeout":"7s"} {"level":"info","ts":"2026-05-06T08:55:09.437581Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T08:55:09.437715Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T08:55:09.440945Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-06T08:55:09.449909Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-06T08:55:09.452615Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-06T08:55:09.452642Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-06T08:55:09.457209Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.53:2379"} {"level":"info","ts":"2026-05-06T08:55:09.711164Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"95bd21e158fabf07","local-member-id":"c47ca1a7b1fe506b","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T08:55:09.711457Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-06T08:55:09.711586Z","caller":"traceutil/trace.go:171","msg":"trace[1016476944] linearizableReadLoop","detail":"{readStateIndex:4; appliedIndex:3; }","duration":"215.772167ms","start":"2026-05-06T08:55:09.495801Z","end":"2026-05-06T08:55:09.711573Z","steps":["trace[1016476944] 'read index received' (duration: 215.534332ms)","trace[1016476944] 'applied index is now lower than readState.Index' (duration: 236.655µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:55:09.71165Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"warn","ts":"2026-05-06T08:55:09.711793Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.950531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.711831Z","caller":"traceutil/trace.go:171","msg":"trace[1192047117] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"216.025263ms","start":"2026-05-06T08:55:09.495797Z","end":"2026-05-06T08:55:09.711823Z","steps":["trace[1192047117] 'agreement among raft nodes before linearized reading' (duration: 215.86735ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.711886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.985013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.711991Z","caller":"traceutil/trace.go:171","msg":"trace[1031465355] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:1; }","duration":"216.131086ms","start":"2026-05-06T08:55:09.495842Z","end":"2026-05-06T08:55:09.711973Z","steps":["trace[1031465355] 'agreement among raft nodes before linearized reading' (duration: 215.948061ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.438403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-06T08:55:09.712145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.754166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712149Z","caller":"traceutil/trace.go:171","msg":"trace[1147759133] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"133.569026ms","start":"2026-05-06T08:55:09.578561Z","end":"2026-05-06T08:55:09.71213Z","steps":["trace[1147759133] 'agreement among raft nodes before linearized reading' (duration: 133.446953ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:09.712188Z","caller":"traceutil/trace.go:171","msg":"trace[1293448285] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"144.803587ms","start":"2026-05-06T08:55:09.56737Z","end":"2026-05-06T08:55:09.712173Z","steps":["trace[1293448285] 'agreement among raft nodes before linearized reading' (duration: 144.756036ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712295Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.715678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.71234Z","caller":"traceutil/trace.go:171","msg":"trace[819514202] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"163.80035ms","start":"2026-05-06T08:55:09.548531Z","end":"2026-05-06T08:55:09.712331Z","steps":["trace[819514202] 'agreement among raft nodes before linearized reading' (duration: 163.723098ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.109804ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712447Z","caller":"traceutil/trace.go:171","msg":"trace[1223705938] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:1; }","duration":"145.172305ms","start":"2026-05-06T08:55:09.567264Z","end":"2026-05-06T08:55:09.712437Z","steps":["trace[1223705938] 'agreement among raft nodes before linearized reading' (duration: 145.111984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.955653ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712519Z","caller":"traceutil/trace.go:171","msg":"trace[87898093] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:1; }","duration":"164.001514ms","start":"2026-05-06T08:55:09.548511Z","end":"2026-05-06T08:55:09.712512Z","steps":["trace[87898093] 'agreement among raft nodes before linearized reading' (duration: 163.966253ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.830273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712589Z","caller":"traceutil/trace.go:171","msg":"trace[1062747524] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"109.902065ms","start":"2026-05-06T08:55:09.602676Z","end":"2026-05-06T08:55:09.712578Z","steps":["trace[1062747524] 'agreement among raft nodes before linearized reading' (duration: 109.832704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.79534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712653Z","caller":"traceutil/trace.go:171","msg":"trace[328682893] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:1; }","duration":"176.835052ms","start":"2026-05-06T08:55:09.535812Z","end":"2026-05-06T08:55:09.712647Z","steps":["trace[328682893] 'agreement among raft nodes before linearized reading' (duration: 176.790211ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.054319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/podtemplates/\" range_end:\"/registry/podtemplates0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712809Z","caller":"traceutil/trace.go:171","msg":"trace[1886825230] range","detail":"{range_begin:/registry/podtemplates/; range_end:/registry/podtemplates0; response_count:0; response_revision:1; }","duration":"110.145681ms","start":"2026-05-06T08:55:09.602647Z","end":"2026-05-06T08:55:09.712792Z","steps":["trace[1886825230] 'agreement among raft nodes before linearized reading' (duration: 110.08135ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.695797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712931Z","caller":"traceutil/trace.go:171","msg":"trace[826177027] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"155.590628ms","start":"2026-05-06T08:55:09.557311Z","end":"2026-05-06T08:55:09.712902Z","steps":["trace[826177027] 'agreement among raft nodes before linearized reading' (duration: 154.698577ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.712952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.13803ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.712993Z","caller":"traceutil/trace.go:171","msg":"trace[1931824751] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"122.192591ms","start":"2026-05-06T08:55:09.59079Z","end":"2026-05-06T08:55:09.712982Z","steps":["trace[1931824751] 'agreement among raft nodes before linearized reading' (duration: 122.135329ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.713115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.607666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" limit:10000 ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-05-06T08:55:09.713153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.252922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.713174Z","caller":"traceutil/trace.go:171","msg":"trace[57312246] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:1; }","duration":"133.765131ms","start":"2026-05-06T08:55:09.579391Z","end":"2026-05-06T08:55:09.713156Z","steps":["trace[57312246] 'agreement among raft nodes before linearized reading' (duration: 133.681069ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:09.713191Z","caller":"traceutil/trace.go:171","msg":"trace[2112835950] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:1; }","duration":"122.333084ms","start":"2026-05-06T08:55:09.59085Z","end":"2026-05-06T08:55:09.713184Z","steps":["trace[2112835950] 'agreement among raft nodes before linearized reading' (duration: 122.269093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:09.713495Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.012134ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-05-06T08:55:09.713641Z","caller":"traceutil/trace.go:171","msg":"trace[175783553] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:1; }","duration":"156.227592ms","start":"2026-05-06T08:55:09.557375Z","end":"2026-05-06T08:55:09.713603Z","steps":["trace[175783553] 'agreement among raft nodes before linearized reading' (duration: 155.003624ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.760356Z","caller":"traceutil/trace.go:171","msg":"trace[1598022673] transaction","detail":"{read_only:false; response_revision:471; number_of_response:1; }","duration":"187.300231ms","start":"2026-05-06T08:55:38.573029Z","end":"2026-05-06T08:55:38.76033Z","steps":["trace[1598022673] 'process raft request' (duration: 187.045386ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.887734Z","caller":"traceutil/trace.go:171","msg":"trace[1084682295] transaction","detail":"{read_only:false; response_revision:474; number_of_response:1; }","duration":"309.410081ms","start":"2026-05-06T08:55:38.578301Z","end":"2026-05-06T08:55:38.887711Z","steps":["trace[1084682295] 'process raft request' (duration: 309.332849ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.88776Z","caller":"traceutil/trace.go:171","msg":"trace[28644751] transaction","detail":"{read_only:false; response_revision:472; number_of_response:1; }","duration":"314.522708ms","start":"2026-05-06T08:55:38.573199Z","end":"2026-05-06T08:55:38.887722Z","steps":["trace[28644751] 'process raft request' (duration: 314.17744ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.887794Z","caller":"traceutil/trace.go:171","msg":"trace[1057023192] transaction","detail":"{read_only:false; response_revision:473; number_of_response:1; }","duration":"309.653286ms","start":"2026-05-06T08:55:38.578098Z","end":"2026-05-06T08:55:38.887751Z","steps":["trace[1057023192] 'process raft request' (duration: 309.481072ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.888019Z","caller":"traceutil/trace.go:171","msg":"trace[775209617] transaction","detail":"{read_only:false; response_revision:475; number_of_response:1; }","duration":"308.187074ms","start":"2026-05-06T08:55:38.579821Z","end":"2026-05-06T08:55:38.888008Z","steps":["trace[775209617] 'process raft request' (duration: 307.850967ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.888082Z","caller":"traceutil/trace.go:171","msg":"trace[1519345272] transaction","detail":"{read_only:false; response_revision:478; number_of_response:1; }","duration":"288.378058ms","start":"2026-05-06T08:55:38.599693Z","end":"2026-05-06T08:55:38.888071Z","steps":["trace[1519345272] 'process raft request' (duration: 288.315116ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.888096Z","caller":"traceutil/trace.go:171","msg":"trace[899915588] transaction","detail":"{read_only:false; response_revision:477; number_of_response:1; }","duration":"295.955517ms","start":"2026-05-06T08:55:38.592106Z","end":"2026-05-06T08:55:38.888061Z","steps":["trace[899915588] 'process raft request' (duration: 295.871436ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.888213Z","caller":"traceutil/trace.go:171","msg":"trace[829521197] transaction","detail":"{read_only:false; response_revision:476; number_of_response:1; }","duration":"304.15639ms","start":"2026-05-06T08:55:38.584048Z","end":"2026-05-06T08:55:38.888204Z","steps":["trace[829521197] 'process raft request' (duration: 303.854764ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.888287Z","caller":"traceutil/trace.go:171","msg":"trace[776091223] linearizableReadLoop","detail":"{readStateIndex:499; appliedIndex:487; }","duration":"235.455414ms","start":"2026-05-06T08:55:38.65282Z","end":"2026-05-06T08:55:38.888275Z","steps":["trace[776091223] 'read index received' (duration: 107.346298ms)","trace[776091223] 'applied index is now lower than readState.Index' (duration: 128.108346ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:55:38.888244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:38.578294Z","time spent":"309.513643ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T08:55:38.888316Z","caller":"traceutil/trace.go:171","msg":"trace[1227601110] transaction","detail":"{read_only:false; response_revision:479; number_of_response:1; }","duration":"288.349487ms","start":"2026-05-06T08:55:38.59996Z","end":"2026-05-06T08:55:38.888309Z","steps":["trace[1227601110] 'process raft request' (duration: 288.068892ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:38.888322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:38.584039Z","time spent":"304.202571ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T08:55:38.888387Z","caller":"traceutil/trace.go:171","msg":"trace[880052995] transaction","detail":"{read_only:false; response_revision:481; number_of_response:1; }","duration":"273.436414ms","start":"2026-05-06T08:55:38.614944Z","end":"2026-05-06T08:55:38.888381Z","steps":["trace[880052995] 'process raft request' (duration: 273.198879ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.8884Z","caller":"traceutil/trace.go:171","msg":"trace[1450052803] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"155.592444ms","start":"2026-05-06T08:55:38.732799Z","end":"2026-05-06T08:55:38.888391Z","steps":["trace[1450052803] 'process raft request' (duration: 155.435391ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:38.888333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:38.573194Z","time spent":"314.63203ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T08:55:38.888511Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.660519ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T08:55:38.888415Z","caller":"traceutil/trace.go:171","msg":"trace[1236386521] transaction","detail":"{read_only:false; response_revision:482; number_of_response:1; }","duration":"246.559358ms","start":"2026-05-06T08:55:38.641847Z","end":"2026-05-06T08:55:38.888406Z","steps":["trace[1236386521] 'process raft request' (duration: 246.342524ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.888544Z","caller":"traceutil/trace.go:171","msg":"trace[341744846] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:483; }","duration":"235.74547ms","start":"2026-05-06T08:55:38.652787Z","end":"2026-05-06T08:55:38.888533Z","steps":["trace[341744846] 'agreement among raft nodes before linearized reading' (duration: 235.650988ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.888285Z","caller":"traceutil/trace.go:171","msg":"trace[2138527716] transaction","detail":"{read_only:false; response_revision:480; number_of_response:1; }","duration":"275.954517ms","start":"2026-05-06T08:55:38.612317Z","end":"2026-05-06T08:55:38.888272Z","steps":["trace[2138527716] 'process raft request' (duration: 275.738852ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:38.888559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:38.579804Z","time spent":"308.246796ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-06T08:55:38.888627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:38.578076Z","time spent":"309.793169ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:55:38.967259Z","caller":"traceutil/trace.go:171","msg":"trace[186861663] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"201.99433ms","start":"2026-05-06T08:55:38.765227Z","end":"2026-05-06T08:55:38.967222Z","steps":["trace[186861663] 'process raft request' (duration: 191.760234ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.967416Z","caller":"traceutil/trace.go:171","msg":"trace[1959607722] transaction","detail":"{read_only:false; number_of_response:1; response_revision:485; }","duration":"199.231522ms","start":"2026-05-06T08:55:38.768115Z","end":"2026-05-06T08:55:38.967347Z","steps":["trace[1959607722] 'process raft request' (duration: 199.10275ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:38.968084Z","caller":"traceutil/trace.go:171","msg":"trace[765415911] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"201.328876ms","start":"2026-05-06T08:55:38.766741Z","end":"2026-05-06T08:55:38.96807Z","steps":["trace[765415911] 'process raft request' (duration: 200.403717ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:39.31913Z","caller":"traceutil/trace.go:171","msg":"trace[1858059100] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"303.072878ms","start":"2026-05-06T08:55:39.016039Z","end":"2026-05-06T08:55:39.319112Z","steps":["trace[1858059100] 'process raft request' (duration: 302.997777ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:39.319271Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:39.016Z","time spent":"303.21391ms","remote":"127.0.0.1:32862","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":986,"response count":0,"response size":40,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-06T08:55:39.319378Z","caller":"traceutil/trace.go:171","msg":"trace[288325451] transaction","detail":"{read_only:false; number_of_response:1; response_revision:497; }","duration":"303.088528ms","start":"2026-05-06T08:55:39.01625Z","end":"2026-05-06T08:55:39.319338Z","steps":["trace[288325451] 'process raft request' (duration: 302.826882ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:39.319431Z","caller":"traceutil/trace.go:171","msg":"trace[962380913] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"301.122776ms","start":"2026-05-06T08:55:39.018294Z","end":"2026-05-06T08:55:39.319417Z","steps":["trace[962380913] 'process raft request' (duration: 300.965063ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:39.319495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:39.016203Z","time spent":"303.226881ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":102,"response count":0,"response size":7376,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T08:55:39.319519Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:39.018267Z","time spent":"301.198397ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:55:39.319766Z","caller":"traceutil/trace.go:171","msg":"trace[1255358507] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"300.938822ms","start":"2026-05-06T08:55:39.018817Z","end":"2026-05-06T08:55:39.319756Z","steps":["trace[1255358507] 'process raft request' (duration: 300.533374ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:39.319815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:39.018785Z","time spent":"301.007214ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":64462,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:55:39.319921Z","caller":"traceutil/trace.go:171","msg":"trace[16916362] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"293.2579ms","start":"2026-05-06T08:55:39.026638Z","end":"2026-05-06T08:55:39.319896Z","steps":["trace[16916362] 'process raft request' (duration: 293.110227ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:39.320162Z","caller":"traceutil/trace.go:171","msg":"trace[809110367] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"293.504206ms","start":"2026-05-06T08:55:39.026644Z","end":"2026-05-06T08:55:39.320149Z","steps":["trace[809110367] 'process raft request' (duration: 293.176289ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:39.320241Z","caller":"traceutil/trace.go:171","msg":"trace[1994994666] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"293.492215ms","start":"2026-05-06T08:55:39.026738Z","end":"2026-05-06T08:55:39.32023Z","steps":["trace[1994994666] 'process raft request' (duration: 293.276501ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:39.320244Z","caller":"traceutil/trace.go:171","msg":"trace[1604987144] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"265.015086ms","start":"2026-05-06T08:55:39.055222Z","end":"2026-05-06T08:55:39.320237Z","steps":["trace[1604987144] 'process raft request' (duration: 264.981516ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:39.320299Z","caller":"traceutil/trace.go:171","msg":"trace[2093141819] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"267.616152ms","start":"2026-05-06T08:55:39.052677Z","end":"2026-05-06T08:55:39.320293Z","steps":["trace[2093141819] 'process raft request' (duration: 267.419558ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:39.319155Z","caller":"traceutil/trace.go:171","msg":"trace[1311057837] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"303.558798ms","start":"2026-05-06T08:55:39.01554Z","end":"2026-05-06T08:55:39.319099Z","steps":["trace[1311057837] 'process raft request' (duration: 255.007416ms)","trace[1311057837] 'compare' (duration: 48.328826ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:55:39.320978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:39.015528Z","time spent":"305.393466ms","remote":"127.0.0.1:60624","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7326,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:55:39.319845Z","caller":"traceutil/trace.go:171","msg":"trace[689137256] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"297.582452ms","start":"2026-05-06T08:55:39.022233Z","end":"2026-05-06T08:55:39.319815Z","steps":["trace[689137256] 'process raft request' (duration: 297.404928ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:39.322966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:39.022209Z","time spent":"300.698717ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:55:40.515137Z","caller":"traceutil/trace.go:171","msg":"trace[32920430] linearizableReadLoop","detail":"{readStateIndex:568; appliedIndex:567; }","duration":"127.617956ms","start":"2026-05-06T08:55:40.38749Z","end":"2026-05-06T08:55:40.515108Z","steps":["trace[32920430] 'read index received' (duration: 127.350799ms)","trace[32920430] 'applied index is now lower than readState.Index' (duration: 266.207µs)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:55:40.515335Z","caller":"traceutil/trace.go:171","msg":"trace[299679773] transaction","detail":"{read_only:false; response_revision:548; number_of_response:1; }","duration":"127.929782ms","start":"2026-05-06T08:55:40.387335Z","end":"2026-05-06T08:55:40.515265Z","steps":["trace[299679773] 'process raft request' (duration: 127.586084ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:40.515506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.995023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:65436"} {"level":"info","ts":"2026-05-06T08:55:40.515668Z","caller":"traceutil/trace.go:171","msg":"trace[1276288161] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/clienttrafficpolicies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:548; }","duration":"128.098025ms","start":"2026-05-06T08:55:40.38745Z","end":"2026-05-06T08:55:40.515548Z","steps":["trace[1276288161] 'agreement among raft nodes before linearized reading' (duration: 127.773478ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:45.082498Z","caller":"traceutil/trace.go:171","msg":"trace[1906432741] transaction","detail":"{read_only:false; response_revision:570; number_of_response:1; }","duration":"948.453016ms","start":"2026-05-06T08:55:44.134029Z","end":"2026-05-06T08:55:45.082482Z","steps":["trace[1906432741] 'process raft request' (duration: 947.910325ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:45.082622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:44.134003Z","time spent":"948.551149ms","remote":"127.0.0.1:60676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036213,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:55:45.084602Z","caller":"traceutil/trace.go:171","msg":"trace[1022967842] linearizableReadLoop","detail":"{readStateIndex:592; appliedIndex:590; }","duration":"429.587ms","start":"2026-05-06T08:55:44.654996Z","end":"2026-05-06T08:55:45.084583Z","steps":["trace[1022967842] 'read index received' (duration: 426.812751ms)","trace[1022967842] 'applied index is now lower than readState.Index' (duration: 2.773349ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:55:45.084856Z","caller":"traceutil/trace.go:171","msg":"trace[589083839] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"586.767466ms","start":"2026-05-06T08:55:44.498074Z","end":"2026-05-06T08:55:45.084842Z","steps":["trace[589083839] 'process raft request' (duration: 586.424029ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:45.084962Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:44.498045Z","time spent":"586.857508ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T08:55:45.084992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.833425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-05-06T08:55:45.085049Z","caller":"traceutil/trace.go:171","msg":"trace[1244466211] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:571; }","duration":"170.928707ms","start":"2026-05-06T08:55:44.914106Z","end":"2026-05-06T08:55:45.085034Z","steps":["trace[1244466211] 'agreement among raft nodes before linearized reading' (duration: 170.769244ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:45.085185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.169242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T08:55:45.085264Z","caller":"traceutil/trace.go:171","msg":"trace[1688498661] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:571; }","duration":"430.298644ms","start":"2026-05-06T08:55:44.654941Z","end":"2026-05-06T08:55:45.08524Z","steps":["trace[1688498661] 'agreement among raft nodes before linearized reading' (duration: 430.163481ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:45.085306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:44.654918Z","time spent":"430.380886ms","remote":"127.0.0.1:60570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T08:55:45.712103Z","caller":"traceutil/trace.go:171","msg":"trace[893285594] transaction","detail":"{read_only:false; response_revision:581; number_of_response:1; }","duration":"128.614736ms","start":"2026-05-06T08:55:45.583447Z","end":"2026-05-06T08:55:45.712062Z","steps":["trace[893285594] 'process raft request' (duration: 121.618339ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:45.986172Z","caller":"traceutil/trace.go:171","msg":"trace[695016719] transaction","detail":"{read_only:false; response_revision:582; number_of_response:1; }","duration":"213.714926ms","start":"2026-05-06T08:55:45.772425Z","end":"2026-05-06T08:55:45.98614Z","steps":["trace[695016719] 'process raft request' (duration: 194.478123ms)","trace[695016719] 'compare' (duration: 19.112091ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:55:46.832525Z","caller":"traceutil/trace.go:171","msg":"trace[1331402697] linearizableReadLoop","detail":"{readStateIndex:604; appliedIndex:603; }","duration":"177.24042ms","start":"2026-05-06T08:55:46.655261Z","end":"2026-05-06T08:55:46.832502Z","steps":["trace[1331402697] 'read index received' (duration: 171.273203ms)","trace[1331402697] 'applied index is now lower than readState.Index' (duration: 5.966227ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:55:46.832573Z","caller":"traceutil/trace.go:171","msg":"trace[923265096] transaction","detail":"{read_only:false; response_revision:583; number_of_response:1; }","duration":"425.34397ms","start":"2026-05-06T08:55:46.407205Z","end":"2026-05-06T08:55:46.832549Z","steps":["trace[923265096] 'process raft request' (duration: 419.507097ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:46.832767Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:55:46.407175Z","time spent":"425.527834ms","remote":"127.0.0.1:60676","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T08:55:46.832672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.400173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T08:55:46.832919Z","caller":"traceutil/trace.go:171","msg":"trace[705009245] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:583; }","duration":"177.686089ms","start":"2026-05-06T08:55:46.655219Z","end":"2026-05-06T08:55:46.832905Z","steps":["trace[705009245] 'agreement among raft nodes before linearized reading' (duration: 177.402903ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:47.562196Z","caller":"traceutil/trace.go:171","msg":"trace[647968494] transaction","detail":"{read_only:false; response_revision:598; number_of_response:1; }","duration":"143.846107ms","start":"2026-05-06T08:55:47.418309Z","end":"2026-05-06T08:55:47.562155Z","steps":["trace[647968494] 'process raft request' (duration: 110.568026ms)","trace[647968494] 'compare' (duration: 32.890883ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:55:47.562459Z","caller":"traceutil/trace.go:171","msg":"trace[2105109421] transaction","detail":"{read_only:false; response_revision:599; number_of_response:1; }","duration":"142.59992ms","start":"2026-05-06T08:55:47.419809Z","end":"2026-05-06T08:55:47.562409Z","steps":["trace[2105109421] 'process raft request' (duration: 142.282494ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:49.484898Z","caller":"traceutil/trace.go:171","msg":"trace[1661531623] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"117.341738ms","start":"2026-05-06T08:55:49.367528Z","end":"2026-05-06T08:55:49.48487Z","steps":["trace[1661531623] 'process raft request' (duration: 106.814657ms)","trace[1661531623] 'compare' (duration: 10.382228ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:55:49.485075Z","caller":"traceutil/trace.go:171","msg":"trace[311033777] transaction","detail":"{read_only:false; response_revision:636; number_of_response:1; }","duration":"108.081884ms","start":"2026-05-06T08:55:49.376917Z","end":"2026-05-06T08:55:49.484999Z","steps":["trace[311033777] 'process raft request' (duration: 107.87707ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:55:49.48484Z","caller":"traceutil/trace.go:171","msg":"trace[681990984] linearizableReadLoop","detail":"{readStateIndex:657; appliedIndex:656; }","duration":"116.549821ms","start":"2026-05-06T08:55:49.368274Z","end":"2026-05-06T08:55:49.484824Z","steps":["trace[681990984] 'read index received' (duration: 42.660987ms)","trace[681990984] 'applied index is now lower than readState.Index' (duration: 73.888064ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:55:49.485555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.263338ms","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-06T08:55:49.485592Z","caller":"traceutil/trace.go:171","msg":"trace[1450477168] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:636; }","duration":"117.332059ms","start":"2026-05-06T08:55:49.368251Z","end":"2026-05-06T08:55:49.485583Z","steps":["trace[1450477168] 'agreement among raft nodes before linearized reading' (duration: 116.946001ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:55:49.485554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.223747ms","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-06T08:55:49.485655Z","caller":"traceutil/trace.go:171","msg":"trace[925382183] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:636; }","duration":"117.343759ms","start":"2026-05-06T08:55:49.368297Z","end":"2026-05-06T08:55:49.485641Z","steps":["trace[925382183] 'agreement among raft nodes before linearized reading' (duration: 117.112265ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:56:03.214508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"557.894859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T08:56:03.214565Z","caller":"traceutil/trace.go:171","msg":"trace[1845226965] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:748; }","duration":"557.997652ms","start":"2026-05-06T08:56:02.656556Z","end":"2026-05-06T08:56:03.214554Z","steps":["trace[1845226965] 'range keys from in-memory index tree' (duration: 557.786057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:56:03.214587Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:56:02.656537Z","time spent":"558.045363ms","remote":"127.0.0.1:60570","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-05-06T08:56:03.346303Z","caller":"traceutil/trace.go:171","msg":"trace[1007592222] transaction","detail":"{read_only:false; response_revision:750; number_of_response:1; }","duration":"128.637608ms","start":"2026-05-06T08:56:03.217619Z","end":"2026-05-06T08:56:03.346257Z","steps":["trace[1007592222] 'process raft request' (duration: 127.956153ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:56:37.495812Z","caller":"traceutil/trace.go:171","msg":"trace[388273772] transaction","detail":"{read_only:false; response_revision:960; number_of_response:1; }","duration":"102.830319ms","start":"2026-05-06T08:56:37.392957Z","end":"2026-05-06T08:56:37.495787Z","steps":["trace[388273772] 'process raft request' (duration: 102.683285ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:56:38.037025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.879697ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T08:56:38.03724Z","caller":"traceutil/trace.go:171","msg":"trace[1808089094] transaction","detail":"{read_only:false; response_revision:961; number_of_response:1; }","duration":"472.030821ms","start":"2026-05-06T08:56:37.565178Z","end":"2026-05-06T08:56:38.037209Z","steps":["trace[1808089094] 'process raft request' (duration: 131.727595ms)","trace[1808089094] 'compare' (duration: 339.779204ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:56:38.037366Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:56:37.565162Z","time spent":"472.143093ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T08:56:38.142385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.251793ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T08:56:38.142467Z","caller":"traceutil/trace.go:171","msg":"trace[1752644634] linearizableReadLoop","detail":"{readStateIndex:996; appliedIndex:994; }","duration":"370.997904ms","start":"2026-05-06T08:56:37.771456Z","end":"2026-05-06T08:56:38.142454Z","steps":["trace[1752644634] 'read index received' (duration: 131.96168ms)","trace[1752644634] 'applied index is now lower than readState.Index' (duration: 239.035184ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:56:38.142615Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.159337ms","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-06T08:56:38.142638Z","caller":"traceutil/trace.go:171","msg":"trace[837039225] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:961; }","duration":"371.229468ms","start":"2026-05-06T08:56:37.7714Z","end":"2026-05-06T08:56:38.14263Z","steps":["trace[837039225] 'agreement among raft nodes before linearized reading' (duration: 371.112276ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:56:38.142666Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:56:37.771377Z","time spent":"371.28125ms","remote":"127.0.0.1:60820","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-06T08:56:38.145154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.777642ms","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-06T08:56:38.145391Z","caller":"traceutil/trace.go:171","msg":"trace[912811771] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:962; }","duration":"347.049417ms","start":"2026-05-06T08:56:37.798331Z","end":"2026-05-06T08:56:38.14538Z","steps":["trace[912811771] 'agreement among raft nodes before linearized reading' (duration: 346.754361ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:56:38.14542Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:56:37.798313Z","time spent":"347.099019ms","remote":"127.0.0.1:60820","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-06T08:56:38.145575Z","caller":"traceutil/trace.go:171","msg":"trace[470281210] transaction","detail":"{read_only:false; response_revision:962; number_of_response:1; }","duration":"119.209975ms","start":"2026-05-06T08:56:38.026357Z","end":"2026-05-06T08:56:38.145567Z","steps":["trace[470281210] 'process raft request' (duration: 118.642563ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:02.797185Z","caller":"traceutil/trace.go:171","msg":"trace[805324600] linearizableReadLoop","detail":"{readStateIndex:1082; appliedIndex:1081; }","duration":"314.750586ms","start":"2026-05-06T08:57:02.482409Z","end":"2026-05-06T08:57:02.79716Z","steps":["trace[805324600] 'read index received' (duration: 226.467262ms)","trace[805324600] 'applied index is now lower than readState.Index' (duration: 88.281874ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:02.797319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.8912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-06T08:57:02.797448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.297564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-06T08:57:02.797485Z","caller":"traceutil/trace.go:171","msg":"trace[1929094336] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1042; }","duration":"245.380676ms","start":"2026-05-06T08:57:02.552093Z","end":"2026-05-06T08:57:02.797474Z","steps":["trace[1929094336] 'agreement among raft nodes before linearized reading' (duration: 245.221663ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:02.797387Z","caller":"traceutil/trace.go:171","msg":"trace[945497203] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:1042; }","duration":"315.014852ms","start":"2026-05-06T08:57:02.482354Z","end":"2026-05-06T08:57:02.797369Z","steps":["trace[945497203] 'agreement among raft nodes before linearized reading' (duration: 314.891059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:02.797713Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:02.482329Z","time spent":"315.37085ms","remote":"127.0.0.1:48608","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true "} {"level":"warn","ts":"2026-05-06T08:57:02.797698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.885292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T08:57:02.797831Z","caller":"traceutil/trace.go:171","msg":"trace[1507203198] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1042; }","duration":"142.048686ms","start":"2026-05-06T08:57:02.655772Z","end":"2026-05-06T08:57:02.797821Z","steps":["trace[1507203198] 'agreement among raft nodes before linearized reading' (duration: 141.902712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:02.797212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:02.368071Z","time spent":"429.132183ms","remote":"127.0.0.1:60604","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-05-06T08:57:16.455922Z","caller":"traceutil/trace.go:171","msg":"trace[2089071299] transaction","detail":"{read_only:false; response_revision:1138; number_of_response:1; }","duration":"225.795616ms","start":"2026-05-06T08:57:16.230113Z","end":"2026-05-06T08:57:16.455908Z","steps":["trace[2089071299] 'process raft request' (duration: 225.702204ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:16.456092Z","caller":"traceutil/trace.go:171","msg":"trace[1106286624] linearizableReadLoop","detail":"{readStateIndex:1182; appliedIndex:1182; }","duration":"177.277162ms","start":"2026-05-06T08:57:16.278776Z","end":"2026-05-06T08:57:16.456053Z","steps":["trace[1106286624] 'read index received' (duration: 177.265062ms)","trace[1106286624] 'applied index is now lower than readState.Index' (duration: 9.92µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:16.456282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.489207ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-06T08:57:16.456382Z","caller":"traceutil/trace.go:171","msg":"trace[1801202427] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1138; }","duration":"177.63849ms","start":"2026-05-06T08:57:16.278727Z","end":"2026-05-06T08:57:16.456366Z","steps":["trace[1801202427] 'agreement among raft nodes before linearized reading' (duration: 177.474527ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:16.700527Z","caller":"traceutil/trace.go:171","msg":"trace[813624074] linearizableReadLoop","detail":"{readStateIndex:1183; appliedIndex:1182; }","duration":"244.334192ms","start":"2026-05-06T08:57:16.456172Z","end":"2026-05-06T08:57:16.700506Z","steps":["trace[813624074] 'read index received' (duration: 239.33966ms)","trace[813624074] 'applied index is now lower than readState.Index' (duration: 4.993392ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:57:16.700603Z","caller":"traceutil/trace.go:171","msg":"trace[763707235] transaction","detail":"{read_only:false; response_revision:1139; number_of_response:1; }","duration":"290.392602ms","start":"2026-05-06T08:57:16.410174Z","end":"2026-05-06T08:57:16.700567Z","steps":["trace[763707235] 'process raft request' (duration: 285.40403ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:16.700808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.470837ms","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-06T08:57:16.700845Z","caller":"traceutil/trace.go:171","msg":"trace[1516555450] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1139; }","duration":"245.550969ms","start":"2026-05-06T08:57:16.455284Z","end":"2026-05-06T08:57:16.700835Z","steps":["trace[1516555450] 'agreement among raft nodes before linearized reading' (duration: 245.384596ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:16.701038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.109509ms","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-06T08:57:16.701068Z","caller":"traceutil/trace.go:171","msg":"trace[1733583428] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1139; }","duration":"249.181049ms","start":"2026-05-06T08:57:16.451879Z","end":"2026-05-06T08:57:16.70106Z","steps":["trace[1733583428] 'agreement among raft nodes before linearized reading' (duration: 249.098888ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:32.557068Z","caller":"traceutil/trace.go:171","msg":"trace[1236179454] linearizableReadLoop","detail":"{readStateIndex:1253; appliedIndex:1252; }","duration":"129.680199ms","start":"2026-05-06T08:57:32.427364Z","end":"2026-05-06T08:57:32.557044Z","steps":["trace[1236179454] 'read index received' (duration: 108.038785ms)","trace[1236179454] 'applied index is now lower than readState.Index' (duration: 21.640364ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:32.557436Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.048977ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:421"} {"level":"info","ts":"2026-05-06T08:57:32.557511Z","caller":"traceutil/trace.go:171","msg":"trace[259900899] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:1205; }","duration":"130.164009ms","start":"2026-05-06T08:57:32.42733Z","end":"2026-05-06T08:57:32.557494Z","steps":["trace[259900899] 'agreement among raft nodes before linearized reading' (duration: 130.012845ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:32.557396Z","caller":"traceutil/trace.go:171","msg":"trace[816377193] transaction","detail":"{read_only:false; response_revision:1205; number_of_response:1; }","duration":"157.049601ms","start":"2026-05-06T08:57:32.400328Z","end":"2026-05-06T08:57:32.557378Z","steps":["trace[816377193] 'process raft request' (duration: 135.08953ms)","trace[816377193] 'compare' (duration: 21.058241ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:57:32.984033Z","caller":"traceutil/trace.go:171","msg":"trace[739973462] transaction","detail":"{read_only:false; response_revision:1208; number_of_response:1; }","duration":"235.734798ms","start":"2026-05-06T08:57:32.748274Z","end":"2026-05-06T08:57:32.984008Z","steps":["trace[739973462] 'process raft request' (duration: 235.540544ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:32.984031Z","caller":"traceutil/trace.go:171","msg":"trace[48890059] linearizableReadLoop","detail":"{readStateIndex:1256; appliedIndex:1255; }","duration":"229.909049ms","start":"2026-05-06T08:57:32.754075Z","end":"2026-05-06T08:57:32.983984Z","steps":["trace[48890059] 'read index received' (duration: 229.642333ms)","trace[48890059] 'applied index is now lower than readState.Index' (duration: 265.116µs)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:32.984271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.21876ms","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-06T08:57:32.984289Z","caller":"traceutil/trace.go:171","msg":"trace[1390756474] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1208; }","duration":"194.270591ms","start":"2026-05-06T08:57:32.790013Z","end":"2026-05-06T08:57:32.984284Z","steps":["trace[1390756474] 'agreement among raft nodes before linearized reading' (duration: 194.158769ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:32.9843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.197395ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-mzfpg\" ","response":"range_response_count:1 size:11057"} {"level":"warn","ts":"2026-05-06T08:57:32.984357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.277142ms","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-06T08:57:32.984369Z","caller":"traceutil/trace.go:171","msg":"trace[1487485349] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1208; }","duration":"190.310212ms","start":"2026-05-06T08:57:32.794055Z","end":"2026-05-06T08:57:32.984365Z","steps":["trace[1487485349] 'agreement among raft nodes before linearized reading' (duration: 190.274321ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:32.984357Z","caller":"traceutil/trace.go:171","msg":"trace[1023968523] range","detail":"{range_begin:/registry/pods/kube-system/ceph-csi-rbd-nodeplugin-mzfpg; range_end:; response_count:1; response_revision:1208; }","duration":"230.292437ms","start":"2026-05-06T08:57:32.754047Z","end":"2026-05-06T08:57:32.984339Z","steps":["trace[1023968523] 'agreement among raft nodes before linearized reading' (duration: 230.097392ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:33.315244Z","caller":"traceutil/trace.go:171","msg":"trace[1921443045] transaction","detail":"{read_only:false; response_revision:1209; number_of_response:1; }","duration":"325.355576ms","start":"2026-05-06T08:57:32.989865Z","end":"2026-05-06T08:57:33.315221Z","steps":["trace[1921443045] 'process raft request' (duration: 274.706972ms)","trace[1921443045] 'compare' (duration: 50.273875ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:33.315385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:32.989842Z","time spent":"325.472268ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:57:33.33022Z","caller":"traceutil/trace.go:171","msg":"trace[1805586870] transaction","detail":"{read_only:false; response_revision:1210; number_of_response:1; }","duration":"340.101182ms","start":"2026-05-06T08:57:32.990084Z","end":"2026-05-06T08:57:33.330185Z","steps":["trace[1805586870] 'process raft request' (duration: 339.795105ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:33.330272Z","caller":"traceutil/trace.go:171","msg":"trace[1763941025] transaction","detail":"{read_only:false; response_revision:1211; number_of_response:1; }","duration":"327.660206ms","start":"2026-05-06T08:57:33.002589Z","end":"2026-05-06T08:57:33.330249Z","steps":["trace[1763941025] 'process raft request' (duration: 327.497532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:33.33038Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:32.990074Z","time spent":"340.225615ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T08:57:33.330386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:33.002572Z","time spent":"327.752688ms","remote":"127.0.0.1:60736","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11371,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:57:33.330209Z","caller":"traceutil/trace.go:171","msg":"trace[991019834] linearizableReadLoop","detail":"{readStateIndex:1259; appliedIndex:1256; }","duration":"247.229192ms","start":"2026-05-06T08:57:33.082953Z","end":"2026-05-06T08:57:33.330182Z","steps":["trace[991019834] 'read index received' (duration: 181.633527ms)","trace[991019834] 'applied index is now lower than readState.Index' (duration: 65.594445ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:33.330407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.430216ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-06T08:57:33.330476Z","caller":"traceutil/trace.go:171","msg":"trace[420541365] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1211; }","duration":"247.536968ms","start":"2026-05-06T08:57:33.082925Z","end":"2026-05-06T08:57:33.330462Z","steps":["trace[420541365] 'agreement among raft nodes before linearized reading' (duration: 247.343344ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:33.988534Z","caller":"traceutil/trace.go:171","msg":"trace[1132863572] transaction","detail":"{read_only:false; response_revision:1217; number_of_response:1; }","duration":"121.69139ms","start":"2026-05-06T08:57:33.866813Z","end":"2026-05-06T08:57:33.988504Z","steps":["trace[1132863572] 'process raft request' (duration: 121.531726ms)"],"step_count":1} {"level":"info","ts":"2026-05-06T08:57:34.243002Z","caller":"traceutil/trace.go:171","msg":"trace[486340278] transaction","detail":"{read_only:false; response_revision:1218; number_of_response:1; }","duration":"300.279429ms","start":"2026-05-06T08:57:33.942692Z","end":"2026-05-06T08:57:34.242972Z","steps":["trace[486340278] 'process raft request' (duration: 300.081984ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:34.243214Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:33.942664Z","time spent":"300.445652ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-06T08:57:35.094676Z","caller":"traceutil/trace.go:171","msg":"trace[56928733] transaction","detail":"{read_only:false; response_revision:1226; number_of_response:1; }","duration":"105.129382ms","start":"2026-05-06T08:57:34.989523Z","end":"2026-05-06T08:57:35.094652Z","steps":["trace[56928733] 'process raft request' (duration: 104.959178ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:35.805652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.569502ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-06T08:57:35.806038Z","caller":"traceutil/trace.go:171","msg":"trace[808080335] transaction","detail":"{read_only:false; response_revision:1228; number_of_response:1; }","duration":"460.106774ms","start":"2026-05-06T08:57:35.345916Z","end":"2026-05-06T08:57:35.806023Z","steps":["trace[808080335] 'process raft request' (duration: 105.014619ms)","trace[808080335] 'compare' (duration: 354.44527ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:57:35.806053Z","caller":"traceutil/trace.go:171","msg":"trace[688592578] linearizableReadLoop","detail":"{readStateIndex:1276; appliedIndex:1274; }","duration":"426.086459ms","start":"2026-05-06T08:57:35.379933Z","end":"2026-05-06T08:57:35.806019Z","steps":["trace[688592578] 'read index received' (duration: 38.309329ms)","trace[688592578] 'applied index is now lower than readState.Index' (duration: 387.77542ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:35.806089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:35.345893Z","time spent":"460.172295ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T08:57:35.806227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.292403ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-06T08:57:35.806279Z","caller":"traceutil/trace.go:171","msg":"trace[1953411080] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1228; }","duration":"426.384205ms","start":"2026-05-06T08:57:35.379881Z","end":"2026-05-06T08:57:35.806265Z","steps":["trace[1953411080] 'agreement among raft nodes before linearized reading' (duration: 426.224731ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:35.806325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:35.379848Z","time spent":"426.466507ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-06T08:57:48.375371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"570.327868ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-05-06T08:57:48.376575Z","caller":"traceutil/trace.go:171","msg":"trace[545145408] linearizableReadLoop","detail":"{readStateIndex:1361; appliedIndex:1359; }","duration":"511.153345ms","start":"2026-05-06T08:57:47.865388Z","end":"2026-05-06T08:57:48.376541Z","steps":["trace[545145408] 'read index received' (duration: 427.850147ms)","trace[545145408] 'applied index is now lower than readState.Index' (duration: 83.301738ms)"],"step_count":2} {"level":"info","ts":"2026-05-06T08:57:48.376656Z","caller":"traceutil/trace.go:171","msg":"trace[1590584291] transaction","detail":"{read_only:false; response_revision:1310; number_of_response:1; }","duration":"594.802309ms","start":"2026-05-06T08:57:47.781801Z","end":"2026-05-06T08:57:48.376603Z","steps":["trace[1590584291] 'process raft request' (duration: 593.672644ms)"],"step_count":1} {"level":"warn","ts":"2026-05-06T08:57:48.376947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:47.78178Z","time spent":"594.968943ms","remote":"127.0.0.1:60726","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6757,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-06T08:57:48.450977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.801132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-06T08:57:48.451079Z","caller":"traceutil/trace.go:171","msg":"trace[139878601] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1310; }","duration":"572.951726ms","start":"2026-05-06T08:57:47.878102Z","end":"2026-05-06T08:57:48.451054Z","steps":["trace[139878601] 'agreement among raft nodes before linearized reading' (duration: 498.622557ms)","trace[139878601] 'range keys from in-memory index tree' (duration: 73.870058ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:48.45113Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:47.878081Z","time spent":"573.036258ms","remote":"127.0.0.1:60820","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-06T08:57:48.451164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.74903ms","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-06T08:57:48.451233Z","caller":"traceutil/trace.go:171","msg":"trace[1254509647] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1310; }","duration":"585.876063ms","start":"2026-05-06T08:57:47.865337Z","end":"2026-05-06T08:57:48.451214Z","steps":["trace[1254509647] 'agreement among raft nodes before linearized reading' (duration: 511.33781ms)","trace[1254509647] 'range keys from in-memory index tree' (duration: 74.330919ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:48.451242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.992311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-05-06T08:57:48.451273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:47.865315Z","time spent":"585.949074ms","remote":"127.0.0.1:60820","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-06T08:57:48.451326Z","caller":"traceutil/trace.go:171","msg":"trace[497130963] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1310; }","duration":"382.079684ms","start":"2026-05-06T08:57:48.069199Z","end":"2026-05-06T08:57:48.451278Z","steps":["trace[497130963] 'agreement among raft nodes before linearized reading' (duration: 307.52438ms)","trace[497130963] 'range keys from in-memory index tree' (duration: 74.419371ms)"],"step_count":2} {"level":"warn","ts":"2026-05-06T08:57:48.451387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-06T08:57:48.069176Z","time spent":"382.183765ms","remote":"127.0.0.1:60820","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "}