{"level":"warn","ts":"2026-06-10T10:08:25.280566Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:08:25.280767Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.242: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.242:2380","--initial-cluster=instance=https://199.204.45.242:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.242:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.242:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-10T10:08:25.280949Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:08:25.280976Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-06-10T10:08:25.281018Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T10:08:25.282429Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"]} {"level":"info","ts":"2026-06-10T10:08:25.282545Z","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":16,"max-cpu-available":16,"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.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.242:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-10T10:08:25.286695Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.823096ms"} {"level":"info","ts":"2026-06-10T10:08:25.292266Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b844c110b9783e73","cluster-id":"49dc9693ccd466a9"} {"level":"info","ts":"2026-06-10T10:08:25.29236Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T10:08:25.292388Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 0"} {"level":"info","ts":"2026-06-10T10:08:25.292408Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b844c110b9783e73 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T10:08:25.29242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became follower at term 1"} {"level":"info","ts":"2026-06-10T10:08:25.292463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"warn","ts":"2026-06-10T10:08:25.297049Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T10:08:25.298487Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T10:08:25.299596Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-10T10:08:25.301654Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b844c110b9783e73","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T10:08:25.302526Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b844c110b9783e73","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T10:08:25.302747Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:08:25.302833Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:08:25.302849Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:08:25.306152Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 switched to configuration voters=(13277949878970367603)"} {"level":"info","ts":"2026-06-10T10:08:25.306224Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-06-10T10:08:25.306249Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.242:2380"} {"level":"info","ts":"2026-06-10T10:08:25.306161Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T10:08:25.306364Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","added-peer-id":"b844c110b9783e73","added-peer-peer-urls":["https://199.204.45.242:2380"]} {"level":"info","ts":"2026-06-10T10:08:25.30653Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b844c110b9783e73","initial-advertise-peer-urls":["https://199.204.45.242:2380"],"listen-peer-urls":["https://199.204.45.242:2380"],"advertise-client-urls":["https://199.204.45.242:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.242:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T10:08:25.306565Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T10:08:25.79344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T10:08:25.793519Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T10:08:25.793676Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgPreVoteResp from b844c110b9783e73 at term 1"} {"level":"info","ts":"2026-06-10T10:08:25.793716Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became candidate at term 2"} {"level":"info","ts":"2026-06-10T10:08:25.79389Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 received MsgVoteResp from b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-06-10T10:08:25.794019Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b844c110b9783e73 became leader at term 2"} {"level":"info","ts":"2026-06-10T10:08:25.794039Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b844c110b9783e73 elected leader b844c110b9783e73 at term 2"} {"level":"info","ts":"2026-06-10T10:08:25.79517Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:25.795817Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b844c110b9783e73","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.242:2379]}","request-path":"/0/members/b844c110b9783e73/attributes","cluster-id":"49dc9693ccd466a9","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T10:08:25.796149Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:08:25.79623Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:08:25.796341Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T10:08:25.796432Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T10:08:25.79643Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"49dc9693ccd466a9","local-member-id":"b844c110b9783e73","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:25.796568Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:25.796621Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:25.798014Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T10:08:25.799679Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.242:2379"} {"level":"info","ts":"2026-06-10T10:08:41.923796Z","caller":"traceutil/trace.go:171","msg":"trace[915950562] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"146.516364ms","start":"2026-06-10T10:08:41.77724Z","end":"2026-06-10T10:08:41.923756Z","steps":["trace[915950562] 'process raft request' (duration: 146.326599ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:45.254806Z","caller":"traceutil/trace.go:171","msg":"trace[575383068] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"300.450535ms","start":"2026-06-10T10:09:44.954313Z","end":"2026-06-10T10:09:45.254763Z","steps":["trace[575383068] 'process raft request' (duration: 248.3541ms)","trace[575383068] 'compare' (duration: 51.758286ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:45.254971Z","caller":"traceutil/trace.go:171","msg":"trace[1605293452] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:635; }","duration":"126.694755ms","start":"2026-06-10T10:09:45.128248Z","end":"2026-06-10T10:09:45.254943Z","steps":["trace[1605293452] 'read index received' (duration: 74.442766ms)","trace[1605293452] 'applied index is now lower than readState.Index' (duration: 52.250969ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:45.254978Z","caller":"traceutil/trace.go:171","msg":"trace[83512550] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"293.125003ms","start":"2026-06-10T10:09:44.961797Z","end":"2026-06-10T10:09:45.254922Z","steps":["trace[83512550] 'process raft request' (duration: 292.890946ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:45.255144Z","caller":"traceutil/trace.go:171","msg":"trace[1438019345] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"233.138118ms","start":"2026-06-10T10:09:45.021967Z","end":"2026-06-10T10:09:45.255105Z","steps":["trace[1438019345] 'process raft request' (duration: 232.898551ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:45.255116Z","caller":"traceutil/trace.go:171","msg":"trace[1987128859] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"293.128512ms","start":"2026-06-10T10:09:44.961921Z","end":"2026-06-10T10:09:45.255049Z","steps":["trace[1987128859] 'process raft request' (duration: 292.844064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:45.255147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.866229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:09:45.255272Z","caller":"traceutil/trace.go:171","msg":"trace[988924932] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:608; }","duration":"127.071416ms","start":"2026-06-10T10:09:45.128181Z","end":"2026-06-10T10:09:45.255252Z","steps":["trace[988924932] 'agreement among raft nodes before linearized reading' (duration: 126.86383ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:45.255485Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:44.954284Z","time spent":"300.645541ms","remote":"127.0.0.1:42542","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58844,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:09:51.064025Z","caller":"traceutil/trace.go:171","msg":"trace[1501834236] transaction","detail":"{read_only:false; response_revision:686; number_of_response:1; }","duration":"132.148166ms","start":"2026-06-10T10:09:50.931849Z","end":"2026-06-10T10:09:51.063997Z","steps":["trace[1501834236] 'process raft request' (duration: 131.429286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:51.578026Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.175886ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:09:51.578331Z","caller":"traceutil/trace.go:171","msg":"trace[1384902313] transaction","detail":"{read_only:false; response_revision:687; number_of_response:1; }","duration":"460.665351ms","start":"2026-06-10T10:09:51.117637Z","end":"2026-06-10T10:09:51.578302Z","steps":["trace[1384902313] 'process raft request' (duration: 43.896608ms)","trace[1384902313] 'compare' (duration: 415.959471ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:09:51.578414Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:51.117607Z","time spent":"460.773804ms","remote":"127.0.0.1:42870","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:09:53.122478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.277574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:53.122646Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.371447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.122655Z","caller":"traceutil/trace.go:171","msg":"trace[181958666] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumpodippools.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"214.497051ms","start":"2026-06-10T10:09:52.908132Z","end":"2026-06-10T10:09:53.122629Z","steps":["trace[181958666] 'range keys from in-memory index tree' (duration: 214.232264ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:53.122703Z","caller":"traceutil/trace.go:171","msg":"trace[1966896786] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumexternalworkloads.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"214.43315ms","start":"2026-06-10T10:09:52.908248Z","end":"2026-06-10T10:09:53.122681Z","steps":["trace[1966896786] 'range keys from in-memory index tree' (duration: 214.328216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.122732Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.81779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.122877Z","caller":"traceutil/trace.go:171","msg":"trace[666420770] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodeconfigs.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"215.007505ms","start":"2026-06-10T10:09:52.907832Z","end":"2026-06-10T10:09:53.122839Z","steps":["trace[666420770] 'range keys from in-memory index tree' (duration: 214.750708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.122882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.893411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T10:09:53.122506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.759885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.122944Z","caller":"traceutil/trace.go:171","msg":"trace[885553857] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:713; }","duration":"214.970004ms","start":"2026-06-10T10:09:52.907954Z","end":"2026-06-10T10:09:53.122924Z","steps":["trace[885553857] 'count revisions from in-memory index tree' (duration: 214.794099ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.122931Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.934293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:53.122953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.840391ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.123017Z","caller":"traceutil/trace.go:171","msg":"trace[104610681] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumcidrgroups.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"214.911672ms","start":"2026-06-10T10:09:52.908092Z","end":"2026-06-10T10:09:53.123003Z","steps":["trace[104610681] 'range keys from in-memory index tree' (duration: 214.778898ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:53.123032Z","caller":"traceutil/trace.go:171","msg":"trace[15514259] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumloadbalancerippools.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"215.036866ms","start":"2026-06-10T10:09:52.907956Z","end":"2026-06-10T10:09:53.122993Z","steps":["trace[15514259] 'range keys from in-memory index tree' (duration: 214.84184ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.122731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.595652ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.123041Z","caller":"traceutil/trace.go:171","msg":"trace[1430724244] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumendpoints.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"212.27124ms","start":"2026-06-10T10:09:52.910705Z","end":"2026-06-10T10:09:53.122977Z","steps":["trace[1430724244] 'range keys from in-memory index tree' (duration: 211.718504ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.12309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.714236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:53.123145Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.810579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.123147Z","caller":"traceutil/trace.go:171","msg":"trace[635368195] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:713; }","duration":"220.055365ms","start":"2026-06-10T10:09:52.903074Z","end":"2026-06-10T10:09:53.123129Z","steps":["trace[635368195] 'range keys from in-memory index tree' (duration: 219.492089ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:53.123177Z","caller":"traceutil/trace.go:171","msg":"trace[1779552304] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliuml2announcementpolicies.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"214.848581ms","start":"2026-06-10T10:09:52.908309Z","end":"2026-06-10T10:09:53.123157Z","steps":["trace[1779552304] 'range keys from in-memory index tree' (duration: 214.608004ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:53.123195Z","caller":"traceutil/trace.go:171","msg":"trace[812948123] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumidentities.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"214.866541ms","start":"2026-06-10T10:09:52.908316Z","end":"2026-06-10T10:09:53.123182Z","steps":["trace[812948123] 'range keys from in-memory index tree' (duration: 214.724507ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.122773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.008139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:09:53.123343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.137742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T10:09:53.123331Z","caller":"traceutil/trace.go:171","msg":"trace[1228493109] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnetworkpolicies.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"182.560304ms","start":"2026-06-10T10:09:52.940691Z","end":"2026-06-10T10:09:53.123251Z","steps":["trace[1228493109] 'range keys from in-memory index tree' (duration: 181.850455ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:53.123418Z","caller":"traceutil/trace.go:171","msg":"trace[175442614] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:713; }","duration":"218.285366ms","start":"2026-06-10T10:09:52.905115Z","end":"2026-06-10T10:09:53.123401Z","steps":["trace[175442614] 'range keys from in-memory index tree' (duration: 217.887685ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:09:53.123433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.68976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:09:53.123543Z","caller":"traceutil/trace.go:171","msg":"trace[50476128] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/ciliumnodes.cilium.io; range_end:; response_count:0; response_revision:713; }","duration":"209.306657ms","start":"2026-06-10T10:09:52.914219Z","end":"2026-06-10T10:09:53.123526Z","steps":["trace[50476128] 'range keys from in-memory index tree' (duration: 208.580117ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:10:34.27078Z","caller":"traceutil/trace.go:171","msg":"trace[281758923] transaction","detail":"{read_only:false; response_revision:1248; number_of_response:1; }","duration":"171.399557ms","start":"2026-06-10T10:10:34.099341Z","end":"2026-06-10T10:10:34.270741Z","steps":["trace[281758923] 'process raft request' (duration: 171.13428ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:21.288468Z","caller":"traceutil/trace.go:171","msg":"trace[1773061444] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"100.533442ms","start":"2026-06-10T10:11:21.187905Z","end":"2026-06-10T10:11:21.288439Z","steps":["trace[1773061444] 'process raft request' (duration: 100.399589ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:33.960065Z","caller":"traceutil/trace.go:171","msg":"trace[606513640] transaction","detail":"{read_only:false; response_revision:2030; number_of_response:1; }","duration":"119.698769ms","start":"2026-06-10T10:11:33.840336Z","end":"2026-06-10T10:11:33.960034Z","steps":["trace[606513640] 'process raft request' (duration: 119.485413ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:33.961184Z","caller":"traceutil/trace.go:171","msg":"trace[1443182431] linearizableReadLoop","detail":"{readStateIndex:2111; appliedIndex:2109; }","duration":"110.310565ms","start":"2026-06-10T10:11:33.850843Z","end":"2026-06-10T10:11:33.961153Z","steps":["trace[1443182431] 'read index received' (duration: 109.041731ms)","trace[1443182431] 'applied index is now lower than readState.Index' (duration: 1.267424ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:11:33.961296Z","caller":"traceutil/trace.go:171","msg":"trace[880044298] transaction","detail":"{read_only:false; response_revision:2031; number_of_response:1; }","duration":"116.493353ms","start":"2026-06-10T10:11:33.844749Z","end":"2026-06-10T10:11:33.961242Z","steps":["trace[880044298] 'process raft request' (duration: 116.226686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:11:33.961435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.570723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:11:33.961537Z","caller":"traceutil/trace.go:171","msg":"trace[1598280810] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2031; }","duration":"110.732377ms","start":"2026-06-10T10:11:33.850785Z","end":"2026-06-10T10:11:33.961517Z","steps":["trace[1598280810] 'agreement among raft nodes before linearized reading' (duration: 110.46904ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:12:12.488958Z","caller":"traceutil/trace.go:171","msg":"trace[1455093238] transaction","detail":"{read_only:false; response_revision:2254; number_of_response:1; }","duration":"227.030659ms","start":"2026-06-10T10:12:12.261871Z","end":"2026-06-10T10:12:12.488902Z","steps":["trace[1455093238] 'process raft request' (duration: 159.085743ms)","trace[1455093238] 'compare' (duration: 67.450053ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:12:12.489348Z","caller":"traceutil/trace.go:171","msg":"trace[1285224262] transaction","detail":"{read_only:false; response_revision:2255; number_of_response:1; }","duration":"227.133302ms","start":"2026-06-10T10:12:12.262176Z","end":"2026-06-10T10:12:12.489309Z","steps":["trace[1285224262] 'process raft request' (duration: 226.557607ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:12:12.489507Z","caller":"traceutil/trace.go:171","msg":"trace[1156345198] transaction","detail":"{read_only:false; response_revision:2256; number_of_response:1; }","duration":"197.630603ms","start":"2026-06-10T10:12:12.291816Z","end":"2026-06-10T10:12:12.489447Z","steps":["trace[1156345198] 'process raft request' (duration: 197.050547ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:13:41.175508Z","caller":"traceutil/trace.go:171","msg":"trace[855522689] transaction","detail":"{read_only:false; response_revision:2927; number_of_response:1; }","duration":"106.088318ms","start":"2026-06-10T10:13:41.06939Z","end":"2026-06-10T10:13:41.175479Z","steps":["trace[855522689] 'process raft request' (duration: 105.902923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:13:41.597375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.679371ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:13:41.597743Z","caller":"traceutil/trace.go:171","msg":"trace[1181022626] transaction","detail":"{read_only:false; response_revision:2929; number_of_response:1; }","duration":"273.148105ms","start":"2026-06-10T10:13:41.324551Z","end":"2026-06-10T10:13:41.597699Z","steps":["trace[1181022626] 'process raft request' (duration: 134.032802ms)","trace[1181022626] 'compare' (duration: 138.523467ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:13:41.785005Z","caller":"traceutil/trace.go:171","msg":"trace[2117945537] transaction","detail":"{read_only:false; response_revision:2930; number_of_response:1; }","duration":"182.221237ms","start":"2026-06-10T10:13:41.602755Z","end":"2026-06-10T10:13:41.784977Z","steps":["trace[2117945537] 'process raft request' (duration: 148.74779ms)","trace[2117945537] 'compare' (duration: 33.365064ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:16:17.407026Z","caller":"traceutil/trace.go:171","msg":"trace[1657891289] linearizableReadLoop","detail":"{readStateIndex:4104; appliedIndex:4102; }","duration":"116.111398ms","start":"2026-06-10T10:16:17.290881Z","end":"2026-06-10T10:16:17.406992Z","steps":["trace[1657891289] 'read index received' (duration: 34.433802ms)","trace[1657891289] 'applied index is now lower than readState.Index' (duration: 81.676596ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:16:17.407092Z","caller":"traceutil/trace.go:171","msg":"trace[633419241] transaction","detail":"{read_only:false; response_revision:3949; number_of_response:1; }","duration":"141.977232ms","start":"2026-06-10T10:16:17.265074Z","end":"2026-06-10T10:16:17.407051Z","steps":["trace[633419241] 'process raft request' (duration: 122.3188ms)","trace[633419241] 'compare' (duration: 19.477347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:16:17.407226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.312933ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/vhosts/\" range_end:\"/registry/rabbitmq.com/vhosts0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:16:17.407298Z","caller":"traceutil/trace.go:171","msg":"trace[398623163] range","detail":"{range_begin:/registry/rabbitmq.com/vhosts/; range_end:/registry/rabbitmq.com/vhosts0; response_count:0; response_revision:3949; }","duration":"116.477148ms","start":"2026-06-10T10:16:17.290803Z","end":"2026-06-10T10:16:17.40728Z","steps":["trace[398623163] 'agreement among raft nodes before linearized reading' (duration: 116.321293ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:49.471932Z","caller":"traceutil/trace.go:171","msg":"trace[1135559153] linearizableReadLoop","detail":"{readStateIndex:5385; appliedIndex:5384; }","duration":"157.569162ms","start":"2026-06-10T10:17:49.314325Z","end":"2026-06-10T10:17:49.471894Z","steps":["trace[1135559153] 'read index received' (duration: 120.648973ms)","trace[1135559153] 'applied index is now lower than readState.Index' (duration: 36.918809ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:49.472047Z","caller":"traceutil/trace.go:171","msg":"trace[155830589] transaction","detail":"{read_only:false; response_revision:5182; number_of_response:1; }","duration":"160.283027ms","start":"2026-06-10T10:17:49.311674Z","end":"2026-06-10T10:17:49.471957Z","steps":["trace[155830589] 'process raft request' (duration: 123.327246ms)","trace[155830589] 'compare' (duration: 36.729305ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:17:49.472347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.313146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-b68pz\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-10T10:17:49.472399Z","caller":"traceutil/trace.go:171","msg":"trace[1519633699] range","detail":"{range_begin:/registry/pods/openstack/keepalived-b68pz; range_end:; response_count:1; response_revision:5182; }","duration":"102.406348ms","start":"2026-06-10T10:17:49.369978Z","end":"2026-06-10T10:17:49.472385Z","steps":["trace[1519633699] 'agreement among raft nodes before linearized reading' (duration: 102.175042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:49.472435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.122179ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-1ce9906c-d19b-4816-b0fa-e5606f7ea3ba\" ","response":"range_response_count:1 size:3891"} {"level":"warn","ts":"2026-06-10T10:17:49.472402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.039555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16248"} {"level":"info","ts":"2026-06-10T10:17:49.472485Z","caller":"traceutil/trace.go:171","msg":"trace[1904051638] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-1ce9906c-d19b-4816-b0fa-e5606f7ea3ba; range_end:; response_count:1; response_revision:5182; }","duration":"111.197311ms","start":"2026-06-10T10:17:49.361273Z","end":"2026-06-10T10:17:49.47247Z","steps":["trace[1904051638] 'agreement among raft nodes before linearized reading' (duration: 111.038917ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:49.472536Z","caller":"traceutil/trace.go:171","msg":"trace[1267970026] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:5182; }","duration":"158.224ms","start":"2026-06-10T10:17:49.314275Z","end":"2026-06-10T10:17:49.472499Z","steps":["trace[1267970026] 'agreement among raft nodes before linearized reading' (duration: 157.839129ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:49.472917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.030454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T10:17:49.473034Z","caller":"traceutil/trace.go:171","msg":"trace[1622078922] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5182; }","duration":"133.2381ms","start":"2026-06-10T10:17:49.339767Z","end":"2026-06-10T10:17:49.473005Z","steps":["trace[1622078922] 'agreement among raft nodes before linearized reading' (duration: 132.810978ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:49.473263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.840941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:17:49.473351Z","caller":"traceutil/trace.go:171","msg":"trace[1758354935] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:5182; }","duration":"152.966355ms","start":"2026-06-10T10:17:49.320363Z","end":"2026-06-10T10:17:49.473329Z","steps":["trace[1758354935] 'agreement among raft nodes before linearized reading' (duration: 151.784202ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:18:10.711986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.617322ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:18:10.712192Z","caller":"traceutil/trace.go:171","msg":"trace[1891075868] transaction","detail":"{read_only:false; response_revision:5613; number_of_response:1; }","duration":"160.796511ms","start":"2026-06-10T10:18:10.551349Z","end":"2026-06-10T10:18:10.712146Z","steps":["trace[1891075868] 'process raft request' (duration: 52.903891ms)","trace[1891075868] 'compare' (duration: 107.475569ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:25.827561Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2843} {"level":"info","ts":"2026-06-10T10:18:25.896882Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2843,"took":"66.576259ms","hash":2133269576,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":32129024,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T10:18:25.896983Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2133269576,"revision":2843,"compact-revision":-1} {"level":"info","ts":"2026-06-10T10:23:25.834766Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5764} {"level":"info","ts":"2026-06-10T10:23:25.921617Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5764,"took":"85.092143ms","hash":2268214687,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":26562560,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-10T10:23:25.921675Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2268214687,"revision":5764,"compact-revision":2843} {"level":"warn","ts":"2026-06-10T10:24:19.368994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:24:18.945947Z","time spent":"423.042109ms","remote":"127.0.0.1:42522","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-10T10:24:19.369155Z","caller":"traceutil/trace.go:171","msg":"trace[910638212] transaction","detail":"{read_only:false; response_revision:8431; number_of_response:1; }","duration":"222.005439ms","start":"2026-06-10T10:24:19.147126Z","end":"2026-06-10T10:24:19.369131Z","steps":["trace[910638212] 'process raft request' (duration: 221.964528ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:19.369486Z","caller":"traceutil/trace.go:171","msg":"trace[661517284] transaction","detail":"{read_only:false; response_revision:8430; number_of_response:1; }","duration":"228.664943ms","start":"2026-06-10T10:24:19.140779Z","end":"2026-06-10T10:24:19.369444Z","steps":["trace[661517284] 'process raft request' (duration: 228.18548ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:19.369517Z","caller":"traceutil/trace.go:171","msg":"trace[213353988] linearizableReadLoop","detail":"{readStateIndex:8733; appliedIndex:8732; }","duration":"278.312574ms","start":"2026-06-10T10:24:19.091154Z","end":"2026-06-10T10:24:19.369467Z","steps":["trace[213353988] 'read index received' (duration: 276.180445ms)","trace[213353988] 'applied index is now lower than readState.Index' (duration: 2.053296ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:24:19.369651Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.477178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-06-10T10:24:19.369714Z","caller":"traceutil/trace.go:171","msg":"trace[1302463090] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8431; }","duration":"278.587071ms","start":"2026-06-10T10:24:19.091107Z","end":"2026-06-10T10:24:19.369694Z","steps":["trace[1302463090] 'agreement among raft nodes before linearized reading' (duration: 278.408896ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:30.927461Z","caller":"traceutil/trace.go:171","msg":"trace[1757376843] transaction","detail":"{read_only:false; response_revision:8490; number_of_response:1; }","duration":"151.076241ms","start":"2026-06-10T10:24:30.776349Z","end":"2026-06-10T10:24:30.927425Z","steps":["trace[1757376843] 'process raft request' (duration: 118.266526ms)","trace[1757376843] 'compare' (duration: 32.490686ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:24:30.988756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.15255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-06-10T10:24:30.988838Z","caller":"traceutil/trace.go:171","msg":"trace[2102235523] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8491; }","duration":"123.260123ms","start":"2026-06-10T10:24:30.865549Z","end":"2026-06-10T10:24:30.98881Z","steps":["trace[2102235523] 'agreement among raft nodes before linearized reading' (duration: 123.063958ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:32.799599Z","caller":"traceutil/trace.go:171","msg":"trace[1903710644] transaction","detail":"{read_only:false; response_revision:8499; number_of_response:1; }","duration":"211.505289ms","start":"2026-06-10T10:24:32.588066Z","end":"2026-06-10T10:24:32.799571Z","steps":["trace[1903710644] 'process raft request' (duration: 211.339965ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:24:33.153555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.405723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-10T10:24:33.153648Z","caller":"traceutil/trace.go:171","msg":"trace[1155485907] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8500; }","duration":"133.554487ms","start":"2026-06-10T10:24:33.020065Z","end":"2026-06-10T10:24:33.153619Z","steps":["trace[1155485907] 'range keys from in-memory index tree' (duration: 133.185617ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:00.6207Z","caller":"traceutil/trace.go:171","msg":"trace[185265516] transaction","detail":"{read_only:false; response_revision:8705; number_of_response:1; }","duration":"204.984589ms","start":"2026-06-10T10:25:00.415689Z","end":"2026-06-10T10:25:00.620673Z","steps":["trace[185265516] 'process raft request' (duration: 204.800874ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:03.65299Z","caller":"traceutil/trace.go:171","msg":"trace[33989832] transaction","detail":"{read_only:false; response_revision:8722; number_of_response:1; }","duration":"108.127136ms","start":"2026-06-10T10:25:03.544821Z","end":"2026-06-10T10:25:03.652949Z","steps":["trace[33989832] 'process raft request' (duration: 72.80239ms)","trace[33989832] 'compare' (duration: 35.10404ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:03.653281Z","caller":"traceutil/trace.go:171","msg":"trace[767681796] transaction","detail":"{read_only:false; response_revision:8723; number_of_response:1; }","duration":"107.258542ms","start":"2026-06-10T10:25:03.545983Z","end":"2026-06-10T10:25:03.653241Z","steps":["trace[767681796] 'process raft request' (duration: 106.914472ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:13.05118Z","caller":"traceutil/trace.go:171","msg":"trace[130731154] linearizableReadLoop","detail":"{readStateIndex:9132; appliedIndex:9131; }","duration":"157.336064ms","start":"2026-06-10T10:25:12.893814Z","end":"2026-06-10T10:25:13.05115Z","steps":["trace[130731154] 'read index received' (duration: 157.158109ms)","trace[130731154] 'applied index is now lower than readState.Index' (duration: 176.565µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:25:13.051302Z","caller":"traceutil/trace.go:171","msg":"trace[1601672924] transaction","detail":"{read_only:false; response_revision:8812; number_of_response:1; }","duration":"232.408417ms","start":"2026-06-10T10:25:12.818881Z","end":"2026-06-10T10:25:13.05129Z","steps":["trace[1601672924] 'process raft request' (duration: 232.083798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:13.051581Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.740155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T10:25:13.051789Z","caller":"traceutil/trace.go:171","msg":"trace[1488185877] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8812; }","duration":"157.851668ms","start":"2026-06-10T10:25:12.893806Z","end":"2026-06-10T10:25:13.051658Z","steps":["trace[1488185877] 'agreement among raft nodes before linearized reading' (duration: 157.603951ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:13.143945Z","caller":"traceutil/trace.go:171","msg":"trace[538378891] transaction","detail":"{read_only:false; response_revision:8813; number_of_response:1; }","duration":"223.50956ms","start":"2026-06-10T10:25:12.920408Z","end":"2026-06-10T10:25:13.143918Z","steps":["trace[538378891] 'process raft request' (duration: 204.188987ms)","trace[538378891] 'compare' (duration: 19.001494ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:25:13.144408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.264583ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-06-10T10:25:13.144473Z","caller":"traceutil/trace.go:171","msg":"trace[279926178] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8813; }","duration":"106.363336ms","start":"2026-06-10T10:25:13.038095Z","end":"2026-06-10T10:25:13.144458Z","steps":["trace[279926178] 'agreement among raft nodes before linearized reading' (duration: 106.13756ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:13.14478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.58797ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-qh6nv\" ","response":"range_response_count:1 size:4648"} {"level":"info","ts":"2026-06-10T10:25:13.145732Z","caller":"traceutil/trace.go:171","msg":"trace[1809848682] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-qh6nv; range_end:; response_count:1; response_revision:8813; }","duration":"225.565987ms","start":"2026-06-10T10:25:12.920128Z","end":"2026-06-10T10:25:13.145694Z","steps":["trace[1809848682] 'agreement among raft nodes before linearized reading' (duration: 224.457526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:13.145202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.035103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-10T10:25:13.145864Z","caller":"traceutil/trace.go:171","msg":"trace[635553289] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:8813; }","duration":"120.728742ms","start":"2026-06-10T10:25:13.025107Z","end":"2026-06-10T10:25:13.145836Z","steps":["trace[635553289] 'agreement among raft nodes before linearized reading' (duration: 119.993632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:25:13.775059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.969307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:25:13.775835Z","caller":"traceutil/trace.go:171","msg":"trace[542342896] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:8820; }","duration":"139.794ms","start":"2026-06-10T10:25:13.636016Z","end":"2026-06-10T10:25:13.77581Z","steps":["trace[542342896] 'count revisions from in-memory index tree' (duration: 138.868655ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:25:30.293459Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000245b.wal"} {"level":"warn","ts":"2026-06-10T10:26:29.51449Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114935739524842,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:26:30.629626Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114935739524842,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:26:31.049964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"419.305014ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context canceled"} {"level":"info","ts":"2026-06-10T10:26:31.050065Z","caller":"traceutil/trace.go:171","msg":"trace[993921899] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"419.439447ms","start":"2026-06-10T10:26:30.630603Z","end":"2026-06-10T10:26:31.050043Z","steps":["trace[993921899] 'agreement among raft nodes before linearized reading' (duration: 419.324694ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.050135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.630592Z","time spent":"419.5143ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} 2026/06/10 10:26:31 WARNING: [core] [Server #7] grpc: Server.processUnaryRPC failed to write status: connection error: desc = "transport is closing" {"level":"warn","ts":"2026-06-10T10:26:31.078258Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.510028333s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T10:26:31.078675Z","caller":"traceutil/trace.go:171","msg":"trace[1248858482] linearizableReadLoop","detail":"{readStateIndex:9895; appliedIndex:9893; }","duration":"2.510462275s","start":"2026-06-10T10:26:28.568181Z","end":"2026-06-10T10:26:31.078644Z","steps":["trace[1248858482] 'read index received' (duration: 2.510346901s)","trace[1248858482] 'applied index is now lower than readState.Index' (duration: 114.394µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:26:31.078957Z","caller":"traceutil/trace.go:171","msg":"trace[1540876915] transaction","detail":"{read_only:false; response_revision:9555; number_of_response:1; }","duration":"2.510880626s","start":"2026-06-10T10:26:28.568065Z","end":"2026-06-10T10:26:31.078945Z","steps":["trace[1540876915] 'process raft request' (duration: 2.510414263s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.079063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.568046Z","time spent":"2.510944688s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.07925Z","caller":"traceutil/trace.go:171","msg":"trace[458373516] transaction","detail":"{read_only:false; response_revision:9556; number_of_response:1; }","duration":"2.511145454s","start":"2026-06-10T10:26:28.568092Z","end":"2026-06-10T10:26:31.079238Z","steps":["trace[458373516] 'process raft request' (duration: 2.510513327s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.079309Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.568076Z","time spent":"2.511203675s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:31.079407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.511249506s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:31.07944Z","caller":"traceutil/trace.go:171","msg":"trace[855751792] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:9556; }","duration":"2.511345499s","start":"2026-06-10T10:26:28.568086Z","end":"2026-06-10T10:26:31.079431Z","steps":["trace[855751792] 'agreement among raft nodes before linearized reading' (duration: 2.511290198s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.079471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.568053Z","time spent":"2.511408871s","remote":"127.0.0.1:56354","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.084039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.375098ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-10T10:26:31.084075Z","caller":"traceutil/trace.go:171","msg":"trace[752100897] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:9565; }","duration":"453.423719ms","start":"2026-06-10T10:26:30.630644Z","end":"2026-06-10T10:26:31.084068Z","steps":["trace[752100897] 'agreement among raft nodes before linearized reading' (duration: 453.264835ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.084094Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.63064Z","time spent":"453.44959ms","remote":"127.0.0.1:42522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":158,"request content":"key:\"/registry/masterleases/199.204.45.242\" "} {"level":"info","ts":"2026-06-10T10:26:31.08422Z","caller":"traceutil/trace.go:171","msg":"trace[2143778468] transaction","detail":"{read_only:false; response_revision:9557; number_of_response:1; }","duration":"454.266683ms","start":"2026-06-10T10:26:30.629945Z","end":"2026-06-10T10:26:31.084212Z","steps":["trace[2143778468] 'process raft request' (duration: 453.611975ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.084261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.629928Z","time spent":"454.306654ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-10T10:26:31.084433Z","caller":"traceutil/trace.go:171","msg":"trace[251953960] transaction","detail":"{read_only:false; response_revision:9558; number_of_response:1; }","duration":"453.906103ms","start":"2026-06-10T10:26:30.63052Z","end":"2026-06-10T10:26:31.084427Z","steps":["trace[251953960] 'process raft request' (duration: 453.199144ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.08447Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.630514Z","time spent":"453.937804ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.084548Z","caller":"traceutil/trace.go:171","msg":"trace[979794621] transaction","detail":"{read_only:false; response_revision:9559; number_of_response:1; }","duration":"453.973944ms","start":"2026-06-10T10:26:30.630569Z","end":"2026-06-10T10:26:31.084543Z","steps":["trace[979794621] 'process raft request' (duration: 453.184773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.084582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.630563Z","time spent":"454.000076ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.084652Z","caller":"traceutil/trace.go:171","msg":"trace[178557451] transaction","detail":"{read_only:false; response_revision:9560; number_of_response:1; }","duration":"453.993285ms","start":"2026-06-10T10:26:30.630651Z","end":"2026-06-10T10:26:31.084644Z","steps":["trace[178557451] 'process raft request' (duration: 453.123951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.084693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.630629Z","time spent":"454.042077ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.084777Z","caller":"traceutil/trace.go:171","msg":"trace[779595481] transaction","detail":"{read_only:false; response_revision:9561; number_of_response:1; }","duration":"454.018356ms","start":"2026-06-10T10:26:30.630752Z","end":"2026-06-10T10:26:31.08477Z","steps":["trace[779595481] 'process raft request' (duration: 453.048369ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.08482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.630742Z","time spent":"454.062728ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:31.084918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.230622ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:31.084936Z","caller":"traceutil/trace.go:171","msg":"trace[1531453842] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9565; }","duration":"454.255652ms","start":"2026-06-10T10:26:30.630677Z","end":"2026-06-10T10:26:31.084932Z","steps":["trace[1531453842] 'agreement among raft nodes before linearized reading' (duration: 454.225741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.084948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.630674Z","time spent":"454.271382ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:26:31.085043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"454.369146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T10:26:31.085029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.524736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-06-10T10:26:31.085092Z","caller":"traceutil/trace.go:171","msg":"trace[1739020149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9565; }","duration":"377.628729ms","start":"2026-06-10T10:26:30.707447Z","end":"2026-06-10T10:26:31.085076Z","steps":["trace[1739020149] 'agreement among raft nodes before linearized reading' (duration: 377.426743ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.085124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.707435Z","time spent":"377.68274ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-06-10T10:26:31.085253Z","caller":"traceutil/trace.go:171","msg":"trace[351417090] transaction","detail":"{read_only:false; response_revision:9562; number_of_response:1; }","duration":"377.139105ms","start":"2026-06-10T10:26:30.708094Z","end":"2026-06-10T10:26:31.085233Z","steps":["trace[351417090] 'process raft request' (duration: 375.726807ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.085324Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.708073Z","time spent":"377.202517ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.085489Z","caller":"traceutil/trace.go:171","msg":"trace[445692487] transaction","detail":"{read_only:false; response_revision:9563; number_of_response:1; }","duration":"377.369242ms","start":"2026-06-10T10:26:30.708112Z","end":"2026-06-10T10:26:31.085481Z","steps":["trace[445692487] 'process raft request' (duration: 375.729407ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.085537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.708095Z","time spent":"377.417353ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.085633Z","caller":"traceutil/trace.go:171","msg":"trace[1209125269] transaction","detail":"{read_only:false; response_revision:9564; number_of_response:1; }","duration":"376.859348ms","start":"2026-06-10T10:26:30.708765Z","end":"2026-06-10T10:26:31.085625Z","steps":["trace[1209125269] 'process raft request' (duration: 375.09613ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.085673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.70876Z","time spent":"376.890769ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.085057Z","caller":"traceutil/trace.go:171","msg":"trace[640649015] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:9565; }","duration":"454.390856ms","start":"2026-06-10T10:26:30.630663Z","end":"2026-06-10T10:26:31.085053Z","steps":["trace[640649015] 'agreement among raft nodes before linearized reading' (duration: 454.360826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.086582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.63066Z","time spent":"455.911738ms","remote":"127.0.0.1:42984","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":10,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.086669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.940154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:289856"} {"level":"info","ts":"2026-06-10T10:26:31.086691Z","caller":"traceutil/trace.go:171","msg":"trace[1441242962] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9565; }","duration":"378.971866ms","start":"2026-06-10T10:26:30.707714Z","end":"2026-06-10T10:26:31.086686Z","steps":["trace[1441242962] 'agreement among raft nodes before linearized reading' (duration: 378.691038ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.086707Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.707711Z","time spent":"378.991327ms","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":31,"response size":289879,"request content":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" "} {"level":"warn","ts":"2026-06-10T10:26:31.086731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.026447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-06-10T10:26:31.086752Z","caller":"traceutil/trace.go:171","msg":"trace[1059082503] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9565; }","duration":"379.074469ms","start":"2026-06-10T10:26:30.70767Z","end":"2026-06-10T10:26:31.086745Z","steps":["trace[1059082503] 'agreement among raft nodes before linearized reading' (duration: 379.008097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.086765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.707655Z","time spent":"379.106619ms","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12239,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-10T10:26:31.086827Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.318115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-10T10:26:31.086838Z","caller":"traceutil/trace.go:171","msg":"trace[1989314623] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9565; }","duration":"379.339186ms","start":"2026-06-10T10:26:30.707495Z","end":"2026-06-10T10:26:31.086834Z","steps":["trace[1989314623] 'agreement among raft nodes before linearized reading' (duration: 379.304945ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.086853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.707491Z","time spent":"379.358837ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-10T10:26:43.198023Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T10:26:43.202939Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-10T10:26:43.203035Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-10T10:28:25.844322Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":7945} {"level":"info","ts":"2026-06-10T10:28:25.904363Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":7945,"took":"58.010642ms","hash":4040757514,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":28798976,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-10T10:28:25.904419Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4040757514,"revision":7945,"compact-revision":5764} {"level":"info","ts":"2026-06-10T10:32:08.717745Z","caller":"traceutil/trace.go:171","msg":"trace[308481620] transaction","detail":"{read_only:false; response_revision:11989; number_of_response:1; }","duration":"346.182172ms","start":"2026-06-10T10:32:08.37152Z","end":"2026-06-10T10:32:08.717702Z","steps":["trace[308481620] 'process raft request' (duration: 340.586791ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:32:08.717778Z","caller":"traceutil/trace.go:171","msg":"trace[1776135711] transaction","detail":"{read_only:false; response_revision:11990; number_of_response:1; }","duration":"345.868134ms","start":"2026-06-10T10:32:08.371884Z","end":"2026-06-10T10:32:08.717752Z","steps":["trace[1776135711] 'process raft request' (duration: 345.722121ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:08.718755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:08.371497Z","time spent":"347.106376ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:32:08.71809Z","caller":"traceutil/trace.go:171","msg":"trace[70812452] transaction","detail":"{read_only:false; response_revision:11991; number_of_response:1; }","duration":"345.139176ms","start":"2026-06-10T10:32:08.372925Z","end":"2026-06-10T10:32:08.718064Z","steps":["trace[70812452] 'process raft request' (duration: 344.786067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:08.718898Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:08.371858Z","time spent":"346.87563ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:32:08.719025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:08.372913Z","time spent":"346.003718ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:32:08.718174Z","caller":"traceutil/trace.go:171","msg":"trace[1175647319] transaction","detail":"{read_only:false; response_revision:11992; number_of_response:1; }","duration":"332.805265ms","start":"2026-06-10T10:32:08.385339Z","end":"2026-06-10T10:32:08.718144Z","steps":["trace[1175647319] 'process raft request' (duration: 332.663682ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:32:08.719179Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:32:08.385322Z","time spent":"333.81414ms","remote":"127.0.0.1:42674","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":19159,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:33:25.84974Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10380} {"level":"info","ts":"2026-06-10T10:33:25.930653Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10380,"took":"78.364191ms","hash":76275180,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":25722880,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-10T10:33:25.930706Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":76275180,"revision":10380,"compact-revision":7945} {"level":"info","ts":"2026-06-10T10:38:25.854399Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12506} {"level":"info","ts":"2026-06-10T10:38:25.927862Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12506,"took":"71.36736ms","hash":2068896657,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":27062272,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-10T10:38:25.92794Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2068896657,"revision":12506,"compact-revision":10380} {"level":"info","ts":"2026-06-10T10:39:00.909165Z","caller":"traceutil/trace.go:171","msg":"trace[1887801028] transaction","detail":"{read_only:false; response_revision:14921; number_of_response:1; }","duration":"107.760174ms","start":"2026-06-10T10:39:00.801363Z","end":"2026-06-10T10:39:00.909123Z","steps":["trace[1887801028] 'process raft request' (duration: 107.418514ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:25.861651Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14529} {"level":"info","ts":"2026-06-10T10:43:25.937393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14529,"took":"73.36719ms","hash":3324433498,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":34033664,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T10:43:25.937473Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3324433498,"revision":14529,"compact-revision":12506} {"level":"info","ts":"2026-06-10T10:46:08.62843Z","caller":"traceutil/trace.go:171","msg":"trace[1480116899] transaction","detail":"{read_only:false; response_revision:18264; number_of_response:1; }","duration":"103.08211ms","start":"2026-06-10T10:46:08.525314Z","end":"2026-06-10T10:46:08.628396Z","steps":["trace[1480116899] 'process raft request' (duration: 102.939046ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:46:15.312794Z","caller":"traceutil/trace.go:171","msg":"trace[844965474] transaction","detail":"{read_only:false; response_revision:18310; number_of_response:1; }","duration":"277.168608ms","start":"2026-06-10T10:46:15.035608Z","end":"2026-06-10T10:46:15.312776Z","steps":["trace[844965474] 'process raft request' (duration: 277.000973ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:46:15.355958Z","caller":"traceutil/trace.go:171","msg":"trace[1544625008] linearizableReadLoop","detail":"{readStateIndex:18947; appliedIndex:18945; }","duration":"316.751758ms","start":"2026-06-10T10:46:15.039183Z","end":"2026-06-10T10:46:15.355935Z","steps":["trace[1544625008] 'read index received' (duration: 273.422744ms)","trace[1544625008] 'applied index is now lower than readState.Index' (duration: 43.328004ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:46:15.355992Z","caller":"traceutil/trace.go:171","msg":"trace[365503840] transaction","detail":"{read_only:false; response_revision:18311; number_of_response:1; }","duration":"319.780552ms","start":"2026-06-10T10:46:15.036184Z","end":"2026-06-10T10:46:15.355964Z","steps":["trace[365503840] 'process raft request' (duration: 319.630177ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:46:15.356227Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:46:15.036164Z","time spent":"320.002127ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":489,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:46:15.356331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.079687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-10T10:46:15.356382Z","caller":"traceutil/trace.go:171","msg":"trace[1880608459] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:18311; }","duration":"317.199091ms","start":"2026-06-10T10:46:15.039168Z","end":"2026-06-10T10:46:15.356367Z","steps":["trace[1880608459] 'agreement among raft nodes before linearized reading' (duration: 316.878832ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:46:15.356421Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:46:15.03916Z","time spent":"317.250892ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T10:46:15.621599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.224098ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:46:15.621954Z","caller":"traceutil/trace.go:171","msg":"trace[1549983039] transaction","detail":"{read_only:false; response_revision:18312; number_of_response:1; }","duration":"300.832739ms","start":"2026-06-10T10:46:15.32108Z","end":"2026-06-10T10:46:15.621913Z","steps":["trace[1549983039] 'process raft request' (duration: 136.517501ms)","trace[1549983039] 'compare' (duration: 162.995402ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:46:15.622117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:46:15.321056Z","time spent":"300.980224ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:46:15.622121Z","caller":"traceutil/trace.go:171","msg":"trace[386148035] linearizableReadLoop","detail":"{readStateIndex:18948; appliedIndex:18947; }","duration":"266.076012ms","start":"2026-06-10T10:46:15.356024Z","end":"2026-06-10T10:46:15.6221Z","steps":["trace[386148035] 'read index received' (duration: 101.712253ms)","trace[386148035] 'applied index is now lower than readState.Index' (duration: 164.360499ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:46:15.622248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.802946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-9tps7\" ","response":"range_response_count:1 size:20778"} {"level":"info","ts":"2026-06-10T10:46:15.622334Z","caller":"traceutil/trace.go:171","msg":"trace[543633913] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-9tps7; range_end:; response_count:1; response_revision:18312; }","duration":"285.932199ms","start":"2026-06-10T10:46:15.33638Z","end":"2026-06-10T10:46:15.622312Z","steps":["trace[543633913] 'agreement among raft nodes before linearized reading' (duration: 285.755964ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:46:15.622346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.791735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T10:46:15.622426Z","caller":"traceutil/trace.go:171","msg":"trace[915627735] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:18312; }","duration":"387.911869ms","start":"2026-06-10T10:46:15.234496Z","end":"2026-06-10T10:46:15.622408Z","steps":["trace[915627735] 'agreement among raft nodes before linearized reading' (duration: 387.671472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:46:15.622472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:46:15.23448Z","time spent":"387.982951ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T10:46:15.622889Z","caller":"traceutil/trace.go:171","msg":"trace[1901935044] transaction","detail":"{read_only:false; response_revision:18313; number_of_response:1; }","duration":"261.449295ms","start":"2026-06-10T10:46:15.361425Z","end":"2026-06-10T10:46:15.622875Z","steps":["trace[1901935044] 'process raft request' (duration: 260.91902ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:46:15.622985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"540.240816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-10T10:46:15.623161Z","caller":"traceutil/trace.go:171","msg":"trace[1403805786] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18312; }","duration":"540.445922ms","start":"2026-06-10T10:46:15.082688Z","end":"2026-06-10T10:46:15.623134Z","steps":["trace[1403805786] 'agreement among raft nodes before linearized reading' (duration: 539.544487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:46:15.623253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:46:15.08266Z","time spent":"540.565925ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T10:46:15.867872Z","caller":"traceutil/trace.go:171","msg":"trace[533760443] linearizableReadLoop","detail":"{readStateIndex:18952; appliedIndex:18951; }","duration":"170.673233ms","start":"2026-06-10T10:46:15.697177Z","end":"2026-06-10T10:46:15.86785Z","steps":["trace[533760443] 'read index received' (duration: 170.530519ms)","trace[533760443] 'applied index is now lower than readState.Index' (duration: 141.694µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:46:15.867976Z","caller":"traceutil/trace.go:171","msg":"trace[1651615598] transaction","detail":"{read_only:false; response_revision:18316; number_of_response:1; }","duration":"225.884085ms","start":"2026-06-10T10:46:15.642032Z","end":"2026-06-10T10:46:15.867916Z","steps":["trace[1651615598] 'process raft request' (duration: 225.677209ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:46:15.868202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.997971ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-5xm6f\" ","response":"range_response_count:1 size:9710"} {"level":"info","ts":"2026-06-10T10:46:15.868266Z","caller":"traceutil/trace.go:171","msg":"trace[446182876] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-5xm6f; range_end:; response_count:1; response_revision:18316; }","duration":"171.128185ms","start":"2026-06-10T10:46:15.697125Z","end":"2026-06-10T10:46:15.868253Z","steps":["trace[446182876] 'agreement among raft nodes before linearized reading' (duration: 170.823696ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:46:15.895537Z","caller":"traceutil/trace.go:171","msg":"trace[431047537] transaction","detail":"{read_only:false; response_revision:18317; number_of_response:1; }","duration":"155.031672ms","start":"2026-06-10T10:46:15.740468Z","end":"2026-06-10T10:46:15.895499Z","steps":["trace[431047537] 'process raft request' (duration: 154.669122ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:46:15.895956Z","caller":"traceutil/trace.go:171","msg":"trace[710752964] transaction","detail":"{read_only:false; response_revision:18319; number_of_response:1; }","duration":"132.387498ms","start":"2026-06-10T10:46:15.76353Z","end":"2026-06-10T10:46:15.895917Z","steps":["trace[710752964] 'process raft request' (duration: 131.789292ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:46:15.895993Z","caller":"traceutil/trace.go:171","msg":"trace[1390616172] transaction","detail":"{read_only:false; response_revision:18318; number_of_response:1; }","duration":"155.007371ms","start":"2026-06-10T10:46:15.740954Z","end":"2026-06-10T10:46:15.895962Z","steps":["trace[1390616172] 'process raft request' (duration: 154.311392ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:47:57.160508Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T10:47:57.16619Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-10T10:47:57.166295Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-10T10:48:25.868524Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17207} {"level":"info","ts":"2026-06-10T10:48:25.976059Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17207,"took":"104.736767ms","hash":4123207049,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":34447360,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-10T10:48:25.97612Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4123207049,"revision":17207,"compact-revision":14529} {"level":"info","ts":"2026-06-10T10:52:19.211021Z","caller":"traceutil/trace.go:171","msg":"trace[1874428099] linearizableReadLoop","detail":"{readStateIndex:21814; appliedIndex:21813; }","duration":"129.137069ms","start":"2026-06-10T10:52:19.081856Z","end":"2026-06-10T10:52:19.210993Z","steps":["trace[1874428099] 'read index received' (duration: 128.975925ms)","trace[1874428099] 'applied index is now lower than readState.Index' (duration: 160.184µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:52:19.211108Z","caller":"traceutil/trace.go:171","msg":"trace[464780459] transaction","detail":"{read_only:false; response_revision:21087; number_of_response:1; }","duration":"299.611907ms","start":"2026-06-10T10:52:18.911453Z","end":"2026-06-10T10:52:19.211065Z","steps":["trace[464780459] 'process raft request' (duration: 299.35142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:52:19.211219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.344625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T10:52:19.211262Z","caller":"traceutil/trace.go:171","msg":"trace[1591302790] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:21087; }","duration":"129.429107ms","start":"2026-06-10T10:52:19.081821Z","end":"2026-06-10T10:52:19.211251Z","steps":["trace[1591302790] 'agreement among raft nodes before linearized reading' (duration: 129.293164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:52:19.485665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.791666ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:52:19.485932Z","caller":"traceutil/trace.go:171","msg":"trace[1481823975] transaction","detail":"{read_only:false; response_revision:21091; number_of_response:1; }","duration":"167.978459ms","start":"2026-06-10T10:52:19.317939Z","end":"2026-06-10T10:52:19.485917Z","steps":["trace[1481823975] 'process raft request' (duration: 167.940258ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:52:19.485938Z","caller":"traceutil/trace.go:171","msg":"trace[174400927] transaction","detail":"{read_only:false; response_revision:21089; number_of_response:1; }","duration":"297.780877ms","start":"2026-06-10T10:52:19.188135Z","end":"2026-06-10T10:52:19.485916Z","steps":["trace[174400927] 'process raft request' (duration: 297.641073ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:52:19.486035Z","caller":"traceutil/trace.go:171","msg":"trace[1467781585] linearizableReadLoop","detail":"{readStateIndex:21816; appliedIndex:21814; }","duration":"274.932937ms","start":"2026-06-10T10:52:19.211093Z","end":"2026-06-10T10:52:19.486025Z","steps":["trace[1467781585] 'read index received' (duration: 115.638037ms)","trace[1467781585] 'applied index is now lower than readState.Index' (duration: 159.29384ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:52:19.486176Z","caller":"traceutil/trace.go:171","msg":"trace[789240424] transaction","detail":"{read_only:false; response_revision:21088; number_of_response:1; }","duration":"302.095646ms","start":"2026-06-10T10:52:19.184069Z","end":"2026-06-10T10:52:19.486165Z","steps":["trace[789240424] 'process raft request' (duration: 142.725784ms)","trace[789240424] 'compare' (duration: 158.682563ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:52:19.486231Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.972176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-10T10:52:19.486262Z","caller":"traceutil/trace.go:171","msg":"trace[1667842943] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21091; }","duration":"403.068789ms","start":"2026-06-10T10:52:19.083185Z","end":"2026-06-10T10:52:19.486254Z","steps":["trace[1667842943] 'agreement among raft nodes before linearized reading' (duration: 402.908844ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:52:19.486277Z","caller":"traceutil/trace.go:171","msg":"trace[1044831506] transaction","detail":"{read_only:false; response_revision:21090; number_of_response:1; }","duration":"270.896586ms","start":"2026-06-10T10:52:19.215362Z","end":"2026-06-10T10:52:19.486258Z","steps":["trace[1044831506] 'process raft request' (duration: 270.487244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:52:19.486312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:52:19.083159Z","time spent":"403.12517ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:52:19.48629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:52:19.184049Z","time spent":"302.155497ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:52:19.486215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.905895ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-10T10:52:19.4864Z","caller":"traceutil/trace.go:171","msg":"trace[29889046] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:21091; }","duration":"370.133751ms","start":"2026-06-10T10:52:19.116258Z","end":"2026-06-10T10:52:19.486392Z","steps":["trace[29889046] 'agreement among raft nodes before linearized reading' (duration: 369.833263ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:52:19.486426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:52:19.116233Z","time spent":"370.185703ms","remote":"127.0.0.1:42522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.242\" "} {"level":"info","ts":"2026-06-10T10:53:25.875005Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19527} {"level":"info","ts":"2026-06-10T10:53:25.991303Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19527,"took":"112.803649ms","hash":975718311,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":28655616,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-06-10T10:53:25.991363Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":975718311,"revision":19527,"compact-revision":17207} {"level":"warn","ts":"2026-06-10T10:56:08.832193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.04739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T10:56:08.832276Z","caller":"traceutil/trace.go:171","msg":"trace[1036161109] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:23520; }","duration":"100.140622ms","start":"2026-06-10T10:56:08.732118Z","end":"2026-06-10T10:56:08.832258Z","steps":["trace[1036161109] 'range keys from in-memory index tree' (duration: 99.880625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:08.832909Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.46366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:56:08.833009Z","caller":"traceutil/trace.go:171","msg":"trace[828512601] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:23520; }","duration":"100.590414ms","start":"2026-06-10T10:56:08.732393Z","end":"2026-06-10T10:56:08.832984Z","steps":["trace[828512601] 'range keys from in-memory index tree' (duration: 100.313866ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:09.129149Z","caller":"traceutil/trace.go:171","msg":"trace[1482087380] transaction","detail":"{read_only:false; response_revision:23521; number_of_response:1; }","duration":"291.725955ms","start":"2026-06-10T10:56:08.837383Z","end":"2026-06-10T10:56:09.129109Z","steps":["trace[1482087380] 'process raft request' (duration: 291.52655ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:09.268406Z","caller":"traceutil/trace.go:171","msg":"trace[425421668] linearizableReadLoop","detail":"{readStateIndex:24326; appliedIndex:24321; }","duration":"138.740857ms","start":"2026-06-10T10:56:09.129643Z","end":"2026-06-10T10:56:09.268384Z","steps":["trace[425421668] 'read index received' (duration: 138.459179ms)","trace[425421668] 'applied index is now lower than readState.Index' (duration: 280.658µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:09.268817Z","caller":"traceutil/trace.go:171","msg":"trace[583062431] transaction","detail":"{read_only:false; response_revision:23523; number_of_response:1; }","duration":"424.59245ms","start":"2026-06-10T10:56:08.844207Z","end":"2026-06-10T10:56:09.268799Z","steps":["trace[583062431] 'process raft request' (duration: 423.976273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:09.268953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.265211ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-10T10:56:09.269413Z","caller":"traceutil/trace.go:171","msg":"trace[655071884] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:23526; }","duration":"139.762215ms","start":"2026-06-10T10:56:09.129628Z","end":"2026-06-10T10:56:09.269391Z","steps":["trace[655071884] 'agreement among raft nodes before linearized reading' (duration: 139.002564ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:09.268993Z","caller":"traceutil/trace.go:171","msg":"trace[1445421062] transaction","detail":"{read_only:false; response_revision:23527; number_of_response:1; }","duration":"134.822338ms","start":"2026-06-10T10:56:09.134145Z","end":"2026-06-10T10:56:09.268968Z","steps":["trace[1445421062] 'process raft request' (duration: 134.653453ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:09.269073Z","caller":"traceutil/trace.go:171","msg":"trace[2079876600] transaction","detail":"{read_only:false; response_revision:23522; number_of_response:1; }","duration":"431.400899ms","start":"2026-06-10T10:56:08.837662Z","end":"2026-06-10T10:56:09.269063Z","steps":["trace[2079876600] 'process raft request' (duration: 430.3592ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:09.26912Z","caller":"traceutil/trace.go:171","msg":"trace[2089496482] transaction","detail":"{read_only:false; response_revision:23525; number_of_response:1; }","duration":"257.125262ms","start":"2026-06-10T10:56:09.011986Z","end":"2026-06-10T10:56:09.269111Z","steps":["trace[2089496482] 'process raft request' (duration: 256.292139ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:09.269099Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:08.844187Z","time spent":"424.835507ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:09.26915Z","caller":"traceutil/trace.go:171","msg":"trace[1753888564] transaction","detail":"{read_only:false; response_revision:23524; number_of_response:1; }","duration":"423.751788ms","start":"2026-06-10T10:56:08.845391Z","end":"2026-06-10T10:56:09.269143Z","steps":["trace[1753888564] 'process raft request' (duration: 422.856983ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:09.269167Z","caller":"traceutil/trace.go:171","msg":"trace[1129844966] transaction","detail":"{read_only:false; response_revision:23526; number_of_response:1; }","duration":"148.958158ms","start":"2026-06-10T10:56:09.120193Z","end":"2026-06-10T10:56:09.269151Z","steps":["trace[1129844966] 'process raft request' (duration: 148.126575ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:09.27178Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:08.845379Z","time spent":"426.327999ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:09.272224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:08.837643Z","time spent":"433.468795ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:27.746116Z","caller":"traceutil/trace.go:171","msg":"trace[2108040300] transaction","detail":"{read_only:false; response_revision:23701; number_of_response:1; }","duration":"106.324014ms","start":"2026-06-10T10:56:27.639778Z","end":"2026-06-10T10:56:27.746102Z","steps":["trace[2108040300] 'process raft request' (duration: 105.933853ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:27.746375Z","caller":"traceutil/trace.go:171","msg":"trace[2017117837] transaction","detail":"{read_only:false; response_revision:23702; number_of_response:1; }","duration":"102.354126ms","start":"2026-06-10T10:56:27.64401Z","end":"2026-06-10T10:56:27.746364Z","steps":["trace[2017117837] 'process raft request' (duration: 101.769009ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:58:25.882868Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21724} {"level":"info","ts":"2026-06-10T10:58:25.98772Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21724,"took":"101.6715ms","hash":2204391477,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":42774528,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-06-10T10:58:25.987778Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2204391477,"revision":21724,"compact-revision":19527} {"level":"info","ts":"2026-06-10T10:59:31.035581Z","caller":"traceutil/trace.go:171","msg":"trace[1213966999] transaction","detail":"{read_only:false; response_revision:25560; number_of_response:1; }","duration":"146.259748ms","start":"2026-06-10T10:59:30.889291Z","end":"2026-06-10T10:59:31.035551Z","steps":["trace[1213966999] 'process raft request' (duration: 145.860287ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:31.238041Z","caller":"traceutil/trace.go:171","msg":"trace[820880504] transaction","detail":"{read_only:false; response_revision:25561; number_of_response:1; }","duration":"106.660084ms","start":"2026-06-10T10:59:31.131252Z","end":"2026-06-10T10:59:31.237912Z","steps":["trace[820880504] 'process raft request' (duration: 106.457469ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:31.272405Z","caller":"traceutil/trace.go:171","msg":"trace[1345256530] transaction","detail":"{read_only:false; response_revision:25562; number_of_response:1; }","duration":"119.587692ms","start":"2026-06-10T10:59:31.152785Z","end":"2026-06-10T10:59:31.272372Z","steps":["trace[1345256530] 'process raft request' (duration: 119.407097ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:31.27259Z","caller":"traceutil/trace.go:171","msg":"trace[1359981056] transaction","detail":"{read_only:false; response_revision:25564; number_of_response:1; }","duration":"110.238173ms","start":"2026-06-10T10:59:31.162334Z","end":"2026-06-10T10:59:31.272572Z","steps":["trace[1359981056] 'process raft request' (duration: 110.175291ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:31.272756Z","caller":"traceutil/trace.go:171","msg":"trace[1255388376] transaction","detail":"{read_only:false; response_revision:25563; number_of_response:1; }","duration":"115.602091ms","start":"2026-06-10T10:59:31.157144Z","end":"2026-06-10T10:59:31.272746Z","steps":["trace[1255388376] 'process raft request' (duration: 115.175909ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:31.71779Z","caller":"traceutil/trace.go:171","msg":"trace[303154924] linearizableReadLoop","detail":"{readStateIndex:26417; appliedIndex:26416; }","duration":"122.77074ms","start":"2026-06-10T10:59:31.594994Z","end":"2026-06-10T10:59:31.717765Z","steps":["trace[303154924] 'read index received' (duration: 122.593505ms)","trace[303154924] 'applied index is now lower than readState.Index' (duration: 176.565µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:31.717907Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.899953ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/services/\" range_end:\"/registry/openstack.k-orc.cloud/services0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:31.717909Z","caller":"traceutil/trace.go:171","msg":"trace[594628549] transaction","detail":"{read_only:false; response_revision:25565; number_of_response:1; }","duration":"129.383262ms","start":"2026-06-10T10:59:31.588495Z","end":"2026-06-10T10:59:31.717879Z","steps":["trace[594628549] 'process raft request' (duration: 129.151376ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:31.717978Z","caller":"traceutil/trace.go:171","msg":"trace[1021217647] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/services/; range_end:/registry/openstack.k-orc.cloud/services0; response_count:0; response_revision:25565; }","duration":"122.970945ms","start":"2026-06-10T10:59:31.594953Z","end":"2026-06-10T10:59:31.717924Z","steps":["trace[1021217647] 'agreement among raft nodes before linearized reading' (duration: 122.899923ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:32.078094Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.968929ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:32.078239Z","caller":"traceutil/trace.go:171","msg":"trace[681936328] linearizableReadLoop","detail":"{readStateIndex:26418; appliedIndex:26417; }","duration":"175.798294ms","start":"2026-06-10T10:59:31.902419Z","end":"2026-06-10T10:59:32.078217Z","steps":["trace[681936328] 'read index received' (duration: 4.609848ms)","trace[681936328] 'applied index is now lower than readState.Index' (duration: 171.186306ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:32.078274Z","caller":"traceutil/trace.go:171","msg":"trace[1889080444] transaction","detail":"{read_only:false; response_revision:25566; number_of_response:1; }","duration":"345.954771ms","start":"2026-06-10T10:59:31.73229Z","end":"2026-06-10T10:59:32.078245Z","steps":["trace[1889080444] 'process raft request' (duration: 174.728504ms)","trace[1889080444] 'compare' (duration: 170.453705ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:32.078409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:31.732261Z","time spent":"346.073194ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:59:32.078648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.226985ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:32.078702Z","caller":"traceutil/trace.go:171","msg":"trace[396618520] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25566; }","duration":"176.317528ms","start":"2026-06-10T10:59:31.902367Z","end":"2026-06-10T10:59:32.078684Z","steps":["trace[396618520] 'agreement among raft nodes before linearized reading' (duration: 175.910996ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:32.34174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.721609ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:32.341984Z","caller":"traceutil/trace.go:171","msg":"trace[784615452] linearizableReadLoop","detail":"{readStateIndex:26419; appliedIndex:26418; }","duration":"167.437122ms","start":"2026-06-10T10:59:32.174529Z","end":"2026-06-10T10:59:32.341966Z","steps":["trace[784615452] 'read index received' (duration: 36.449446ms)","trace[784615452] 'applied index is now lower than readState.Index' (duration: 130.986006ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:32.342237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.854234ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:59:32.34227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.71723ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-10T10:59:32.342385Z","caller":"traceutil/trace.go:171","msg":"trace[586042044] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:25567; }","duration":"164.011578ms","start":"2026-06-10T10:59:32.178314Z","end":"2026-06-10T10:59:32.342326Z","steps":["trace[586042044] 'agreement among raft nodes before linearized reading' (duration: 163.817113ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:32.342464Z","caller":"traceutil/trace.go:171","msg":"trace[1566558882] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25567; }","duration":"167.908525ms","start":"2026-06-10T10:59:32.174486Z","end":"2026-06-10T10:59:32.342394Z","steps":["trace[1566558882] 'agreement among raft nodes before linearized reading' (duration: 167.556705ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:32.342672Z","caller":"traceutil/trace.go:171","msg":"trace[996206514] transaction","detail":"{read_only:false; response_revision:25567; number_of_response:1; }","duration":"245.612341ms","start":"2026-06-10T10:59:32.096383Z","end":"2026-06-10T10:59:32.341995Z","steps":["trace[996206514] 'process raft request' (duration: 114.533302ms)","trace[996206514] 'compare' (duration: 130.582386ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:32.632179Z","caller":"traceutil/trace.go:171","msg":"trace[1269317181] linearizableReadLoop","detail":"{readStateIndex:26423; appliedIndex:26422; }","duration":"184.963157ms","start":"2026-06-10T10:59:32.447192Z","end":"2026-06-10T10:59:32.632155Z","steps":["trace[1269317181] 'read index received' (duration: 184.795912ms)","trace[1269317181] 'applied index is now lower than readState.Index' (duration: 164.455µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:32.632296Z","caller":"traceutil/trace.go:171","msg":"trace[1171900161] transaction","detail":"{read_only:false; response_revision:25571; number_of_response:1; }","duration":"242.488634ms","start":"2026-06-10T10:59:32.389716Z","end":"2026-06-10T10:59:32.632204Z","steps":["trace[1171900161] 'process raft request' (duration: 242.309959ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:32.632456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.247814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T10:59:32.632517Z","caller":"traceutil/trace.go:171","msg":"trace[1103785822] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25571; }","duration":"185.346247ms","start":"2026-06-10T10:59:32.447152Z","end":"2026-06-10T10:59:32.632498Z","steps":["trace[1103785822] 'agreement among raft nodes before linearized reading' (duration: 185.145972ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:32.632877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.528503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"info","ts":"2026-06-10T10:59:32.632997Z","caller":"traceutil/trace.go:171","msg":"trace[1799817138] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25571; }","duration":"168.919893ms","start":"2026-06-10T10:59:32.464048Z","end":"2026-06-10T10:59:32.632968Z","steps":["trace[1799817138] 'agreement among raft nodes before linearized reading' (duration: 168.350867ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:38.653659Z","caller":"traceutil/trace.go:171","msg":"trace[1553304004] linearizableReadLoop","detail":"{readStateIndex:26466; appliedIndex:26465; }","duration":"272.878934ms","start":"2026-06-10T10:59:38.380755Z","end":"2026-06-10T10:59:38.653634Z","steps":["trace[1553304004] 'read index received' (duration: 272.714309ms)","trace[1553304004] 'applied index is now lower than readState.Index' (duration: 163.495µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:38.653792Z","caller":"traceutil/trace.go:171","msg":"trace[599968094] transaction","detail":"{read_only:false; response_revision:25612; number_of_response:1; }","duration":"288.072303ms","start":"2026-06-10T10:59:38.365678Z","end":"2026-06-10T10:59:38.65375Z","steps":["trace[599968094] 'process raft request' (duration: 287.799705ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:38.653869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.316425ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T10:59:38.653898Z","caller":"traceutil/trace.go:171","msg":"trace[1297895936] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25612; }","duration":"231.403869ms","start":"2026-06-10T10:59:38.422485Z","end":"2026-06-10T10:59:38.653889Z","steps":["trace[1297895936] 'agreement among raft nodes before linearized reading' (duration: 231.283285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:38.653919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.152371ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-10T10:59:38.653966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.197582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:59:38.654041Z","caller":"traceutil/trace.go:171","msg":"trace[2134745946] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25612; }","duration":"223.306514ms","start":"2026-06-10T10:59:38.430717Z","end":"2026-06-10T10:59:38.654023Z","steps":["trace[2134745946] 'agreement among raft nodes before linearized reading' (duration: 223.089078ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:38.653991Z","caller":"traceutil/trace.go:171","msg":"trace[1204922424] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25612; }","duration":"273.294555ms","start":"2026-06-10T10:59:38.380678Z","end":"2026-06-10T10:59:38.653972Z","steps":["trace[1204922424] 'agreement among raft nodes before linearized reading' (duration: 273.084359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:38.939401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.701436ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:38.939619Z","caller":"traceutil/trace.go:171","msg":"trace[1061560863] linearizableReadLoop","detail":"{readStateIndex:26470; appliedIndex:26466; }","duration":"225.376022ms","start":"2026-06-10T10:59:38.714225Z","end":"2026-06-10T10:59:38.939602Z","steps":["trace[1061560863] 'read index received' (duration: 89.514102ms)","trace[1061560863] 'applied index is now lower than readState.Index' (duration: 135.86093ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:38.939667Z","caller":"traceutil/trace.go:171","msg":"trace[902009432] transaction","detail":"{read_only:false; response_revision:25614; number_of_response:1; }","duration":"280.135603ms","start":"2026-06-10T10:59:38.659491Z","end":"2026-06-10T10:59:38.939627Z","steps":["trace[902009432] 'process raft request' (duration: 279.995219ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:38.939704Z","caller":"traceutil/trace.go:171","msg":"trace[1547904109] transaction","detail":"{read_only:false; response_revision:25615; number_of_response:1; }","duration":"277.999705ms","start":"2026-06-10T10:59:38.661695Z","end":"2026-06-10T10:59:38.939695Z","steps":["trace[1547904109] 'process raft request' (duration: 277.841911ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:38.939984Z","caller":"traceutil/trace.go:171","msg":"trace[1526833215] transaction","detail":"{read_only:false; response_revision:25613; number_of_response:1; }","duration":"280.864493ms","start":"2026-06-10T10:59:38.6591Z","end":"2026-06-10T10:59:38.939965Z","steps":["trace[1526833215] 'process raft request' (duration: 144.510509ms)","trace[1526833215] 'compare' (duration: 135.621804ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:38.94009Z","caller":"traceutil/trace.go:171","msg":"trace[1079258968] transaction","detail":"{read_only:false; response_revision:25616; number_of_response:1; }","duration":"276.614897ms","start":"2026-06-10T10:59:38.663466Z","end":"2026-06-10T10:59:38.940081Z","steps":["trace[1079258968] 'process raft request' (duration: 276.107903ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:38.940241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.01773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T10:59:38.940277Z","caller":"traceutil/trace.go:171","msg":"trace[1222553680] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25616; }","duration":"226.082142ms","start":"2026-06-10T10:59:38.714183Z","end":"2026-06-10T10:59:38.940265Z","steps":["trace[1222553680] 'agreement among raft nodes before linearized reading' (duration: 225.964738ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:39.23249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.432157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:39.232639Z","caller":"traceutil/trace.go:171","msg":"trace[1922406705] transaction","detail":"{read_only:false; response_revision:25617; number_of_response:1; }","duration":"286.488239ms","start":"2026-06-10T10:59:38.9461Z","end":"2026-06-10T10:59:39.232588Z","steps":["trace[1922406705] 'process raft request' (duration: 149.867927ms)","trace[1922406705] 'compare' (duration: 136.252562ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:39.265333Z","caller":"traceutil/trace.go:171","msg":"trace[621606076] linearizableReadLoop","detail":"{readStateIndex:26473; appliedIndex:26471; }","duration":"119.489448ms","start":"2026-06-10T10:59:39.145823Z","end":"2026-06-10T10:59:39.265313Z","steps":["trace[621606076] 'read index received' (duration: 119.286303ms)","trace[621606076] 'applied index is now lower than readState.Index' (duration: 202.305µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:39.265442Z","caller":"traceutil/trace.go:171","msg":"trace[681265324] transaction","detail":"{read_only:false; response_revision:25618; number_of_response:1; }","duration":"298.066099ms","start":"2026-06-10T10:59:38.967333Z","end":"2026-06-10T10:59:39.265399Z","steps":["trace[681265324] 'process raft request' (duration: 297.789421ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:39.265656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.701345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:140"} {"level":"info","ts":"2026-06-10T10:59:39.265707Z","caller":"traceutil/trace.go:171","msg":"trace[1952433627] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:25619; }","duration":"119.919461ms","start":"2026-06-10T10:59:39.145775Z","end":"2026-06-10T10:59:39.265695Z","steps":["trace[1952433627] 'agreement among raft nodes before linearized reading' (duration: 119.629403ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:39.26567Z","caller":"traceutil/trace.go:171","msg":"trace[1017037122] transaction","detail":"{read_only:false; response_revision:25619; number_of_response:1; }","duration":"193.995406ms","start":"2026-06-10T10:59:39.071617Z","end":"2026-06-10T10:59:39.265612Z","steps":["trace[1017037122] 'process raft request' (duration: 193.644226ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:39.396278Z","caller":"traceutil/trace.go:171","msg":"trace[2063653681] transaction","detail":"{read_only:false; response_revision:25620; number_of_response:1; }","duration":"133.826364ms","start":"2026-06-10T10:59:39.262423Z","end":"2026-06-10T10:59:39.396249Z","steps":["trace[2063653681] 'process raft request' (duration: 112.492295ms)","trace[2063653681] 'compare' (duration: 21.179625ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:39.552256Z","caller":"traceutil/trace.go:171","msg":"trace[2044355352] transaction","detail":"{read_only:false; response_revision:25621; number_of_response:1; }","duration":"253.132609ms","start":"2026-06-10T10:59:39.299103Z","end":"2026-06-10T10:59:39.552235Z","steps":["trace[2044355352] 'process raft request' (duration: 252.973754ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:39.552563Z","caller":"traceutil/trace.go:171","msg":"trace[2028627160] transaction","detail":"{read_only:false; response_revision:25622; number_of_response:1; }","duration":"251.999677ms","start":"2026-06-10T10:59:39.300551Z","end":"2026-06-10T10:59:39.552551Z","steps":["trace[2028627160] 'process raft request' (duration: 251.642378ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:39.552658Z","caller":"traceutil/trace.go:171","msg":"trace[295266095] transaction","detail":"{read_only:false; response_revision:25623; number_of_response:1; }","duration":"250.955628ms","start":"2026-06-10T10:59:39.301694Z","end":"2026-06-10T10:59:39.552649Z","steps":["trace[295266095] 'process raft request' (duration: 250.800064ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:39.853739Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.348523ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:39.854015Z","caller":"traceutil/trace.go:171","msg":"trace[1999056877] linearizableReadLoop","detail":"{readStateIndex:26479; appliedIndex:26478; }","duration":"168.351628ms","start":"2026-06-10T10:59:39.685638Z","end":"2026-06-10T10:59:39.85399Z","steps":["trace[1999056877] 'read index received' (duration: 32.291µs)","trace[1999056877] 'applied index is now lower than readState.Index' (duration: 168.316887ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:39.854085Z","caller":"traceutil/trace.go:171","msg":"trace[913379892] transaction","detail":"{read_only:false; response_revision:25624; number_of_response:1; }","duration":"300.027343ms","start":"2026-06-10T10:59:39.554031Z","end":"2026-06-10T10:59:39.854058Z","steps":["trace[913379892] 'process raft request' (duration: 112.232288ms)","trace[913379892] 'compare' (duration: 187.199159ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:39.854198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:39.554005Z","time spent":"300.138216ms","remote":"127.0.0.1:42522","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:59:39.854357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.706578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/permissions/\" range_end:\"/registry/rabbitmq.com/permissions0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:39.854548Z","caller":"traceutil/trace.go:171","msg":"trace[491419966] range","detail":"{range_begin:/registry/rabbitmq.com/permissions/; range_end:/registry/rabbitmq.com/permissions0; response_count:0; response_revision:25624; }","duration":"168.893933ms","start":"2026-06-10T10:59:39.685602Z","end":"2026-06-10T10:59:39.854496Z","steps":["trace[491419966] 'agreement among raft nodes before linearized reading' (duration: 168.466321ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:39.855853Z","caller":"traceutil/trace.go:171","msg":"trace[1067218729] transaction","detail":"{read_only:false; response_revision:25625; number_of_response:1; }","duration":"107.026435ms","start":"2026-06-10T10:59:39.748803Z","end":"2026-06-10T10:59:39.855829Z","steps":["trace[1067218729] 'process raft request' (duration: 106.882231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:40.199928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.63492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:59:40.200108Z","caller":"traceutil/trace.go:171","msg":"trace[277468113] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:25625; }","duration":"216.880327ms","start":"2026-06-10T10:59:39.983209Z","end":"2026-06-10T10:59:40.20009Z","steps":["trace[277468113] 'count revisions from in-memory index tree' (duration: 216.540468ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:40.20029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.408923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-10T10:59:40.20039Z","caller":"traceutil/trace.go:171","msg":"trace[1901714396] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25625; }","duration":"200.573088ms","start":"2026-06-10T10:59:39.999796Z","end":"2026-06-10T10:59:40.200369Z","steps":["trace[1901714396] 'range keys from in-memory index tree' (duration: 200.182827ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:40.88756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.913636ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephrbdmirrors/\" range_end:\"/registry/ceph.rook.io/cephrbdmirrors0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:40.887623Z","caller":"traceutil/trace.go:171","msg":"trace[1656289036] range","detail":"{range_begin:/registry/ceph.rook.io/cephrbdmirrors/; range_end:/registry/ceph.rook.io/cephrbdmirrors0; response_count:0; response_revision:25627; }","duration":"264.02589ms","start":"2026-06-10T10:59:40.62358Z","end":"2026-06-10T10:59:40.887606Z","steps":["trace[1656289036] 'count revisions from in-memory index tree' (duration: 263.832344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:40.888419Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.485159ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:40.888553Z","caller":"traceutil/trace.go:171","msg":"trace[1603944797] transaction","detail":"{read_only:false; response_revision:25628; number_of_response:1; }","duration":"229.386433ms","start":"2026-06-10T10:59:40.659147Z","end":"2026-06-10T10:59:40.888533Z","steps":["trace[1603944797] 'process raft request' (duration: 88.673858ms)","trace[1603944797] 'compare' (duration: 140.353885ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:41.203594Z","caller":"traceutil/trace.go:171","msg":"trace[1573628486] transaction","detail":"{read_only:false; response_revision:25629; number_of_response:1; }","duration":"256.340977ms","start":"2026-06-10T10:59:40.947226Z","end":"2026-06-10T10:59:41.203567Z","steps":["trace[1573628486] 'process raft request' (duration: 256.186553ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:41.214347Z","caller":"traceutil/trace.go:171","msg":"trace[1378803468] transaction","detail":"{read_only:false; response_revision:25632; number_of_response:1; }","duration":"263.579217ms","start":"2026-06-10T10:59:40.950745Z","end":"2026-06-10T10:59:41.214324Z","steps":["trace[1378803468] 'process raft request' (duration: 263.543496ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:41.214446Z","caller":"traceutil/trace.go:171","msg":"trace[493328710] transaction","detail":"{read_only:false; response_revision:25631; number_of_response:1; }","duration":"264.281436ms","start":"2026-06-10T10:59:40.95014Z","end":"2026-06-10T10:59:41.214422Z","steps":["trace[493328710] 'process raft request' (duration: 264.109801ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:41.21437Z","caller":"traceutil/trace.go:171","msg":"trace[1959186212] transaction","detail":"{read_only:false; response_revision:25630; number_of_response:1; }","duration":"264.701368ms","start":"2026-06-10T10:59:40.949642Z","end":"2026-06-10T10:59:41.214344Z","steps":["trace[1959186212] 'process raft request' (duration: 264.501322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:41.504333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.882117ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:41.504504Z","caller":"traceutil/trace.go:171","msg":"trace[1281751036] transaction","detail":"{read_only:false; response_revision:25634; number_of_response:1; }","duration":"232.867189ms","start":"2026-06-10T10:59:41.271617Z","end":"2026-06-10T10:59:41.504484Z","steps":["trace[1281751036] 'process raft request' (duration: 232.812307ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:41.505039Z","caller":"traceutil/trace.go:171","msg":"trace[616276825] transaction","detail":"{read_only:false; response_revision:25633; number_of_response:1; }","duration":"264.573385ms","start":"2026-06-10T10:59:41.24041Z","end":"2026-06-10T10:59:41.504983Z","steps":["trace[616276825] 'process raft request' (duration: 92.965277ms)","trace[616276825] 'compare' (duration: 170.785085ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:41.505179Z","caller":"traceutil/trace.go:171","msg":"trace[747958733] transaction","detail":"{read_only:false; response_revision:25635; number_of_response:1; }","duration":"104.415443ms","start":"2026-06-10T10:59:41.400733Z","end":"2026-06-10T10:59:41.505148Z","steps":["trace[747958733] 'process raft request' (duration: 104.176997ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:41.681521Z","caller":"traceutil/trace.go:171","msg":"trace[590749789] transaction","detail":"{read_only:false; response_revision:25638; number_of_response:1; }","duration":"122.864962ms","start":"2026-06-10T10:59:41.558633Z","end":"2026-06-10T10:59:41.681498Z","steps":["trace[590749789] 'process raft request' (duration: 122.81364ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:41.681762Z","caller":"traceutil/trace.go:171","msg":"trace[289256905] transaction","detail":"{read_only:false; response_revision:25637; number_of_response:1; }","duration":"123.334775ms","start":"2026-06-10T10:59:41.558417Z","end":"2026-06-10T10:59:41.681752Z","steps":["trace[289256905] 'process raft request' (duration: 122.947384ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:41.68214Z","caller":"traceutil/trace.go:171","msg":"trace[507628027] transaction","detail":"{read_only:false; response_revision:25636; number_of_response:1; }","duration":"124.558168ms","start":"2026-06-10T10:59:41.557554Z","end":"2026-06-10T10:59:41.682112Z","steps":["trace[507628027] 'process raft request' (duration: 110.651565ms)","trace[507628027] 'compare' (duration: 12.841364ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:41.990242Z","caller":"traceutil/trace.go:171","msg":"trace[1912233587] transaction","detail":"{read_only:false; response_revision:25639; number_of_response:1; }","duration":"129.405332ms","start":"2026-06-10T10:59:41.860813Z","end":"2026-06-10T10:59:41.990218Z","steps":["trace[1912233587] 'process raft request' (duration: 129.258938ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:42.583247Z","caller":"traceutil/trace.go:171","msg":"trace[1060761765] linearizableReadLoop","detail":"{readStateIndex:26495; appliedIndex:26494; }","duration":"106.044398ms","start":"2026-06-10T10:59:42.477175Z","end":"2026-06-10T10:59:42.583219Z","steps":["trace[1060761765] 'read index received' (duration: 105.834542ms)","trace[1060761765] 'applied index is now lower than readState.Index' (duration: 208.516µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:42.583301Z","caller":"traceutil/trace.go:171","msg":"trace[1871445695] transaction","detail":"{read_only:false; response_revision:25640; number_of_response:1; }","duration":"292.953018ms","start":"2026-06-10T10:59:42.290311Z","end":"2026-06-10T10:59:42.583264Z","steps":["trace[1871445695] 'process raft request' (duration: 292.740962ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:42.583459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.256513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:59:42.584072Z","caller":"traceutil/trace.go:171","msg":"trace[1257899608] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:25640; }","duration":"106.373247ms","start":"2026-06-10T10:59:42.477113Z","end":"2026-06-10T10:59:42.583486Z","steps":["trace[1257899608] 'agreement among raft nodes before linearized reading' (duration: 106.268524ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:42.80816Z","caller":"traceutil/trace.go:171","msg":"trace[112695527] transaction","detail":"{read_only:false; response_revision:25641; number_of_response:1; }","duration":"153.891998ms","start":"2026-06-10T10:59:42.654221Z","end":"2026-06-10T10:59:42.808113Z","steps":["trace[112695527] 'process raft request' (duration: 84.39339ms)","trace[112695527] 'compare' (duration: 69.173269ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:43.410992Z","caller":"traceutil/trace.go:171","msg":"trace[1118695567] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"160.545092ms","start":"2026-06-10T10:59:43.250419Z","end":"2026-06-10T10:59:43.410964Z","steps":["trace[1118695567] 'process raft request' (duration: 160.382168ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:43.411839Z","caller":"traceutil/trace.go:171","msg":"trace[1438903748] transaction","detail":"{read_only:false; response_revision:25646; number_of_response:1; }","duration":"160.807739ms","start":"2026-06-10T10:59:43.251017Z","end":"2026-06-10T10:59:43.411825Z","steps":["trace[1438903748] 'process raft request' (duration: 160.715216ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:43.41208Z","caller":"traceutil/trace.go:171","msg":"trace[1860229895] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"160.873071ms","start":"2026-06-10T10:59:43.251174Z","end":"2026-06-10T10:59:43.412048Z","steps":["trace[1860229895] 'process raft request' (duration: 160.611924ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:43.71597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.170414ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:43.716133Z","caller":"traceutil/trace.go:171","msg":"trace[1479976951] transaction","detail":"{read_only:false; response_revision:25648; number_of_response:1; }","duration":"205.330798ms","start":"2026-06-10T10:59:43.510773Z","end":"2026-06-10T10:59:43.716104Z","steps":["trace[1479976951] 'process raft request' (duration: 74.949669ms)","trace[1479976951] 'compare' (duration: 129.882305ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:43.716172Z","caller":"traceutil/trace.go:171","msg":"trace[1631875504] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"202.780889ms","start":"2026-06-10T10:59:43.513373Z","end":"2026-06-10T10:59:43.716154Z","steps":["trace[1631875504] 'process raft request' (duration: 202.701306ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:43.716291Z","caller":"traceutil/trace.go:171","msg":"trace[948378960] linearizableReadLoop","detail":"{readStateIndex:26503; appliedIndex:26502; }","duration":"204.118255ms","start":"2026-06-10T10:59:43.512164Z","end":"2026-06-10T10:59:43.716283Z","steps":["trace[948378960] 'read index received' (duration: 73.577191ms)","trace[948378960] 'applied index is now lower than readState.Index' (duration: 130.540364ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:43.716463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-10T10:59:43.716497Z","caller":"traceutil/trace.go:171","msg":"trace[68866184] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25649; }","duration":"204.356922ms","start":"2026-06-10T10:59:43.512129Z","end":"2026-06-10T10:59:43.716486Z","steps":["trace[68866184] 'agreement among raft nodes before linearized reading' (duration: 204.210448ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:44.0273Z","caller":"traceutil/trace.go:171","msg":"trace[646633316] linearizableReadLoop","detail":"{readStateIndex:26507; appliedIndex:26504; }","duration":"310.965685ms","start":"2026-06-10T10:59:43.716315Z","end":"2026-06-10T10:59:44.02728Z","steps":["trace[646633316] 'read index received' (duration: 263.103034ms)","trace[646633316] 'applied index is now lower than readState.Index' (duration: 47.861751ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:44.027564Z","caller":"traceutil/trace.go:171","msg":"trace[906312676] transaction","detail":"{read_only:false; response_revision:25650; number_of_response:1; }","duration":"340.016727ms","start":"2026-06-10T10:59:43.687534Z","end":"2026-06-10T10:59:44.02755Z","steps":["trace[906312676] 'process raft request' (duration: 291.867207ms)","trace[906312676] 'compare' (duration: 47.503642ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:44.027678Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:43.687512Z","time spent":"340.089519ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:59:44.027845Z","caller":"traceutil/trace.go:171","msg":"trace[1189274758] transaction","detail":"{read_only:false; response_revision:25651; number_of_response:1; }","duration":"339.796741ms","start":"2026-06-10T10:59:43.688039Z","end":"2026-06-10T10:59:44.027836Z","steps":["trace[1189274758] 'process raft request' (duration: 339.142193ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:44.027904Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:43.688014Z","time spent":"339.860763ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:59:44.028029Z","caller":"traceutil/trace.go:171","msg":"trace[1303868068] transaction","detail":"{read_only:false; response_revision:25652; number_of_response:1; }","duration":"339.094212ms","start":"2026-06-10T10:59:43.688926Z","end":"2026-06-10T10:59:44.02802Z","steps":["trace[1303868068] 'process raft request' (duration: 338.31492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:44.028086Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:43.688888Z","time spent":"339.168434ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:59:44.028227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.869893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:44.02827Z","caller":"traceutil/trace.go:171","msg":"trace[721271046] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:25652; }","duration":"389.949045ms","start":"2026-06-10T10:59:43.638308Z","end":"2026-06-10T10:59:44.028257Z","steps":["trace[721271046] 'agreement among raft nodes before linearized reading' (duration: 389.885483ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:44.028301Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:43.638282Z","time spent":"390.011297ms","remote":"127.0.0.1:44488","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:59:44.028454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"458.499698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:44.028491Z","caller":"traceutil/trace.go:171","msg":"trace[1749710853] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0; response_count:0; response_revision:25652; }","duration":"458.57871ms","start":"2026-06-10T10:59:43.569903Z","end":"2026-06-10T10:59:44.028482Z","steps":["trace[1749710853] 'agreement among raft nodes before linearized reading' (duration: 458.525309ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:44.028522Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:43.569878Z","time spent":"458.635711ms","remote":"127.0.0.1:52152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":142,"response count":0,"response size":29,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachinetemplates0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:59:44.030359Z","caller":"traceutil/trace.go:171","msg":"trace[1421206708] transaction","detail":"{read_only:false; response_revision:25653; number_of_response:1; }","duration":"308.701643ms","start":"2026-06-10T10:59:43.721641Z","end":"2026-06-10T10:59:44.030342Z","steps":["trace[1421206708] 'process raft request' (duration: 308.387334ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:44.030445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:43.721613Z","time spent":"308.791015ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:59:44.231438Z","caller":"traceutil/trace.go:171","msg":"trace[1362816170] linearizableReadLoop","detail":"{readStateIndex:26510; appliedIndex:26509; }","duration":"204.056144ms","start":"2026-06-10T10:59:44.027363Z","end":"2026-06-10T10:59:44.23142Z","steps":["trace[1362816170] 'read index received' (duration: 3.282941ms)","trace[1362816170] 'applied index is now lower than readState.Index' (duration: 200.772243ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:44.231765Z","caller":"traceutil/trace.go:171","msg":"trace[228266967] transaction","detail":"{read_only:false; response_revision:25655; number_of_response:1; }","duration":"236.084587ms","start":"2026-06-10T10:59:43.99565Z","end":"2026-06-10T10:59:44.231735Z","steps":["trace[228266967] 'process raft request' (duration: 214.570593ms)","trace[228266967] 'compare' (duration: 21.068382ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:44.30402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.266896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:44.304089Z","caller":"traceutil/trace.go:171","msg":"trace[620100213] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25655; }","duration":"402.374739ms","start":"2026-06-10T10:59:43.901698Z","end":"2026-06-10T10:59:44.304072Z","steps":["trace[620100213] 'agreement among raft nodes before linearized reading' (duration: 330.138144ms)","trace[620100213] 'range keys from in-memory index tree' (duration: 72.140552ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:59:44.304146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:43.901679Z","time spent":"402.45451ms","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T10:59:48.431465Z","caller":"traceutil/trace.go:171","msg":"trace[1882533833] transaction","detail":"{read_only:false; response_revision:25685; number_of_response:1; }","duration":"187.080145ms","start":"2026-06-10T10:59:48.244358Z","end":"2026-06-10T10:59:48.431439Z","steps":["trace[1882533833] 'process raft request' (duration: 186.892099ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:48.736813Z","caller":"traceutil/trace.go:171","msg":"trace[1357370926] linearizableReadLoop","detail":"{readStateIndex:26542; appliedIndex:26540; }","duration":"322.061331ms","start":"2026-06-10T10:59:48.414726Z","end":"2026-06-10T10:59:48.736787Z","steps":["trace[1357370926] 'read index received' (duration: 16.606819ms)","trace[1357370926] 'applied index is now lower than readState.Index' (duration: 305.453392ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:48.737201Z","caller":"traceutil/trace.go:171","msg":"trace[268339348] transaction","detail":"{read_only:false; response_revision:25686; number_of_response:1; }","duration":"351.592856ms","start":"2026-06-10T10:59:48.385584Z","end":"2026-06-10T10:59:48.737177Z","steps":["trace[268339348] 'process raft request' (duration: 349.891779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:48.737332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:48.385547Z","time spent":"351.713419ms","remote":"127.0.0.1:35504","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418382,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:59:48.737666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.935035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-10T10:59:48.737703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.876821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:59:48.73777Z","caller":"traceutil/trace.go:171","msg":"trace[1989561213] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:25686; }","duration":"323.037438ms","start":"2026-06-10T10:59:48.414701Z","end":"2026-06-10T10:59:48.737739Z","steps":["trace[1989561213] 'agreement among raft nodes before linearized reading' (duration: 322.421591ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:48.73777Z","caller":"traceutil/trace.go:171","msg":"trace[1713264020] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:25686; }","duration":"202.974934ms","start":"2026-06-10T10:59:48.534778Z","end":"2026-06-10T10:59:48.737752Z","steps":["trace[1713264020] 'agreement among raft nodes before linearized reading' (duration: 202.394758ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:48.737834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:48.414616Z","time spent":"323.207853ms","remote":"127.0.0.1:42982","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":19,"response size":31,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:59:48.738318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.986581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-10T10:59:48.738425Z","caller":"traceutil/trace.go:171","msg":"trace[1483675191] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25686; }","duration":"129.162576ms","start":"2026-06-10T10:59:48.609241Z","end":"2026-06-10T10:59:48.738404Z","steps":["trace[1483675191] 'agreement among raft nodes before linearized reading' (duration: 127.934082ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.155831Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.763927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:49.155898Z","caller":"traceutil/trace.go:171","msg":"trace[969516085] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25687; }","duration":"252.87925ms","start":"2026-06-10T10:59:48.903004Z","end":"2026-06-10T10:59:49.155883Z","steps":["trace[969516085] 'range keys from in-memory index tree' (duration: 252.679565ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:49.472014Z","caller":"traceutil/trace.go:171","msg":"trace[2055745689] linearizableReadLoop","detail":"{readStateIndex:26544; appliedIndex:26543; }","duration":"453.002565ms","start":"2026-06-10T10:59:49.018981Z","end":"2026-06-10T10:59:49.471983Z","steps":["trace[2055745689] 'read index received' (duration: 452.856291ms)","trace[2055745689] 'applied index is now lower than readState.Index' (duration: 144.874µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:49.472178Z","caller":"traceutil/trace.go:171","msg":"trace[1498183178] transaction","detail":"{read_only:false; response_revision:25688; number_of_response:1; }","duration":"520.970491ms","start":"2026-06-10T10:59:48.951089Z","end":"2026-06-10T10:59:49.47206Z","steps":["trace[1498183178] 'process raft request' (duration: 520.587051ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.472378Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.297784ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:59:49.472392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:48.951061Z","time spent":"521.249229ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:59:49.472431Z","caller":"traceutil/trace.go:171","msg":"trace[702618292] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:25688; }","duration":"453.506179ms","start":"2026-06-10T10:59:49.018908Z","end":"2026-06-10T10:59:49.472415Z","steps":["trace[702618292] 'agreement among raft nodes before linearized reading' (duration: 453.212731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.472586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:49.018881Z","time spent":"453.688844ms","remote":"127.0.0.1:44652","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":29,"request content":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:59:49.542274Z","caller":"traceutil/trace.go:171","msg":"trace[663651606] transaction","detail":"{read_only:false; response_revision:25689; number_of_response:1; }","duration":"275.464355ms","start":"2026-06-10T10:59:49.266783Z","end":"2026-06-10T10:59:49.542247Z","steps":["trace[663651606] 'process raft request' (duration: 275.27069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.542587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.108724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T10:59:49.542629Z","caller":"traceutil/trace.go:171","msg":"trace[1710477167] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25690; }","duration":"100.183806ms","start":"2026-06-10T10:59:49.442435Z","end":"2026-06-10T10:59:49.542619Z","steps":["trace[1710477167] 'agreement among raft nodes before linearized reading' (duration: 100.007431ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.54263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.537093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:59:49.542769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.009143ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.242\" ","response":"range_response_count:1 size:140"} {"level":"warn","ts":"2026-06-10T10:59:49.542897Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.048105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18542"} {"level":"info","ts":"2026-06-10T10:59:49.54282Z","caller":"traceutil/trace.go:171","msg":"trace[1388899452] range","detail":"{range_begin:/registry/masterleases/199.204.45.242; range_end:; response_count:1; response_revision:25690; }","duration":"396.174867ms","start":"2026-06-10T10:59:49.146633Z","end":"2026-06-10T10:59:49.542808Z","steps":["trace[1388899452] 'agreement among raft nodes before linearized reading' (duration: 395.777666ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:49.542944Z","caller":"traceutil/trace.go:171","msg":"trace[1613259680] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25690; }","duration":"216.130937ms","start":"2026-06-10T10:59:49.326803Z","end":"2026-06-10T10:59:49.542934Z","steps":["trace[1613259680] 'agreement among raft nodes before linearized reading' (duration: 216.010254ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.542954Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:49.146613Z","time spent":"396.331832ms","remote":"127.0.0.1:42522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":163,"request content":"key:\"/registry/masterleases/199.204.45.242\" "} {"level":"warn","ts":"2026-06-10T10:59:49.543079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.765796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:59:49.543124Z","caller":"traceutil/trace.go:171","msg":"trace[1920547684] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25690; }","duration":"107.860128ms","start":"2026-06-10T10:59:49.435254Z","end":"2026-06-10T10:59:49.543114Z","steps":["trace[1920547684] 'agreement among raft nodes before linearized reading' (duration: 107.751135ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.543267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"386.163731ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:49.543334Z","caller":"traceutil/trace.go:171","msg":"trace[1496587084] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25690; }","duration":"386.264574ms","start":"2026-06-10T10:59:49.157052Z","end":"2026-06-10T10:59:49.543317Z","steps":["trace[1496587084] 'agreement among raft nodes before linearized reading' (duration: 386.14565ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:49.543381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:49.15703Z","time spent":"386.338656ms","remote":"127.0.0.1:42484","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T10:59:49.542662Z","caller":"traceutil/trace.go:171","msg":"trace[103600574] transaction","detail":"{read_only:false; response_revision:25690; number_of_response:1; }","duration":"233.547667ms","start":"2026-06-10T10:59:49.309076Z","end":"2026-06-10T10:59:49.542624Z","steps":["trace[103600574] 'process raft request' (duration: 233.118776ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:49.542806Z","caller":"traceutil/trace.go:171","msg":"trace[1428962385] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:25690; }","duration":"172.702118ms","start":"2026-06-10T10:59:49.370072Z","end":"2026-06-10T10:59:49.542774Z","steps":["trace[1428962385] 'agreement among raft nodes before linearized reading' (duration: 172.495632ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:54.150557Z","caller":"traceutil/trace.go:171","msg":"trace[1304383548] linearizableReadLoop","detail":"{readStateIndex:26636; appliedIndex:26635; }","duration":"245.613881ms","start":"2026-06-10T10:59:53.90492Z","end":"2026-06-10T10:59:54.150533Z","steps":["trace[1304383548] 'read index received' (duration: 245.389485ms)","trace[1304383548] 'applied index is now lower than readState.Index' (duration: 223.156µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:54.150676Z","caller":"traceutil/trace.go:171","msg":"trace[122946931] transaction","detail":"{read_only:false; response_revision:25779; number_of_response:1; }","duration":"303.773247ms","start":"2026-06-10T10:59:53.846867Z","end":"2026-06-10T10:59:54.15064Z","steps":["trace[122946931] 'process raft request' (duration: 303.463708ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:54.150809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.855817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:59:54.150876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:59:53.846845Z","time spent":"303.921761ms","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3743,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:59:54.150904Z","caller":"traceutil/trace.go:171","msg":"trace[1908520545] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25779; }","duration":"246.010582ms","start":"2026-06-10T10:59:53.904873Z","end":"2026-06-10T10:59:54.150883Z","steps":["trace[1908520545] 'agreement among raft nodes before linearized reading' (duration: 245.787666ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:54.271688Z","caller":"traceutil/trace.go:171","msg":"trace[2039500767] transaction","detail":"{read_only:false; response_revision:25780; number_of_response:1; }","duration":"197.390239ms","start":"2026-06-10T10:59:54.074276Z","end":"2026-06-10T10:59:54.271666Z","steps":["trace[2039500767] 'process raft request' (duration: 197.205934ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:54.271915Z","caller":"traceutil/trace.go:171","msg":"trace[690869550] transaction","detail":"{read_only:false; response_revision:25781; number_of_response:1; }","duration":"192.881285ms","start":"2026-06-10T10:59:54.079027Z","end":"2026-06-10T10:59:54.271908Z","steps":["trace[690869550] 'process raft request' (duration: 192.607287ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:54.272217Z","caller":"traceutil/trace.go:171","msg":"trace[1882418576] linearizableReadLoop","detail":"{readStateIndex:26639; appliedIndex:26636; }","duration":"121.545065ms","start":"2026-06-10T10:59:54.150627Z","end":"2026-06-10T10:59:54.272172Z","steps":["trace[1882418576] 'read index received' (duration: 120.791464ms)","trace[1882418576] 'applied index is now lower than readState.Index' (duration: 750.681µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:54.272285Z","caller":"traceutil/trace.go:171","msg":"trace[1386509536] transaction","detail":"{read_only:false; response_revision:25782; number_of_response:1; }","duration":"193.035519ms","start":"2026-06-10T10:59:54.079238Z","end":"2026-06-10T10:59:54.272273Z","steps":["trace[1386509536] 'process raft request' (duration: 192.633008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:54.272472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.703289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-10T10:59:54.2726Z","caller":"traceutil/trace.go:171","msg":"trace[1215485311] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25782; }","duration":"188.884465ms","start":"2026-06-10T10:59:54.083685Z","end":"2026-06-10T10:59:54.27257Z","steps":["trace[1215485311] 'agreement among raft nodes before linearized reading' (duration: 188.638838ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:54.272476Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.19565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:59:54.272713Z","caller":"traceutil/trace.go:171","msg":"trace[1207241605] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25782; }","duration":"119.483008ms","start":"2026-06-10T10:59:54.153214Z","end":"2026-06-10T10:59:54.272697Z","steps":["trace[1207241605] 'agreement among raft nodes before linearized reading' (duration: 119.182ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:54.510964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.132223ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:59:54.511212Z","caller":"traceutil/trace.go:171","msg":"trace[1568642105] transaction","detail":"{read_only:false; response_revision:25784; number_of_response:1; }","duration":"208.61723ms","start":"2026-06-10T10:59:54.302573Z","end":"2026-06-10T10:59:54.51119Z","steps":["trace[1568642105] 'process raft request' (duration: 208.499526ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:54.511593Z","caller":"traceutil/trace.go:171","msg":"trace[193425021] transaction","detail":"{read_only:false; response_revision:25783; number_of_response:1; }","duration":"234.393361ms","start":"2026-06-10T10:59:54.277171Z","end":"2026-06-10T10:59:54.511564Z","steps":["trace[193425021] 'process raft request' (duration: 103.568229ms)","trace[193425021] 'compare' (duration: 129.845825ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:59:54.716346Z","caller":"traceutil/trace.go:171","msg":"trace[1846153372] transaction","detail":"{read_only:false; response_revision:25785; number_of_response:1; }","duration":"264.066601ms","start":"2026-06-10T10:59:54.452249Z","end":"2026-06-10T10:59:54.716316Z","steps":["trace[1846153372] 'process raft request' (duration: 263.840524ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:54.718619Z","caller":"traceutil/trace.go:171","msg":"trace[54428426] transaction","detail":"{read_only:false; response_revision:25786; number_of_response:1; }","duration":"193.769809ms","start":"2026-06-10T10:59:54.524812Z","end":"2026-06-10T10:59:54.718582Z","steps":["trace[54428426] 'process raft request' (duration: 193.487591ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:59:54.718876Z","caller":"traceutil/trace.go:171","msg":"trace[2039000457] transaction","detail":"{read_only:false; response_revision:25787; number_of_response:1; }","duration":"168.973605ms","start":"2026-06-10T10:59:54.549874Z","end":"2026-06-10T10:59:54.718848Z","steps":["trace[2039000457] 'process raft request' (duration: 168.589554ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:59:56.051269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.997246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/\" range_end:\"/registry/jobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:59:56.051361Z","caller":"traceutil/trace.go:171","msg":"trace[609502035] range","detail":"{range_begin:/registry/jobs/; range_end:/registry/jobs0; response_count:0; response_revision:25798; }","duration":"127.162421ms","start":"2026-06-10T10:59:55.924174Z","end":"2026-06-10T10:59:56.051336Z","steps":["trace[609502035] 'count revisions from in-memory index tree' (duration: 126.900033ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.323308Z","caller":"traceutil/trace.go:171","msg":"trace[629701375] linearizableReadLoop","detail":"{readStateIndex:26722; appliedIndex:26716; }","duration":"146.102853ms","start":"2026-06-10T11:00:00.177187Z","end":"2026-06-10T11:00:00.32329Z","steps":["trace[629701375] 'read index received' (duration: 145.816446ms)","trace[629701375] 'applied index is now lower than readState.Index' (duration: 285.717µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:00.323389Z","caller":"traceutil/trace.go:171","msg":"trace[1417630028] transaction","detail":"{read_only:false; response_revision:25861; number_of_response:1; }","duration":"200.980138ms","start":"2026-06-10T11:00:00.122402Z","end":"2026-06-10T11:00:00.323382Z","steps":["trace[1417630028] 'process raft request' (duration: 200.801413ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.323403Z","caller":"traceutil/trace.go:171","msg":"trace[1841705337] transaction","detail":"{read_only:false; response_revision:25860; number_of_response:1; }","duration":"201.068831ms","start":"2026-06-10T11:00:00.122304Z","end":"2026-06-10T11:00:00.323373Z","steps":["trace[1841705337] 'process raft request' (duration: 200.877726ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.323581Z","caller":"traceutil/trace.go:171","msg":"trace[1634462208] transaction","detail":"{read_only:false; response_revision:25863; number_of_response:1; }","duration":"196.873815ms","start":"2026-06-10T11:00:00.126685Z","end":"2026-06-10T11:00:00.323559Z","steps":["trace[1634462208] 'process raft request' (duration: 196.573867ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.323666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.465433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/openstack/nova-cell-setup\" ","response":"range_response_count:1 size:5263"} {"level":"info","ts":"2026-06-10T11:00:00.323688Z","caller":"traceutil/trace.go:171","msg":"trace[66872267] range","detail":"{range_begin:/registry/cronjobs/openstack/nova-cell-setup; range_end:; response_count:1; response_revision:25863; }","duration":"146.532645ms","start":"2026-06-10T11:00:00.17715Z","end":"2026-06-10T11:00:00.323683Z","steps":["trace[66872267] 'agreement among raft nodes before linearized reading' (duration: 146.427862ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.323754Z","caller":"traceutil/trace.go:171","msg":"trace[1771995101] transaction","detail":"{read_only:false; response_revision:25858; number_of_response:1; }","duration":"210.770708ms","start":"2026-06-10T11:00:00.11298Z","end":"2026-06-10T11:00:00.32375Z","steps":["trace[1771995101] 'process raft request' (duration: 210.021748ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.323815Z","caller":"traceutil/trace.go:171","msg":"trace[983488740] transaction","detail":"{read_only:false; response_revision:25862; number_of_response:1; }","duration":"201.118683ms","start":"2026-06-10T11:00:00.122644Z","end":"2026-06-10T11:00:00.323763Z","steps":["trace[983488740] 'process raft request' (duration: 200.577138ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.323947Z","caller":"traceutil/trace.go:171","msg":"trace[1548671826] transaction","detail":"{read_only:false; response_revision:25859; number_of_response:1; }","duration":"201.577215ms","start":"2026-06-10T11:00:00.122197Z","end":"2026-06-10T11:00:00.323775Z","steps":["trace[1548671826] 'process raft request' (duration: 200.942247ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.336188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.423793ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:00.336249Z","caller":"traceutil/trace.go:171","msg":"trace[2092128542] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25866; }","duration":"129.517756ms","start":"2026-06-10T11:00:00.206717Z","end":"2026-06-10T11:00:00.336235Z","steps":["trace[2092128542] 'agreement among raft nodes before linearized reading' (duration: 129.414973ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.529002Z","caller":"traceutil/trace.go:171","msg":"trace[1341080602] transaction","detail":"{read_only:false; response_revision:25875; number_of_response:1; }","duration":"126.379129ms","start":"2026-06-10T11:00:00.402592Z","end":"2026-06-10T11:00:00.528971Z","steps":["trace[1341080602] 'process raft request' (duration: 110.522781ms)","trace[1341080602] 'compare' (duration: 15.639742ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:00.786039Z","caller":"traceutil/trace.go:171","msg":"trace[2141006870] linearizableReadLoop","detail":"{readStateIndex:26736; appliedIndex:26733; }","duration":"370.19577ms","start":"2026-06-10T11:00:00.415824Z","end":"2026-06-10T11:00:00.786019Z","steps":["trace[2141006870] 'read index received' (duration: 98.220632ms)","trace[2141006870] 'applied index is now lower than readState.Index' (duration: 271.974198ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:00.786145Z","caller":"traceutil/trace.go:171","msg":"trace[842120918] transaction","detail":"{read_only:false; response_revision:25877; number_of_response:1; }","duration":"381.037709ms","start":"2026-06-10T11:00:00.405095Z","end":"2026-06-10T11:00:00.786133Z","steps":["trace[842120918] 'process raft request' (duration: 380.841324ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.786117Z","caller":"traceutil/trace.go:171","msg":"trace[664893917] transaction","detail":"{read_only:false; response_revision:25876; number_of_response:1; }","duration":"383.047865ms","start":"2026-06-10T11:00:00.403035Z","end":"2026-06-10T11:00:00.786083Z","steps":["trace[664893917] 'process raft request' (duration: 335.534093ms)","trace[664893917] 'compare' (duration: 47.156842ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:00.786226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:00.405089Z","time spent":"381.07972ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":737,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T11:00:00.786248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:00.403029Z","time spent":"383.151458ms","remote":"127.0.0.1:42572","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":720,"response count":0,"response size":41,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T11:00:00.786267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.419596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:00.786358Z","caller":"traceutil/trace.go:171","msg":"trace[528233163] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/servers/; range_end:/registry/openstack.k-orc.cloud/servers0; response_count:0; response_revision:25877; }","duration":"370.517749ms","start":"2026-06-10T11:00:00.415817Z","end":"2026-06-10T11:00:00.786335Z","steps":["trace[528233163] 'agreement among raft nodes before linearized reading' (duration: 370.353534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.786406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:00.415764Z","time spent":"370.632262ms","remote":"127.0.0.1:50032","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":29,"request content":"key:\"/registry/openstack.k-orc.cloud/servers/\" range_end:\"/registry/openstack.k-orc.cloud/servers0\" count_only:true "} {"level":"info","ts":"2026-06-10T11:00:00.943988Z","caller":"traceutil/trace.go:171","msg":"trace[113832078] linearizableReadLoop","detail":"{readStateIndex:26737; appliedIndex:26736; }","duration":"157.862109ms","start":"2026-06-10T11:00:00.786105Z","end":"2026-06-10T11:00:00.943967Z","steps":["trace[113832078] 'read index received' (duration: 154.950118ms)","trace[113832078] 'applied index is now lower than readState.Index' (duration: 2.911041ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:00.944104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.677492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:00.944129Z","caller":"traceutil/trace.go:171","msg":"trace[2119932226] range","detail":"{range_begin:/registry/cluster.x-k8s.io/clusterclasses/; range_end:/registry/cluster.x-k8s.io/clusterclasses0; response_count:0; response_revision:25878; }","duration":"358.742564ms","start":"2026-06-10T11:00:00.585378Z","end":"2026-06-10T11:00:00.94412Z","steps":["trace[2119932226] 'agreement among raft nodes before linearized reading' (duration: 358.683522ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.944153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:00.585362Z","time spent":"358.783416ms","remote":"127.0.0.1:51866","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":29,"request content":"key:\"/registry/cluster.x-k8s.io/clusterclasses/\" range_end:\"/registry/cluster.x-k8s.io/clusterclasses0\" count_only:true "} {"level":"warn","ts":"2026-06-10T11:00:00.944186Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.269649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/nova-cell-setup-cron\" ","response":"range_response_count:1 size:541"} {"level":"warn","ts":"2026-06-10T11:00:00.94418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.096503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/nova-service-cleaner\" ","response":"range_response_count:1 size:541"} {"level":"info","ts":"2026-06-10T11:00:00.944229Z","caller":"traceutil/trace.go:171","msg":"trace[1464477622] range","detail":"{range_begin:/registry/serviceaccounts/openstack/nova-cell-setup-cron; range_end:; response_count:1; response_revision:25878; }","duration":"317.347552ms","start":"2026-06-10T11:00:00.626869Z","end":"2026-06-10T11:00:00.944216Z","steps":["trace[1464477622] 'agreement among raft nodes before linearized reading' (duration: 317.166477ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.944256Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:00.626855Z","time spent":"317.394023ms","remote":"127.0.0.1:42710","response type":"/etcdserverpb.KV/Range","request count":0,"request size":58,"response count":1,"response size":564,"request content":"key:\"/registry/serviceaccounts/openstack/nova-cell-setup-cron\" "} {"level":"warn","ts":"2026-06-10T11:00:00.944326Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.427639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T11:00:00.944324Z","caller":"traceutil/trace.go:171","msg":"trace[1412635371] transaction","detail":"{read_only:false; response_revision:25878; number_of_response:1; }","duration":"210.029599ms","start":"2026-06-10T11:00:00.734272Z","end":"2026-06-10T11:00:00.944302Z","steps":["trace[1412635371] 'process raft request' (duration: 206.604134ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.944358Z","caller":"traceutil/trace.go:171","msg":"trace[1409768551] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:25878; }","duration":"168.501602ms","start":"2026-06-10T11:00:00.775847Z","end":"2026-06-10T11:00:00.944348Z","steps":["trace[1409768551] 'agreement among raft nodes before linearized reading' (duration: 168.42519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.944372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"404.829397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T11:00:00.944402Z","caller":"traceutil/trace.go:171","msg":"trace[1725810062] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25878; }","duration":"404.892699ms","start":"2026-06-10T11:00:00.539501Z","end":"2026-06-10T11:00:00.944394Z","steps":["trace[1725810062] 'agreement among raft nodes before linearized reading' (duration: 404.802066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.944422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:00.539485Z","time spent":"404.931729ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T11:00:00.944446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.287638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/heat-engine-cleaner\" ","response":"range_response_count:1 size:541"} {"level":"warn","ts":"2026-06-10T11:00:00.944483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.597894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-29684820-x24lp\" ","response":"range_response_count:1 size:5432"} {"level":"info","ts":"2026-06-10T11:00:00.944501Z","caller":"traceutil/trace.go:171","msg":"trace[804392504] range","detail":"{range_begin:/registry/serviceaccounts/openstack/heat-engine-cleaner; range_end:; response_count:1; response_revision:25878; }","duration":"213.36617ms","start":"2026-06-10T11:00:00.731121Z","end":"2026-06-10T11:00:00.944487Z","steps":["trace[804392504] 'agreement among raft nodes before linearized reading' (duration: 213.187335ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.944518Z","caller":"traceutil/trace.go:171","msg":"trace[1305800340] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-29684820-x24lp; range_end:; response_count:1; response_revision:25878; }","duration":"528.677426ms","start":"2026-06-10T11:00:00.415829Z","end":"2026-06-10T11:00:00.944507Z","steps":["trace[1305800340] 'agreement among raft nodes before linearized reading' (duration: 528.573533ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.944252Z","caller":"traceutil/trace.go:171","msg":"trace[191836787] range","detail":"{range_begin:/registry/serviceaccounts/openstack/nova-service-cleaner; range_end:; response_count:1; response_revision:25878; }","duration":"213.197296ms","start":"2026-06-10T11:00:00.731029Z","end":"2026-06-10T11:00:00.944226Z","steps":["trace[191836787] 'agreement among raft nodes before linearized reading' (duration: 212.98119ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:00.944548Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:00.415806Z","time spent":"528.735718ms","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":57,"response count":1,"response size":5455,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-29684820-x24lp\" "} {"level":"warn","ts":"2026-06-10T11:00:00.944577Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.13983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-10T11:00:00.944651Z","caller":"traceutil/trace.go:171","msg":"trace[1090878574] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25878; }","duration":"261.266413ms","start":"2026-06-10T11:00:00.683365Z","end":"2026-06-10T11:00:00.944632Z","steps":["trace[1090878574] 'agreement among raft nodes before linearized reading' (duration: 261.043867ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.944861Z","caller":"traceutil/trace.go:171","msg":"trace[1143004855] transaction","detail":"{read_only:false; response_revision:25879; number_of_response:1; }","duration":"154.873506ms","start":"2026-06-10T11:00:00.789974Z","end":"2026-06-10T11:00:00.944847Z","steps":["trace[1143004855] 'process raft request' (duration: 154.64371ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:00.945007Z","caller":"traceutil/trace.go:171","msg":"trace[1449080507] transaction","detail":"{read_only:false; response_revision:25880; number_of_response:1; }","duration":"154.964669ms","start":"2026-06-10T11:00:00.790023Z","end":"2026-06-10T11:00:00.944988Z","steps":["trace[1449080507] 'process raft request' (duration: 154.682811ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:02.36152Z","caller":"traceutil/trace.go:171","msg":"trace[2062890066] transaction","detail":"{read_only:false; response_revision:25914; number_of_response:1; }","duration":"100.022481ms","start":"2026-06-10T11:00:02.261471Z","end":"2026-06-10T11:00:02.361494Z","steps":["trace[2062890066] 'process raft request' (duration: 97.891953ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:04.004232Z","caller":"traceutil/trace.go:171","msg":"trace[1591038058] linearizableReadLoop","detail":"{readStateIndex:26790; appliedIndex:26789; }","duration":"104.226677ms","start":"2026-06-10T11:00:03.899985Z","end":"2026-06-10T11:00:04.004212Z","steps":["trace[1591038058] 'read index received' (duration: 40.248621ms)","trace[1591038058] 'applied index is now lower than readState.Index' (duration: 63.977036ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:04.00438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.380262ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T11:00:04.00436Z","caller":"traceutil/trace.go:171","msg":"trace[2109620730] transaction","detail":"{read_only:false; response_revision:25931; number_of_response:1; }","duration":"123.898501ms","start":"2026-06-10T11:00:03.880425Z","end":"2026-06-10T11:00:04.004323Z","steps":["trace[2109620730] 'process raft request' (duration: 59.901684ms)","trace[2109620730] 'compare' (duration: 63.799542ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:04.004407Z","caller":"traceutil/trace.go:171","msg":"trace[1218805327] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:25931; }","duration":"104.452174ms","start":"2026-06-10T11:00:03.899946Z","end":"2026-06-10T11:00:04.004398Z","steps":["trace[1218805327] 'agreement among raft nodes before linearized reading' (duration: 104.367752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:04.004564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.58099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:04.004589Z","caller":"traceutil/trace.go:171","msg":"trace[866613351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25931; }","duration":"103.61422ms","start":"2026-06-10T11:00:03.900969Z","end":"2026-06-10T11:00:04.004583Z","steps":["trace[866613351] 'agreement among raft nodes before linearized reading' (duration: 103.579239ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:05.151706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.944989ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T11:00:05.151985Z","caller":"traceutil/trace.go:171","msg":"trace[299599990] transaction","detail":"{read_only:false; response_revision:25939; number_of_response:1; }","duration":"158.239508ms","start":"2026-06-10T11:00:04.993724Z","end":"2026-06-10T11:00:05.151964Z","steps":["trace[299599990] 'process raft request' (duration: 36.923019ms)","trace[299599990] 'compare' (duration: 120.690462ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:05.152141Z","caller":"traceutil/trace.go:171","msg":"trace[617343158] transaction","detail":"{read_only:false; response_revision:25941; number_of_response:1; }","duration":"125.071913ms","start":"2026-06-10T11:00:05.027061Z","end":"2026-06-10T11:00:05.152133Z","steps":["trace[617343158] 'process raft request' (duration: 124.894298ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:05.152121Z","caller":"traceutil/trace.go:171","msg":"trace[981632840] transaction","detail":"{read_only:false; response_revision:25940; number_of_response:1; }","duration":"157.506289ms","start":"2026-06-10T11:00:04.994583Z","end":"2026-06-10T11:00:05.15209Z","steps":["trace[981632840] 'process raft request' (duration: 157.250842ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:05.152161Z","caller":"traceutil/trace.go:171","msg":"trace[1410930903] linearizableReadLoop","detail":"{readStateIndex:26800; appliedIndex:26798; }","duration":"126.522493ms","start":"2026-06-10T11:00:05.025607Z","end":"2026-06-10T11:00:05.152129Z","steps":["trace[1410930903] 'read index received' (duration: 4.991998ms)","trace[1410930903] 'applied index is now lower than readState.Index' (duration: 121.528805ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:05.152386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.759479ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-29684820-x24lp\" ","response":"range_response_count:1 size:6960"} {"level":"info","ts":"2026-06-10T11:00:05.152464Z","caller":"traceutil/trace.go:171","msg":"trace[623210460] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-29684820-x24lp; range_end:; response_count:1; response_revision:25941; }","duration":"126.845492ms","start":"2026-06-10T11:00:05.025599Z","end":"2026-06-10T11:00:05.152444Z","steps":["trace[623210460] 'agreement among raft nodes before linearized reading' (duration: 126.615825ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:09.410032Z","caller":"traceutil/trace.go:171","msg":"trace[516969843] transaction","detail":"{read_only:false; response_revision:25986; number_of_response:1; }","duration":"208.440245ms","start":"2026-06-10T11:00:09.201557Z","end":"2026-06-10T11:00:09.409997Z","steps":["trace[516969843] 'process raft request' (duration: 132.525129ms)","trace[516969843] 'compare' (duration: 75.797072ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:09.449821Z","caller":"traceutil/trace.go:171","msg":"trace[862282023] linearizableReadLoop","detail":"{readStateIndex:26849; appliedIndex:26846; }","duration":"178.629932ms","start":"2026-06-10T11:00:09.271171Z","end":"2026-06-10T11:00:09.449801Z","steps":["trace[862282023] 'read index received' (duration: 62.961938ms)","trace[862282023] 'applied index is now lower than readState.Index' (duration: 115.666964ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:09.449845Z","caller":"traceutil/trace.go:171","msg":"trace[1296297408] transaction","detail":"{read_only:false; response_revision:25987; number_of_response:1; }","duration":"248.259074ms","start":"2026-06-10T11:00:09.201557Z","end":"2026-06-10T11:00:09.449816Z","steps":["trace[1296297408] 'process raft request' (duration: 248.033338ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:09.449918Z","caller":"traceutil/trace.go:171","msg":"trace[1387443335] transaction","detail":"{read_only:false; response_revision:25988; number_of_response:1; }","duration":"248.130581ms","start":"2026-06-10T11:00:09.201749Z","end":"2026-06-10T11:00:09.44988Z","steps":["trace[1387443335] 'process raft request' (duration: 247.997187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:09.450034Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.835947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/passwords/\" range_end:\"/registry/secretgen.k14s.io/passwords0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T11:00:09.450299Z","caller":"traceutil/trace.go:171","msg":"trace[793613069] range","detail":"{range_begin:/registry/secretgen.k14s.io/passwords/; range_end:/registry/secretgen.k14s.io/passwords0; response_count:0; response_revision:25988; }","duration":"179.157126ms","start":"2026-06-10T11:00:09.27112Z","end":"2026-06-10T11:00:09.450277Z","steps":["trace[793613069] 'agreement among raft nodes before linearized reading' (duration: 178.840107ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:11.388239Z","caller":"traceutil/trace.go:171","msg":"trace[1580990881] linearizableReadLoop","detail":"{readStateIndex:26864; appliedIndex:26863; }","duration":"156.412648ms","start":"2026-06-10T11:00:11.231803Z","end":"2026-06-10T11:00:11.388216Z","steps":["trace[1580990881] 'read index received' (duration: 156.265124ms)","trace[1580990881] 'applied index is now lower than readState.Index' (duration: 146.614µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:11.388469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.645235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-10T11:00:11.388521Z","caller":"traceutil/trace.go:171","msg":"trace[496843334] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26003; }","duration":"156.741617ms","start":"2026-06-10T11:00:11.231769Z","end":"2026-06-10T11:00:11.38851Z","steps":["trace[496843334] 'agreement among raft nodes before linearized reading' (duration: 156.537641ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:11.388942Z","caller":"traceutil/trace.go:171","msg":"trace[194171396] transaction","detail":"{read_only:false; response_revision:26003; number_of_response:1; }","duration":"219.89508ms","start":"2026-06-10T11:00:11.169029Z","end":"2026-06-10T11:00:11.388924Z","steps":["trace[194171396] 'process raft request' (duration: 219.024896ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:15.786974Z","caller":"traceutil/trace.go:171","msg":"trace[998166600] linearizableReadLoop","detail":"{readStateIndex:26908; appliedIndex:26906; }","duration":"112.735703ms","start":"2026-06-10T11:00:15.674214Z","end":"2026-06-10T11:00:15.78695Z","steps":["trace[998166600] 'read index received' (duration: 26.585014ms)","trace[998166600] 'applied index is now lower than readState.Index' (duration: 86.149619ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:15.787275Z","caller":"traceutil/trace.go:171","msg":"trace[2033697692] transaction","detail":"{read_only:false; response_revision:26046; number_of_response:1; }","duration":"122.77487ms","start":"2026-06-10T11:00:15.664468Z","end":"2026-06-10T11:00:15.787243Z","steps":["trace[2033697692] 'process raft request' (duration: 104.944997ms)","trace[2033697692] 'compare' (duration: 17.404831ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:15.787457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.233026ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T11:00:15.787507Z","caller":"traceutil/trace.go:171","msg":"trace[1625187612] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26046; }","duration":"113.327419ms","start":"2026-06-10T11:00:15.674165Z","end":"2026-06-10T11:00:15.787492Z","steps":["trace[1625187612] 'agreement among raft nodes before linearized reading' (duration: 113.158134ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:15.787542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.631766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-10T11:00:15.787443Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.715341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T11:00:15.787602Z","caller":"traceutil/trace.go:171","msg":"trace[1239620778] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26046; }","duration":"105.714918ms","start":"2026-06-10T11:00:15.68187Z","end":"2026-06-10T11:00:15.787585Z","steps":["trace[1239620778] 'agreement among raft nodes before linearized reading' (duration: 105.618825ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:15.787614Z","caller":"traceutil/trace.go:171","msg":"trace[1375208564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26046; }","duration":"108.937738ms","start":"2026-06-10T11:00:15.678666Z","end":"2026-06-10T11:00:15.787604Z","steps":["trace[1375208564] 'agreement among raft nodes before linearized reading' (duration: 108.587888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:16.112053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.042899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T11:00:16.112325Z","caller":"traceutil/trace.go:171","msg":"trace[1361925603] transaction","detail":"{read_only:false; response_revision:26047; number_of_response:1; }","duration":"320.444806ms","start":"2026-06-10T11:00:15.791835Z","end":"2026-06-10T11:00:16.112279Z","steps":["trace[1361925603] 'process raft request' (duration: 135.072998ms)","trace[1361925603] 'compare' (duration: 184.883334ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:16.112417Z","caller":"traceutil/trace.go:171","msg":"trace[618958057] transaction","detail":"{read_only:false; response_revision:26049; number_of_response:1; }","duration":"319.156011ms","start":"2026-06-10T11:00:15.793235Z","end":"2026-06-10T11:00:16.112391Z","steps":["trace[618958057] 'process raft request' (duration: 319.037928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:16.112541Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:15.793226Z","time spent":"319.256394ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:16.112627Z","caller":"traceutil/trace.go:171","msg":"trace[1797969482] linearizableReadLoop","detail":"{readStateIndex:26911; appliedIndex:26908; }","duration":"299.19684ms","start":"2026-06-10T11:00:15.813401Z","end":"2026-06-10T11:00:16.112598Z","steps":["trace[1797969482] 'read index received' (duration: 113.527194ms)","trace[1797969482] 'applied index is now lower than readState.Index' (duration: 185.668416ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:16.112649Z","caller":"traceutil/trace.go:171","msg":"trace[2140309354] transaction","detail":"{read_only:false; response_revision:26050; number_of_response:1; }","duration":"211.429247ms","start":"2026-06-10T11:00:15.901187Z","end":"2026-06-10T11:00:16.112616Z","steps":["trace[2140309354] 'process raft request' (duration: 211.134739ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:16.112635Z","caller":"traceutil/trace.go:171","msg":"trace[754545234] transaction","detail":"{read_only:false; response_revision:26048; number_of_response:1; }","duration":"320.507508ms","start":"2026-06-10T11:00:15.792077Z","end":"2026-06-10T11:00:16.112585Z","steps":["trace[754545234] 'process raft request' (duration: 320.111377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:16.112871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.423846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"warn","ts":"2026-06-10T11:00:16.112826Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:15.792059Z","time spent":"320.669052ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:16.112925Z","caller":"traceutil/trace.go:171","msg":"trace[1937454527] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:26050; }","duration":"299.551529ms","start":"2026-06-10T11:00:15.813362Z","end":"2026-06-10T11:00:16.112914Z","steps":["trace[1937454527] 'agreement among raft nodes before linearized reading' (duration: 299.287672ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:16.112947Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:15.791819Z","time spent":"320.58768ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:16.115164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.532264ms","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:6"} {"level":"info","ts":"2026-06-10T11:00:16.115235Z","caller":"traceutil/trace.go:171","msg":"trace[710650157] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:26051; }","duration":"268.658427ms","start":"2026-06-10T11:00:15.846559Z","end":"2026-06-10T11:00:16.115217Z","steps":["trace[710650157] 'agreement among raft nodes before linearized reading' (duration: 268.523273ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:16.115314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.95406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T11:00:16.11535Z","caller":"traceutil/trace.go:171","msg":"trace[1388299223] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:26051; }","duration":"175.039903ms","start":"2026-06-10T11:00:15.940298Z","end":"2026-06-10T11:00:16.115338Z","steps":["trace[1388299223] 'agreement among raft nodes before linearized reading' (duration: 174.973611ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.230463Z","caller":"traceutil/trace.go:171","msg":"trace[153564981] transaction","detail":"{read_only:false; response_revision:26062; number_of_response:1; }","duration":"111.873028ms","start":"2026-06-10T11:00:18.118562Z","end":"2026-06-10T11:00:18.230435Z","steps":["trace[153564981] 'process raft request' (duration: 54.764012ms)","trace[153564981] 'compare' (duration: 56.90054ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:18.230528Z","caller":"traceutil/trace.go:171","msg":"trace[1090047261] transaction","detail":"{read_only:false; response_revision:26063; number_of_response:1; }","duration":"111.351284ms","start":"2026-06-10T11:00:18.119157Z","end":"2026-06-10T11:00:18.230508Z","steps":["trace[1090047261] 'process raft request' (duration: 111.2014ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.230706Z","caller":"traceutil/trace.go:171","msg":"trace[2044376776] linearizableReadLoop","detail":"{readStateIndex:26925; appliedIndex:26923; }","duration":"108.612438ms","start":"2026-06-10T11:00:18.122085Z","end":"2026-06-10T11:00:18.230697Z","steps":["trace[2044376776] 'read index received' (duration: 51.255335ms)","trace[2044376776] 'applied index is now lower than readState.Index' (duration: 57.356433ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:18.230869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.99061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T11:00:18.230908Z","caller":"traceutil/trace.go:171","msg":"trace[1643234325] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26063; }","duration":"113.084792ms","start":"2026-06-10T11:00:18.117813Z","end":"2026-06-10T11:00:18.230898Z","steps":["trace[1643234325] 'agreement among raft nodes before linearized reading' (duration: 112.922798ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:18.230908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.00075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T11:00:18.230936Z","caller":"traceutil/trace.go:171","msg":"trace[1863182245] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26063; }","duration":"113.081422ms","start":"2026-06-10T11:00:18.117847Z","end":"2026-06-10T11:00:18.230929Z","steps":["trace[1863182245] 'agreement among raft nodes before linearized reading' (duration: 112.953008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:18.230927Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.940235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-10T11:00:18.231006Z","caller":"traceutil/trace.go:171","msg":"trace[794843083] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:26063; }","duration":"110.040718ms","start":"2026-06-10T11:00:18.120944Z","end":"2026-06-10T11:00:18.230985Z","steps":["trace[794843083] 'agreement among raft nodes before linearized reading' (duration: 109.769021ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.283048Z","caller":"traceutil/trace.go:171","msg":"trace[956163667] transaction","detail":"{read_only:false; response_revision:26064; number_of_response:1; }","duration":"153.98139ms","start":"2026-06-10T11:00:18.129049Z","end":"2026-06-10T11:00:18.283031Z","steps":["trace[956163667] 'process raft request' (duration: 153.849027ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.283293Z","caller":"traceutil/trace.go:171","msg":"trace[567895356] transaction","detail":"{read_only:false; response_revision:26065; number_of_response:1; }","duration":"154.171646ms","start":"2026-06-10T11:00:18.129114Z","end":"2026-06-10T11:00:18.283285Z","steps":["trace[567895356] 'process raft request' (duration: 153.875508ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.28348Z","caller":"traceutil/trace.go:171","msg":"trace[959610007] transaction","detail":"{read_only:false; response_revision:26066; number_of_response:1; }","duration":"154.066683ms","start":"2026-06-10T11:00:18.129392Z","end":"2026-06-10T11:00:18.283459Z","steps":["trace[959610007] 'process raft request' (duration: 153.774395ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.283604Z","caller":"traceutil/trace.go:171","msg":"trace[356364025] transaction","detail":"{read_only:false; response_revision:26067; number_of_response:1; }","duration":"151.901634ms","start":"2026-06-10T11:00:18.131696Z","end":"2026-06-10T11:00:18.283598Z","steps":["trace[356364025] 'process raft request' (duration: 151.676328ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.283824Z","caller":"traceutil/trace.go:171","msg":"trace[575460864] transaction","detail":"{read_only:false; response_revision:26068; number_of_response:1; }","duration":"148.687415ms","start":"2026-06-10T11:00:18.13513Z","end":"2026-06-10T11:00:18.283817Z","steps":["trace[575460864] 'process raft request' (duration: 148.379467ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.284117Z","caller":"traceutil/trace.go:171","msg":"trace[1224989538] transaction","detail":"{read_only:false; response_revision:26069; number_of_response:1; }","duration":"145.366633ms","start":"2026-06-10T11:00:18.138743Z","end":"2026-06-10T11:00:18.284109Z","steps":["trace[1224989538] 'process raft request' (duration: 144.938691ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.496981Z","caller":"traceutil/trace.go:171","msg":"trace[1586496383] linearizableReadLoop","detail":"{readStateIndex:26934; appliedIndex:26933; }","duration":"172.993095ms","start":"2026-06-10T11:00:18.323968Z","end":"2026-06-10T11:00:18.496961Z","steps":["trace[1586496383] 'read index received' (duration: 152.393657ms)","trace[1586496383] 'applied index is now lower than readState.Index' (duration: 20.598658ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:18.497077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.090988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:18.497103Z","caller":"traceutil/trace.go:171","msg":"trace[1128746143] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26072; }","duration":"173.16837ms","start":"2026-06-10T11:00:18.323926Z","end":"2026-06-10T11:00:18.497095Z","steps":["trace[1128746143] 'agreement among raft nodes before linearized reading' (duration: 173.106858ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.497068Z","caller":"traceutil/trace.go:171","msg":"trace[1155885350] transaction","detail":"{read_only:false; response_revision:26072; number_of_response:1; }","duration":"173.082928ms","start":"2026-06-10T11:00:18.323942Z","end":"2026-06-10T11:00:18.497025Z","steps":["trace[1155885350] 'process raft request' (duration: 152.404087ms)","trace[1155885350] 'compare' (duration: 20.527657ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:18.546825Z","caller":"traceutil/trace.go:171","msg":"trace[652016055] transaction","detail":"{read_only:false; response_revision:26074; number_of_response:1; }","duration":"117.473664ms","start":"2026-06-10T11:00:18.429334Z","end":"2026-06-10T11:00:18.546808Z","steps":["trace[652016055] 'process raft request' (duration: 117.404922ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.546864Z","caller":"traceutil/trace.go:171","msg":"trace[1690677615] transaction","detail":"{read_only:false; response_revision:26073; number_of_response:1; }","duration":"125.423682ms","start":"2026-06-10T11:00:18.42141Z","end":"2026-06-10T11:00:18.546834Z","steps":["trace[1690677615] 'process raft request' (duration: 125.230277ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:18.547036Z","caller":"traceutil/trace.go:171","msg":"trace[1035188642] transaction","detail":"{read_only:false; response_revision:26075; number_of_response:1; }","duration":"117.34965ms","start":"2026-06-10T11:00:18.429677Z","end":"2026-06-10T11:00:18.547026Z","steps":["trace[1035188642] 'process raft request' (duration: 117.095203ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:20.758936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.323096ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T11:00:20.759099Z","caller":"traceutil/trace.go:171","msg":"trace[402633011] transaction","detail":"{read_only:false; response_revision:26099; number_of_response:1; }","duration":"206.801069ms","start":"2026-06-10T11:00:20.552272Z","end":"2026-06-10T11:00:20.759073Z","steps":["trace[402633011] 'process raft request' (duration: 92.270267ms)","trace[402633011] 'compare' (duration: 114.07359ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:20.759363Z","caller":"traceutil/trace.go:171","msg":"trace[1126044027] transaction","detail":"{read_only:false; response_revision:26100; number_of_response:1; }","duration":"205.974227ms","start":"2026-06-10T11:00:20.553364Z","end":"2026-06-10T11:00:20.759338Z","steps":["trace[1126044027] 'process raft request' (duration: 205.644178ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:20.759447Z","caller":"traceutil/trace.go:171","msg":"trace[1606457717] linearizableReadLoop","detail":"{readStateIndex:26963; appliedIndex:26960; }","duration":"193.181984ms","start":"2026-06-10T11:00:20.566157Z","end":"2026-06-10T11:00:20.759339Z","steps":["trace[1606457717] 'read index received' (duration: 27.314804ms)","trace[1606457717] 'applied index is now lower than readState.Index' (duration: 165.86579ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:20.759534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.248495ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T11:00:20.759559Z","caller":"traceutil/trace.go:171","msg":"trace[870744610] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:26100; }","duration":"193.425361ms","start":"2026-06-10T11:00:20.566126Z","end":"2026-06-10T11:00:20.759551Z","steps":["trace[870744610] 'agreement among raft nodes before linearized reading' (duration: 193.239645ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:23.92458Z","caller":"traceutil/trace.go:171","msg":"trace[1183489401] transaction","detail":"{read_only:false; response_revision:26127; number_of_response:1; }","duration":"113.959926ms","start":"2026-06-10T11:00:23.81059Z","end":"2026-06-10T11:00:23.92455Z","steps":["trace[1183489401] 'process raft request' (duration: 80.145193ms)","trace[1183489401] 'compare' (duration: 33.229887ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:25.627245Z","caller":"traceutil/trace.go:171","msg":"trace[1732730818] transaction","detail":"{read_only:false; response_revision:26142; number_of_response:1; }","duration":"106.13996ms","start":"2026-06-10T11:00:25.521073Z","end":"2026-06-10T11:00:25.627213Z","steps":["trace[1732730818] 'process raft request' (duration: 46.71896ms)","trace[1732730818] 'compare' (duration: 59.272176ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:25.642436Z","caller":"traceutil/trace.go:171","msg":"trace[922457319] transaction","detail":"{read_only:false; response_revision:26143; number_of_response:1; }","duration":"119.763316ms","start":"2026-06-10T11:00:25.522647Z","end":"2026-06-10T11:00:25.64241Z","steps":["trace[922457319] 'process raft request' (duration: 119.616052ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:29.097983Z","caller":"traceutil/trace.go:171","msg":"trace[1213611792] linearizableReadLoop","detail":"{readStateIndex:27041; appliedIndex:27040; }","duration":"193.756859ms","start":"2026-06-10T11:00:28.904199Z","end":"2026-06-10T11:00:29.097956Z","steps":["trace[1213611792] 'read index received' (duration: 103.331832ms)","trace[1213611792] 'applied index is now lower than readState.Index' (duration: 90.423567ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:29.098024Z","caller":"traceutil/trace.go:171","msg":"trace[1067869085] transaction","detail":"{read_only:false; response_revision:26177; number_of_response:1; }","duration":"313.062733ms","start":"2026-06-10T11:00:28.78493Z","end":"2026-06-10T11:00:29.097992Z","steps":["trace[1067869085] 'process raft request' (duration: 222.613856ms)","trace[1067869085] 'compare' (duration: 89.581223ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:29.098132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:28.784906Z","time spent":"313.167816ms","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:29.098152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.933194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:29.098257Z","caller":"traceutil/trace.go:171","msg":"trace[1552472969] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26177; }","duration":"194.084378ms","start":"2026-06-10T11:00:28.904145Z","end":"2026-06-10T11:00:29.098229Z","steps":["trace[1552472969] 'agreement among raft nodes before linearized reading' (duration: 193.897573ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:29.852211Z","caller":"traceutil/trace.go:171","msg":"trace[87672497] linearizableReadLoop","detail":"{readStateIndex:27045; appliedIndex:27044; }","duration":"196.993059ms","start":"2026-06-10T11:00:29.655181Z","end":"2026-06-10T11:00:29.852174Z","steps":["trace[87672497] 'read index received' (duration: 196.529806ms)","trace[87672497] 'applied index is now lower than readState.Index' (duration: 460.892µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:29.852362Z","caller":"traceutil/trace.go:171","msg":"trace[333968668] transaction","detail":"{read_only:false; response_revision:26180; number_of_response:1; }","duration":"205.599836ms","start":"2026-06-10T11:00:29.646721Z","end":"2026-06-10T11:00:29.85232Z","steps":["trace[333968668] 'process raft request' (duration: 204.969858ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.852665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.448501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-10T11:00:29.852716Z","caller":"traceutil/trace.go:171","msg":"trace[1611064852] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26180; }","duration":"197.569764ms","start":"2026-06-10T11:00:29.655133Z","end":"2026-06-10T11:00:29.852703Z","steps":["trace[1611064852] 'agreement among raft nodes before linearized reading' (duration: 197.303397ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.742728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.083459468s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-10T11:00:34.742791Z","caller":"traceutil/trace.go:171","msg":"trace[1521235973] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.083564651s","start":"2026-06-10T11:00:32.659213Z","end":"2026-06-10T11:00:34.742777Z","steps":["trace[1521235973] 'agreement among raft nodes before linearized reading' (duration: 2.083492519s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.742834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.659194Z","time spent":"2.083631604s","remote":"127.0.0.1:42494","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T11:00:34.74346Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4500114935739573789,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T11:00:34.773001Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"2.134827027s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T11:00:34.783915Z","caller":"traceutil/trace.go:171","msg":"trace[1321142087] transaction","detail":"{read_only:false; response_revision:26194; number_of_response:1; }","duration":"2.14143207s","start":"2026-06-10T11:00:32.642454Z","end":"2026-06-10T11:00:34.783886Z","steps":["trace[1321142087] 'process raft request' (duration: 2.140279258s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.784077Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.642451Z","time spent":"2.141550343s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.784279Z","caller":"traceutil/trace.go:171","msg":"trace[1164011624] transaction","detail":"{read_only:false; response_revision:26192; number_of_response:1; }","duration":"2.14615734s","start":"2026-06-10T11:00:32.638115Z","end":"2026-06-10T11:00:34.784272Z","steps":["trace[1164011624] 'process raft request' (duration: 2.135185946s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.784311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.638107Z","time spent":"2.14618535s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.784377Z","caller":"traceutil/trace.go:171","msg":"trace[1597631409] transaction","detail":"{read_only:false; response_revision:26193; number_of_response:1; }","duration":"2.141995785s","start":"2026-06-10T11:00:32.642375Z","end":"2026-06-10T11:00:34.784371Z","steps":["trace[1597631409] 'process raft request' (duration: 2.140329429s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.784408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.642336Z","time spent":"2.142053757s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.784637Z","caller":"traceutil/trace.go:171","msg":"trace[484488734] transaction","detail":"{read_only:false; response_revision:26197; number_of_response:1; }","duration":"2.13707315s","start":"2026-06-10T11:00:32.647534Z","end":"2026-06-10T11:00:34.784608Z","steps":["trace[484488734] 'process raft request' (duration: 2.13525575s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.784685Z","caller":"traceutil/trace.go:171","msg":"trace[2091552718] transaction","detail":"{read_only:false; response_revision:26195; number_of_response:1; }","duration":"2.142184071s","start":"2026-06-10T11:00:32.642484Z","end":"2026-06-10T11:00:34.784668Z","steps":["trace[2091552718] 'process raft request' (duration: 2.140267878s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.784696Z","caller":"traceutil/trace.go:171","msg":"trace[1572723151] transaction","detail":"{read_only:false; response_revision:26196; number_of_response:1; }","duration":"2.142128039s","start":"2026-06-10T11:00:32.642559Z","end":"2026-06-10T11:00:34.784687Z","steps":["trace[1572723151] 'process raft request' (duration: 2.140215826s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.784754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.642552Z","time spent":"2.14218s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.784754Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.64248Z","time spent":"2.142232482s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.784753Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.647526Z","time spent":"2.137164522s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.784861Z","caller":"traceutil/trace.go:171","msg":"trace[612865920] transaction","detail":"{read_only:false; response_revision:26198; number_of_response:1; }","duration":"2.132086333s","start":"2026-06-10T11:00:32.652767Z","end":"2026-06-10T11:00:34.784854Z","steps":["trace[612865920] 'process raft request' (duration: 2.130044886s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.784902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.65275Z","time spent":"2.132126963s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.785073Z","caller":"traceutil/trace.go:171","msg":"trace[145394034] transaction","detail":"{read_only:false; response_revision:26199; number_of_response:1; }","duration":"2.126231612s","start":"2026-06-10T11:00:32.658834Z","end":"2026-06-10T11:00:34.785066Z","steps":["trace[145394034] 'process raft request' (duration: 2.12399594s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.785115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.658825Z","time spent":"2.126265262s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.793038Z","caller":"traceutil/trace.go:171","msg":"trace[1641853458] linearizableReadLoop","detail":"{readStateIndex:27065; appliedIndex:27056; }","duration":"2.15010656s","start":"2026-06-10T11:00:32.642918Z","end":"2026-06-10T11:00:34.793025Z","steps":["trace[1641853458] 'read index received' (duration: 2.130394075s)","trace[1641853458] 'applied index is now lower than readState.Index' (duration: 19.711985ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:34.793402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.150585563s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12217"} {"level":"info","ts":"2026-06-10T11:00:34.793428Z","caller":"traceutil/trace.go:171","msg":"trace[741693066] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26201; }","duration":"2.150628404s","start":"2026-06-10T11:00:32.642793Z","end":"2026-06-10T11:00:34.793421Z","steps":["trace[741693066] 'agreement among raft nodes before linearized reading' (duration: 2.150522781s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.793443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.64279Z","time spent":"2.150649104s","remote":"127.0.0.1:42686","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12240,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-10T11:00:34.79355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.150762647s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T11:00:34.793567Z","caller":"traceutil/trace.go:171","msg":"trace[1785148814] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26201; }","duration":"2.150793369s","start":"2026-06-10T11:00:32.64277Z","end":"2026-06-10T11:00:34.793563Z","steps":["trace[1785148814] 'agreement among raft nodes before linearized reading' (duration: 2.150747567s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.793579Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.642763Z","time spent":"2.150813509s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T11:00:34.793661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.15122621s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-10T11:00:34.79368Z","caller":"traceutil/trace.go:171","msg":"trace[47901520] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26201; }","duration":"2.151256982s","start":"2026-06-10T11:00:32.642419Z","end":"2026-06-10T11:00:34.793676Z","steps":["trace[47901520] 'agreement among raft nodes before linearized reading' (duration: 2.151211101s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.793693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.642415Z","time spent":"2.151274532s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T11:00:34.793769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.151357544s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-10T11:00:34.793787Z","caller":"traceutil/trace.go:171","msg":"trace[1384950002] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26201; }","duration":"2.151405716s","start":"2026-06-10T11:00:32.642375Z","end":"2026-06-10T11:00:34.793781Z","steps":["trace[1384950002] 'agreement among raft nodes before linearized reading' (duration: 2.151365435s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.793799Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.642344Z","time spent":"2.151451697s","remote":"127.0.0.1:42772","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T11:00:34.793874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.151799776s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:34.793887Z","caller":"traceutil/trace.go:171","msg":"trace[543248799] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:26201; }","duration":"2.151817667s","start":"2026-06-10T11:00:32.642065Z","end":"2026-06-10T11:00:34.793882Z","steps":["trace[543248799] 'agreement among raft nodes before linearized reading' (duration: 2.151787036s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.793903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.64204Z","time spent":"2.151858228s","remote":"127.0.0.1:52210","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":29,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"info","ts":"2026-06-10T11:00:45.661704Z","caller":"traceutil/trace.go:171","msg":"trace[1468551490] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"180.535741ms","start":"2026-06-10T11:00:45.481139Z","end":"2026-06-10T11:00:45.661675Z","steps":["trace[1468551490] 'process raft request' (duration: 180.354716ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:56.045839Z","caller":"traceutil/trace.go:171","msg":"trace[513921830] linearizableReadLoop","detail":"{readStateIndex:27240; appliedIndex:27239; }","duration":"137.340466ms","start":"2026-06-10T11:00:55.908478Z","end":"2026-06-10T11:00:56.045818Z","steps":["trace[513921830] 'read index received' (duration: 137.164781ms)","trace[513921830] 'applied index is now lower than readState.Index' (duration: 174.995µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:56.04612Z","caller":"traceutil/trace.go:171","msg":"trace[1677249728] transaction","detail":"{read_only:false; response_revision:26369; number_of_response:1; }","duration":"168.024397ms","start":"2026-06-10T11:00:55.878086Z","end":"2026-06-10T11:00:56.046111Z","steps":["trace[1677249728] 'process raft request' (duration: 167.604675ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:56.046314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.832409ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:56.04636Z","caller":"traceutil/trace.go:171","msg":"trace[1018492022] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26369; }","duration":"137.917022ms","start":"2026-06-10T11:00:55.908435Z","end":"2026-06-10T11:00:56.046352Z","steps":["trace[1018492022] 'agreement among raft nodes before linearized reading' (duration: 137.816579ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:56.349149Z","caller":"traceutil/trace.go:171","msg":"trace[173214529] transaction","detail":"{read_only:false; response_revision:26370; number_of_response:1; }","duration":"118.377246ms","start":"2026-06-10T11:00:56.230752Z","end":"2026-06-10T11:00:56.349129Z","steps":["trace[173214529] 'process raft request' (duration: 118.228192ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:56.402581Z","caller":"traceutil/trace.go:171","msg":"trace[157987569] transaction","detail":"{read_only:false; response_revision:26371; number_of_response:1; }","duration":"108.719761ms","start":"2026-06-10T11:00:56.293836Z","end":"2026-06-10T11:00:56.402556Z","steps":["trace[157987569] 'process raft request' (duration: 108.592267ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105233Z","caller":"traceutil/trace.go:171","msg":"trace[1678777780] transaction","detail":"{read_only:false; response_revision:26373; number_of_response:1; }","duration":"228.887345ms","start":"2026-06-10T11:00:56.876313Z","end":"2026-06-10T11:00:57.1052Z","steps":["trace[1678777780] 'process raft request' (duration: 213.676808ms)","trace[1678777780] 'compare' (duration: 14.168418ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:57.105255Z","caller":"traceutil/trace.go:171","msg":"trace[618089641] linearizableReadLoop","detail":"{readStateIndex:27250; appliedIndex:27243; }","duration":"214.707717ms","start":"2026-06-10T11:00:56.890525Z","end":"2026-06-10T11:00:57.105233Z","steps":["trace[618089641] 'read index received' (duration: 62.960707ms)","trace[618089641] 'applied index is now lower than readState.Index' (duration: 151.74606ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:57.105294Z","caller":"traceutil/trace.go:171","msg":"trace[196522533] transaction","detail":"{read_only:false; response_revision:26378; number_of_response:1; }","duration":"224.371341ms","start":"2026-06-10T11:00:56.880888Z","end":"2026-06-10T11:00:57.105259Z","steps":["trace[196522533] 'process raft request' (duration: 224.273669ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105292Z","caller":"traceutil/trace.go:171","msg":"trace[380235037] transaction","detail":"{read_only:false; response_revision:26376; number_of_response:1; }","duration":"224.958347ms","start":"2026-06-10T11:00:56.880284Z","end":"2026-06-10T11:00:57.105242Z","steps":["trace[380235037] 'process raft request' (duration: 224.793682ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105381Z","caller":"traceutil/trace.go:171","msg":"trace[1455676636] transaction","detail":"{read_only:false; response_revision:26379; number_of_response:1; }","duration":"223.766684ms","start":"2026-06-10T11:00:56.881598Z","end":"2026-06-10T11:00:57.105365Z","steps":["trace[1455676636] 'process raft request' (duration: 223.5973ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105481Z","caller":"traceutil/trace.go:171","msg":"trace[1745339901] transaction","detail":"{read_only:false; response_revision:26375; number_of_response:1; }","duration":"225.815241ms","start":"2026-06-10T11:00:56.879654Z","end":"2026-06-10T11:00:57.105469Z","steps":["trace[1745339901] 'process raft request' (duration: 225.382459ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105464Z","caller":"traceutil/trace.go:171","msg":"trace[1225215435] transaction","detail":"{read_only:false; response_revision:26377; number_of_response:1; }","duration":"224.795813ms","start":"2026-06-10T11:00:56.880643Z","end":"2026-06-10T11:00:57.105439Z","steps":["trace[1225215435] 'process raft request' (duration: 224.475894ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105479Z","caller":"traceutil/trace.go:171","msg":"trace[59754254] transaction","detail":"{read_only:false; response_revision:26374; number_of_response:1; }","duration":"229.05356ms","start":"2026-06-10T11:00:56.876411Z","end":"2026-06-10T11:00:57.105464Z","steps":["trace[59754254] 'process raft request' (duration: 228.551516ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:57.105628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.285465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-10T11:00:57.105665Z","caller":"traceutil/trace.go:171","msg":"trace[1430271557] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26379; }","duration":"214.351056ms","start":"2026-06-10T11:00:56.891303Z","end":"2026-06-10T11:00:57.105654Z","steps":["trace[1430271557] 'agreement among raft nodes before linearized reading' (duration: 214.210092ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:57.105708Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.172819ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-10T11:00:57.105716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.983122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-10T11:00:57.105753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.94242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T11:00:57.105754Z","caller":"traceutil/trace.go:171","msg":"trace[454276295] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26379; }","duration":"215.248022ms","start":"2026-06-10T11:00:56.890492Z","end":"2026-06-10T11:00:57.10574Z","steps":["trace[454276295] 'agreement among raft nodes before linearized reading' (duration: 215.105298ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105762Z","caller":"traceutil/trace.go:171","msg":"trace[2078041981] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26379; }","duration":"173.035304ms","start":"2026-06-10T11:00:56.93271Z","end":"2026-06-10T11:00:57.105746Z","steps":["trace[2078041981] 'agreement among raft nodes before linearized reading' (duration: 172.876229ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.105783Z","caller":"traceutil/trace.go:171","msg":"trace[1436179719] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26379; }","duration":"177.009732ms","start":"2026-06-10T11:00:56.928764Z","end":"2026-06-10T11:00:57.105774Z","steps":["trace[1436179719] 'agreement among raft nodes before linearized reading' (duration: 176.90368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:57.105794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.965311ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T11:00:57.105819Z","caller":"traceutil/trace.go:171","msg":"trace[2022236318] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26379; }","duration":"212.012032ms","start":"2026-06-10T11:00:56.8938Z","end":"2026-06-10T11:00:57.105812Z","steps":["trace[2022236318] 'agreement among raft nodes before linearized reading' (duration: 211.93584ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.325576Z","caller":"traceutil/trace.go:171","msg":"trace[1804675328] transaction","detail":"{read_only:false; response_revision:26382; number_of_response:1; }","duration":"214.196443ms","start":"2026-06-10T11:00:57.11136Z","end":"2026-06-10T11:00:57.325557Z","steps":["trace[1804675328] 'process raft request' (duration: 214.09297ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.32557Z","caller":"traceutil/trace.go:171","msg":"trace[147740532] transaction","detail":"{read_only:false; response_revision:26381; number_of_response:1; }","duration":"215.426857ms","start":"2026-06-10T11:00:57.11012Z","end":"2026-06-10T11:00:57.325547Z","steps":["trace[147740532] 'process raft request' (duration: 215.247552ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.325582Z","caller":"traceutil/trace.go:171","msg":"trace[616927396] transaction","detail":"{read_only:false; response_revision:26384; number_of_response:1; }","duration":"214.038139ms","start":"2026-06-10T11:00:57.111523Z","end":"2026-06-10T11:00:57.325561Z","steps":["trace[616927396] 'process raft request' (duration: 214.001688ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.325643Z","caller":"traceutil/trace.go:171","msg":"trace[1701565109] transaction","detail":"{read_only:false; response_revision:26383; number_of_response:1; }","duration":"214.145132ms","start":"2026-06-10T11:00:57.111488Z","end":"2026-06-10T11:00:57.325633Z","steps":["trace[1701565109] 'process raft request' (duration: 214.006638ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:57.32557Z","caller":"traceutil/trace.go:171","msg":"trace[88132671] transaction","detail":"{read_only:false; response_revision:26380; number_of_response:1; }","duration":"215.758636ms","start":"2026-06-10T11:00:57.10977Z","end":"2026-06-10T11:00:57.325529Z","steps":["trace[88132671] 'process raft request' (duration: 196.724174ms)","trace[88132671] 'compare' (duration: 18.349573ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:57.697669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.199727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:57.697744Z","caller":"traceutil/trace.go:171","msg":"trace[828577362] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:26385; }","duration":"263.31032ms","start":"2026-06-10T11:00:57.434414Z","end":"2026-06-10T11:00:57.697725Z","steps":["trace[828577362] 'count revisions from in-memory index tree' (duration: 263.141036ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:57.698417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.22802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-10T11:00:57.698466Z","caller":"traceutil/trace.go:171","msg":"trace[666639705] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:26385; }","duration":"212.312592ms","start":"2026-06-10T11:00:57.486142Z","end":"2026-06-10T11:00:57.698455Z","steps":["trace[666639705] 'count revisions from in-memory index tree' (duration: 212.164668ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:01:15.774291Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006b33.wal"} {"level":"info","ts":"2026-06-10T11:02:47.71914Z","caller":"traceutil/trace.go:171","msg":"trace[2079726423] transaction","detail":"{read_only:false; response_revision:27466; number_of_response:1; }","duration":"168.905752ms","start":"2026-06-10T11:02:47.550197Z","end":"2026-06-10T11:02:47.719103Z","steps":["trace[2079726423] 'process raft request' (duration: 168.669595ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:02:47.722571Z","caller":"traceutil/trace.go:171","msg":"trace[213198683] linearizableReadLoop","detail":"{readStateIndex:28363; appliedIndex:28361; }","duration":"165.251773ms","start":"2026-06-10T11:02:47.557287Z","end":"2026-06-10T11:02:47.722538Z","steps":["trace[213198683] 'read index received' (duration: 161.553733ms)","trace[213198683] 'applied index is now lower than readState.Index' (duration: 3.69572ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:02:47.722575Z","caller":"traceutil/trace.go:171","msg":"trace[1910337939] transaction","detail":"{read_only:false; response_revision:27467; number_of_response:1; }","duration":"170.6971ms","start":"2026-06-10T11:02:47.551852Z","end":"2026-06-10T11:02:47.722549Z","steps":["trace[1910337939] 'process raft request' (duration: 170.538536ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:02:47.722741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.434148ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystems/\" range_end:\"/registry/ceph.rook.io/cephfilesystems0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T11:02:47.722835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.012903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:02:47.722877Z","caller":"traceutil/trace.go:171","msg":"trace[1089364064] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystems/; range_end:/registry/ceph.rook.io/cephfilesystems0; response_count:0; response_revision:27467; }","duration":"165.587142ms","start":"2026-06-10T11:02:47.557274Z","end":"2026-06-10T11:02:47.722861Z","steps":["trace[1089364064] 'agreement among raft nodes before linearized reading' (duration: 165.374656ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:02:47.722934Z","caller":"traceutil/trace.go:171","msg":"trace[982788233] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:27467; }","duration":"114.151527ms","start":"2026-06-10T11:02:47.608753Z","end":"2026-06-10T11:02:47.722905Z","steps":["trace[982788233] 'agreement among raft nodes before linearized reading' (duration: 113.984012ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:03:25.89036Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":24920} {"level":"info","ts":"2026-06-10T11:03:26.048067Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":24920,"took":"154.47346ms","hash":2932843891,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":36716544,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-10T11:03:26.048124Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2932843891,"revision":24920,"compact-revision":21724} {"level":"info","ts":"2026-06-10T11:04:16.047941Z","caller":"traceutil/trace.go:171","msg":"trace[282108634] transaction","detail":"{read_only:false; response_revision:28344; number_of_response:1; }","duration":"123.987083ms","start":"2026-06-10T11:04:15.923644Z","end":"2026-06-10T11:04:16.047631Z","steps":["trace[282108634] 'process raft request' (duration: 123.760807ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:04:16.066447Z","caller":"traceutil/trace.go:171","msg":"trace[1971492239] transaction","detail":"{read_only:false; response_revision:28345; number_of_response:1; }","duration":"100.147357ms","start":"2026-06-10T11:04:15.966267Z","end":"2026-06-10T11:04:16.066415Z","steps":["trace[1971492239] 'process raft request' (duration: 85.616422ms)","trace[1971492239] 'compare' (duration: 13.903058ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:05:26.909068Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T11:05:26.913991Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-10T11:05:26.914072Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-10T11:08:25.896873Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":27779} {"level":"info","ts":"2026-06-10T11:08:26.030712Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":27779,"took":"130.337343ms","hash":731967898,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":33058816,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-10T11:08:26.030794Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":731967898,"revision":27779,"compact-revision":24920} {"level":"info","ts":"2026-06-10T11:13:25.907934Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30379} {"level":"info","ts":"2026-06-10T11:13:26.053652Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30379,"took":"139.548376ms","hash":3703425318,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":30289920,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T11:13:26.053728Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3703425318,"revision":30379,"compact-revision":27779} {"level":"info","ts":"2026-06-10T11:18:25.913653Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32630} {"level":"info","ts":"2026-06-10T11:18:26.052274Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32630,"took":"135.437608ms","hash":3875059355,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":29941760,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T11:18:26.052352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3875059355,"revision":32630,"compact-revision":30379} {"level":"info","ts":"2026-06-10T11:23:25.919904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":34865} {"level":"info","ts":"2026-06-10T11:23:26.048405Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":34865,"took":"125.110406ms","hash":2670053719,"current-db-size-bytes":56758272,"current-db-size":"57 MB","current-db-size-in-use-bytes":32739328,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-10T11:23:26.049414Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2670053719,"revision":34865,"compact-revision":32630} {"level":"info","ts":"2026-06-10T11:26:57.016658Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"b844c110b9783e73","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T11:26:57.022085Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-10T11:26:57.022219Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-10T11:28:25.926535Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37161} {"level":"info","ts":"2026-06-10T11:28:26.087858Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37161,"took":"156.0515ms","hash":2107164591,"current-db-size-bytes":58486784,"current-db-size":"58 MB","current-db-size-in-use-bytes":31408128,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T11:28:26.08792Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2107164591,"revision":37161,"compact-revision":34865}