{"level":"warn","ts":"2026-06-02T12:20:32.380828Z","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-02T12:20:32.380902Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.156: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.156:2380","--initial-cluster=instance=https://199.204.45.156:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.156:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.156: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-02T12:20:32.380955Z","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-02T12:20:32.380962Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-02T12:20:32.380978Z","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-02T12:20:32.381501Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"]} {"level":"info","ts":"2026-06-02T12:20:32.381568Z","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.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.156: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-02T12:20:32.384024Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.25081ms"} {"level":"info","ts":"2026-06-02T12:20:32.396228Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5ac240a6daec2148","cluster-id":"62163637a46c33c2"} {"level":"info","ts":"2026-06-02T12:20:32.396315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T12:20:32.396334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 0"} {"level":"info","ts":"2026-06-02T12:20:32.396344Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5ac240a6daec2148 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T12:20:32.396358Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became follower at term 1"} {"level":"info","ts":"2026-06-02T12:20:32.396416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"warn","ts":"2026-06-02T12:20:32.400655Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T12:20:32.403031Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T12:20:32.404876Z","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-02T12:20:32.406708Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5ac240a6daec2148","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T12:20:32.406956Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5ac240a6daec2148","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T12:20:32.407029Z","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-02T12:20:32.407144Z","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-02T12:20:32.407159Z","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-02T12:20:32.408074Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 switched to configuration voters=(6539860694277038408)"} {"level":"info","ts":"2026-06-02T12:20:32.408213Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","added-peer-id":"5ac240a6daec2148","added-peer-peer-urls":["https://199.204.45.156:2380"]} {"level":"info","ts":"2026-06-02T12:20:32.40908Z","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-02T12:20:32.409265Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5ac240a6daec2148","initial-advertise-peer-urls":["https://199.204.45.156:2380"],"listen-peer-urls":["https://199.204.45.156:2380"],"advertise-client-urls":["https://199.204.45.156:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.156:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T12:20:32.409268Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-02T12:20:32.409312Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T12:20:32.409328Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.156:2380"} {"level":"info","ts":"2026-06-02T12:20:32.997155Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T12:20:32.99723Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T12:20:32.997268Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgPreVoteResp from 5ac240a6daec2148 at term 1"} {"level":"info","ts":"2026-06-02T12:20:32.997287Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became candidate at term 2"} {"level":"info","ts":"2026-06-02T12:20:32.997298Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 received MsgVoteResp from 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-02T12:20:32.997315Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5ac240a6daec2148 became leader at term 2"} {"level":"info","ts":"2026-06-02T12:20:32.997328Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5ac240a6daec2148 elected leader 5ac240a6daec2148 at term 2"} {"level":"info","ts":"2026-06-02T12:20:32.998472Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5ac240a6daec2148","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.156:2379]}","request-path":"/0/members/5ac240a6daec2148/attributes","cluster-id":"62163637a46c33c2","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T12:20:32.998492Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:20:32.998687Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T12:20:32.998771Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T12:20:32.998827Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T12:20:32.999307Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T12:20:33.001537Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T12:20:33.002381Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.156:2379"} {"level":"info","ts":"2026-06-02T12:20:33.002615Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"62163637a46c33c2","local-member-id":"5ac240a6daec2148","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:20:33.002717Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:20:33.002751Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T12:20:55.413067Z","caller":"traceutil/trace.go:171","msg":"trace[136161709] transaction","detail":"{read_only:false; response_revision:408; number_of_response:1; }","duration":"191.366048ms","start":"2026-06-02T12:20:55.221681Z","end":"2026-06-02T12:20:55.413047Z","steps":["trace[136161709] 'process raft request' (duration: 191.206975ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:21:00.594465Z","caller":"traceutil/trace.go:171","msg":"trace[714598628] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"134.462255ms","start":"2026-06-02T12:21:00.459978Z","end":"2026-06-02T12:21:00.59444Z","steps":["trace[714598628] 'process raft request' (duration: 134.301322ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:21:17.028831Z","caller":"traceutil/trace.go:171","msg":"trace[183471426] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"113.326051ms","start":"2026-06-02T12:21:16.915479Z","end":"2026-06-02T12:21:17.028805Z","steps":["trace[183471426] 'process raft request' (duration: 112.797701ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:21:17.4847Z","caller":"traceutil/trace.go:171","msg":"trace[627876280] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:635; }","duration":"378.041474ms","start":"2026-06-02T12:21:17.106621Z","end":"2026-06-02T12:21:17.484662Z","steps":["trace[627876280] 'read index received' (duration: 4.842806ms)","trace[627876280] 'applied index is now lower than readState.Index' (duration: 373.197008ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:21:17.484724Z","caller":"traceutil/trace.go:171","msg":"trace[1132491630] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"388.359146ms","start":"2026-06-02T12:21:17.096331Z","end":"2026-06-02T12:21:17.48469Z","steps":["trace[1132491630] 'process raft request' (duration: 315.557991ms)","trace[1132491630] 'compare' (duration: 72.456389ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:21:17.484995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.355471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-06-02T12:21:17.485728Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:21:17.096314Z","time spent":"388.483249ms","remote":"127.0.0.1:59530","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T12:21:17.486242Z","caller":"traceutil/trace.go:171","msg":"trace[257370145] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:615; }","duration":"378.500532ms","start":"2026-06-02T12:21:17.106574Z","end":"2026-06-02T12:21:17.485075Z","steps":["trace[257370145] 'agreement among raft nodes before linearized reading' (duration: 378.192567ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:21:17.486317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:21:17.10656Z","time spent":"379.742725ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":527,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T12:21:17.930763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.316248ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:21:17.93092Z","caller":"traceutil/trace.go:171","msg":"trace[1426032478] linearizableReadLoop","detail":"{readStateIndex:638; appliedIndex:637; }","duration":"430.816316ms","start":"2026-06-02T12:21:17.500082Z","end":"2026-06-02T12:21:17.930899Z","steps":["trace[1426032478] 'read index received' (duration: 264.970569ms)","trace[1426032478] 'applied index is now lower than readState.Index' (duration: 165.844127ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:21:17.930941Z","caller":"traceutil/trace.go:171","msg":"trace[1743383757] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"437.455033ms","start":"2026-06-02T12:21:17.49346Z","end":"2026-06-02T12:21:17.930915Z","steps":["trace[1743383757] 'process raft request' (duration: 271.507224ms)","trace[1743383757] 'compare' (duration: 164.87549ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:21:17.931006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.922778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:21:17.931043Z","caller":"traceutil/trace.go:171","msg":"trace[1870901113] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:616; }","duration":"430.964679ms","start":"2026-06-02T12:21:17.500064Z","end":"2026-06-02T12:21:17.931029Z","steps":["trace[1870901113] 'agreement among raft nodes before linearized reading' (duration: 430.892948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:21:17.931082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:21:17.49343Z","time spent":"437.571925ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T12:21:17.931095Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T12:21:17.500016Z","time spent":"431.069191ms","remote":"127.0.0.1:59722","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"info","ts":"2026-06-02T12:22:50.633353Z","caller":"traceutil/trace.go:171","msg":"trace[1002588836] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1929; }","duration":"103.94808ms","start":"2026-06-02T12:22:50.529371Z","end":"2026-06-02T12:22:50.633319Z","steps":["trace[1002588836] 'read index received' (duration: 103.716116ms)","trace[1002588836] 'applied index is now lower than readState.Index' (duration: 230.034µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:22:50.633443Z","caller":"traceutil/trace.go:171","msg":"trace[1426354774] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"230.031361ms","start":"2026-06-02T12:22:50.403374Z","end":"2026-06-02T12:22:50.633406Z","steps":["trace[1426354774] 'process raft request' (duration: 229.701625ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:22:50.633661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.235755ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-8dd13361-cb04-4d97-bd31-cf1ee6b27baa\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-06-02T12:22:50.633748Z","caller":"traceutil/trace.go:171","msg":"trace[1806248541] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-8dd13361-cb04-4d97-bd31-cf1ee6b27baa; range_end:; response_count:1; response_revision:1861; }","duration":"104.425099ms","start":"2026-06-02T12:22:50.529305Z","end":"2026-06-02T12:22:50.63373Z","steps":["trace[1806248541] 'agreement among raft nodes before linearized reading' (duration: 104.153274ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:22:50.702337Z","caller":"traceutil/trace.go:171","msg":"trace[1912342624] transaction","detail":"{read_only:false; response_revision:1862; number_of_response:1; }","duration":"166.567153ms","start":"2026-06-02T12:22:50.535743Z","end":"2026-06-02T12:22:50.702311Z","steps":["trace[1912342624] 'process raft request' (duration: 133.459112ms)","trace[1912342624] 'compare' (duration: 33.001169ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:23:03.11907Z","caller":"traceutil/trace.go:171","msg":"trace[234247674] transaction","detail":"{read_only:false; response_revision:1966; number_of_response:1; }","duration":"129.805272ms","start":"2026-06-02T12:23:02.98924Z","end":"2026-06-02T12:23:03.119046Z","steps":["trace[234247674] 'process raft request' (duration: 129.644409ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:23:35.495804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.048501ms","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-02T12:23:35.495901Z","caller":"traceutil/trace.go:171","msg":"trace[1536501985] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2156; }","duration":"159.185994ms","start":"2026-06-02T12:23:35.336697Z","end":"2026-06-02T12:23:35.495883Z","steps":["trace[1536501985] 'range keys from in-memory index tree' (duration: 158.902579ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:23:41.689965Z","caller":"traceutil/trace.go:171","msg":"trace[544703231] linearizableReadLoop","detail":"{readStateIndex:2272; appliedIndex:2271; }","duration":"144.599645ms","start":"2026-06-02T12:23:41.545339Z","end":"2026-06-02T12:23:41.689939Z","steps":["trace[544703231] 'read index received' (duration: 111.115097ms)","trace[544703231] 'applied index is now lower than readState.Index' (duration: 33.483178ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:23:41.69018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.845451ms","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-02T12:23:41.69014Z","caller":"traceutil/trace.go:171","msg":"trace[741899943] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"177.202557ms","start":"2026-06-02T12:23:41.512885Z","end":"2026-06-02T12:23:41.690088Z","steps":["trace[741899943] 'process raft request' (duration: 143.564175ms)","trace[741899943] 'compare' (duration: 33.118842ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:23:41.690217Z","caller":"traceutil/trace.go:171","msg":"trace[1295752223] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2191; }","duration":"144.969323ms","start":"2026-06-02T12:23:41.545237Z","end":"2026-06-02T12:23:41.690207Z","steps":["trace[1295752223] 'agreement among raft nodes before linearized reading' (duration: 144.804699ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:23:42.061417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.338161ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:23:42.061508Z","caller":"traceutil/trace.go:171","msg":"trace[400119595] linearizableReadLoop","detail":"{readStateIndex:2274; appliedIndex:2273; }","duration":"150.07173ms","start":"2026-06-02T12:23:41.91142Z","end":"2026-06-02T12:23:42.061492Z","steps":["trace[400119595] 'read index received' (duration: 5.543775ms)","trace[400119595] 'applied index is now lower than readState.Index' (duration: 144.527075ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:23:42.061558Z","caller":"traceutil/trace.go:171","msg":"trace[628179287] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"219.951043ms","start":"2026-06-02T12:23:41.841569Z","end":"2026-06-02T12:23:42.06152Z","steps":["trace[628179287] 'process raft request' (duration: 75.423878ms)","trace[628179287] 'compare' (duration: 144.058435ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:23:42.061606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.032016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:23:42.061666Z","caller":"traceutil/trace.go:171","msg":"trace[2130162066] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2193; }","duration":"122.114287ms","start":"2026-06-02T12:23:41.939539Z","end":"2026-06-02T12:23:42.061654Z","steps":["trace[2130162066] 'agreement among raft nodes before linearized reading' (duration: 122.039456ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:23:42.061979Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.542709ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-02T12:23:42.062084Z","caller":"traceutil/trace.go:171","msg":"trace[2143283569] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2193; }","duration":"150.701512ms","start":"2026-06-02T12:23:41.911336Z","end":"2026-06-02T12:23:42.062038Z","steps":["trace[2143283569] 'agreement among raft nodes before linearized reading' (duration: 150.226793ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:28:52.956389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.918431ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:28:52.956532Z","caller":"traceutil/trace.go:171","msg":"trace[671409681] transaction","detail":"{read_only:false; response_revision:4853; number_of_response:1; }","duration":"216.732343ms","start":"2026-06-02T12:28:52.739776Z","end":"2026-06-02T12:28:52.956508Z","steps":["trace[671409681] 'process raft request' (duration: 53.603757ms)","trace[671409681] 'compare' (duration: 162.796129ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:28:52.972805Z","caller":"traceutil/trace.go:171","msg":"trace[580313985] transaction","detail":"{read_only:false; response_revision:4854; number_of_response:1; }","duration":"232.687006ms","start":"2026-06-02T12:28:52.740081Z","end":"2026-06-02T12:28:52.972768Z","steps":["trace[580313985] 'process raft request' (duration: 232.427042ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:28:52.972975Z","caller":"traceutil/trace.go:171","msg":"trace[1681716993] linearizableReadLoop","detail":"{readStateIndex:5039; appliedIndex:5037; }","duration":"171.640921ms","start":"2026-06-02T12:28:52.801303Z","end":"2026-06-02T12:28:52.972944Z","steps":["trace[1681716993] 'read index received' (duration: 171.236184ms)","trace[1681716993] 'applied index is now lower than readState.Index' (duration: 402.737µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:28:52.973036Z","caller":"traceutil/trace.go:171","msg":"trace[1637587688] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"197.173972ms","start":"2026-06-02T12:28:52.775832Z","end":"2026-06-02T12:28:52.973006Z","steps":["trace[1637587688] 'process raft request' (duration: 196.887047ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:28:52.973236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.914756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hhb7\" ","response":"range_response_count:1 size:6524"} {"level":"info","ts":"2026-06-02T12:28:52.973266Z","caller":"traceutil/trace.go:171","msg":"trace[408093150] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hhb7; range_end:; response_count:1; response_revision:4855; }","duration":"171.996938ms","start":"2026-06-02T12:28:52.801261Z","end":"2026-06-02T12:28:52.973257Z","steps":["trace[408093150] 'agreement among raft nodes before linearized reading' (duration: 171.823645ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:29:08.537051Z","caller":"traceutil/trace.go:171","msg":"trace[205331264] transaction","detail":"{read_only:false; response_revision:5236; number_of_response:1; }","duration":"110.272702ms","start":"2026-06-02T12:29:08.426753Z","end":"2026-06-02T12:29:08.537026Z","steps":["trace[205331264] 'process raft request' (duration: 20.929819ms)","trace[205331264] 'compare' (duration: 88.845204ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:29:15.930459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.517731ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:29:15.930638Z","caller":"traceutil/trace.go:171","msg":"trace[193819013] transaction","detail":"{read_only:false; response_revision:5407; number_of_response:1; }","duration":"156.278991ms","start":"2026-06-02T12:29:15.774325Z","end":"2026-06-02T12:29:15.930604Z","steps":["trace[193819013] 'process raft request' (duration: 40.506625ms)","trace[193819013] 'compare' (duration: 115.357448ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:29:16.177736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.107184ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:39"} {"level":"info","ts":"2026-06-02T12:30:33.089644Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2989} {"level":"info","ts":"2026-06-02T12:30:33.154783Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2989,"took":"63.789276ms","hash":2603100932,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":34177024,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-02T12:30:33.154903Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2603100932,"revision":2989,"compact-revision":-1} {"level":"info","ts":"2026-06-02T12:35:32.414651Z","caller":"traceutil/trace.go:171","msg":"trace[436186019] transaction","detail":"{read_only:false; response_revision:8287; number_of_response:1; }","duration":"233.998344ms","start":"2026-06-02T12:35:32.180629Z","end":"2026-06-02T12:35:32.414628Z","steps":["trace[436186019] 'process raft request' (duration: 233.841191ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:35:33.095995Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6102} {"level":"info","ts":"2026-06-02T12:35:33.190874Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6102,"took":"92.487961ms","hash":2696704108,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":23461888,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-02T12:35:33.190947Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2696704108,"revision":6102,"compact-revision":2989} {"level":"warn","ts":"2026-06-02T12:36:12.5938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.552909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T12:36:12.5939Z","caller":"traceutil/trace.go:171","msg":"trace[414081561] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:8553; }","duration":"280.705392ms","start":"2026-06-02T12:36:12.313175Z","end":"2026-06-02T12:36:12.593881Z","steps":["trace[414081561] 'count revisions from in-memory index tree' (duration: 280.457877ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:36:16.246936Z","caller":"traceutil/trace.go:171","msg":"trace[1876622959] transaction","detail":"{read_only:false; response_revision:8571; number_of_response:1; }","duration":"244.47886ms","start":"2026-06-02T12:36:16.002422Z","end":"2026-06-02T12:36:16.246901Z","steps":["trace[1876622959] 'process raft request' (duration: 188.310354ms)","trace[1876622959] 'compare' (duration: 55.845071ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:36:16.247035Z","caller":"traceutil/trace.go:171","msg":"trace[570846026] transaction","detail":"{read_only:false; response_revision:8572; number_of_response:1; }","duration":"211.619693ms","start":"2026-06-02T12:36:16.035393Z","end":"2026-06-02T12:36:16.247012Z","steps":["trace[570846026] 'process raft request' (duration: 211.48657ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:36:16.247025Z","caller":"traceutil/trace.go:171","msg":"trace[1460799490] linearizableReadLoop","detail":"{readStateIndex:8873; appliedIndex:8871; }","duration":"198.308522ms","start":"2026-06-02T12:36:16.048678Z","end":"2026-06-02T12:36:16.246987Z","steps":["trace[1460799490] 'read index received' (duration: 40.782347ms)","trace[1460799490] 'applied index is now lower than readState.Index' (duration: 157.524115ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:36:16.247271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.567806ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-06-02T12:36:16.247369Z","caller":"traceutil/trace.go:171","msg":"trace[1750691688] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:8572; }","duration":"198.69977ms","start":"2026-06-02T12:36:16.048654Z","end":"2026-06-02T12:36:16.247354Z","steps":["trace[1750691688] 'agreement among raft nodes before linearized reading' (duration: 198.443695ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:36:16.247647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.467982ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-06-02T12:36:16.247699Z","caller":"traceutil/trace.go:171","msg":"trace[448844120] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8572; }","duration":"124.567704ms","start":"2026-06-02T12:36:16.12312Z","end":"2026-06-02T12:36:16.247687Z","steps":["trace[448844120] 'agreement among raft nodes before linearized reading' (duration: 124.37254ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:36:24.577676Z","caller":"traceutil/trace.go:171","msg":"trace[851143390] transaction","detail":"{read_only:false; response_revision:8662; number_of_response:1; }","duration":"106.794969ms","start":"2026-06-02T12:36:24.47085Z","end":"2026-06-02T12:36:24.577645Z","steps":["trace[851143390] 'process raft request' (duration: 106.595435ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:36:24.83741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.507581ms","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-02T12:36:24.837548Z","caller":"traceutil/trace.go:171","msg":"trace[873949753] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8662; }","duration":"160.667064ms","start":"2026-06-02T12:36:24.676855Z","end":"2026-06-02T12:36:24.837522Z","steps":["trace[873949753] 'range keys from in-memory index tree' (duration: 160.277176ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:36:25.392408Z","caller":"traceutil/trace.go:171","msg":"trace[1224820780] transaction","detail":"{read_only:false; response_revision:8668; number_of_response:1; }","duration":"111.841534ms","start":"2026-06-02T12:36:25.280533Z","end":"2026-06-02T12:36:25.392374Z","steps":["trace[1224820780] 'process raft request' (duration: 111.642671ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:36:25.705246Z","caller":"traceutil/trace.go:171","msg":"trace[2005752565] transaction","detail":"{read_only:false; response_revision:8669; number_of_response:1; }","duration":"102.920278ms","start":"2026-06-02T12:36:25.602302Z","end":"2026-06-02T12:36:25.705222Z","steps":["trace[2005752565] 'process raft request' (duration: 102.777395ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:36:46.28252Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002402.wal"} {"level":"warn","ts":"2026-06-02T12:37:43.376224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.046364ms","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-02T12:37:43.376427Z","caller":"traceutil/trace.go:171","msg":"trace[2134039388] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9421; }","duration":"128.324079ms","start":"2026-06-02T12:37:43.248078Z","end":"2026-06-02T12:37:43.376402Z","steps":["trace[2134039388] 'range keys from in-memory index tree' (duration: 127.744858ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:38:17.254717Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T12:38:17.261379Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-02T12:38:17.261483Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-02T12:40:33.10311Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8291} {"level":"info","ts":"2026-06-02T12:40:33.182323Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8291,"took":"77.052546ms","hash":810848038,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":26140672,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-02T12:40:33.182399Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":810848038,"revision":8291,"compact-revision":6102} {"level":"info","ts":"2026-06-02T12:45:33.109918Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10775} {"level":"info","ts":"2026-06-02T12:45:33.186557Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10775,"took":"74.164526ms","hash":4186435728,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":26931200,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-02T12:45:33.186629Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4186435728,"revision":10775,"compact-revision":8291} {"level":"warn","ts":"2026-06-02T12:47:56.39236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.917571ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T12:47:56.392574Z","caller":"traceutil/trace.go:171","msg":"trace[865757539] transaction","detail":"{read_only:false; response_revision:13880; number_of_response:1; }","duration":"297.648665ms","start":"2026-06-02T12:47:56.09491Z","end":"2026-06-02T12:47:56.392559Z","steps":["trace[865757539] 'process raft request' (duration: 34.446038ms)","trace[865757539] 'compare' (duration: 262.757109ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:47:56.570723Z","caller":"traceutil/trace.go:171","msg":"trace[611516028] transaction","detail":"{read_only:false; response_revision:13882; number_of_response:1; }","duration":"172.255737ms","start":"2026-06-02T12:47:56.39843Z","end":"2026-06-02T12:47:56.570685Z","steps":["trace[611516028] 'process raft request' (duration: 145.422513ms)","trace[611516028] 'compare' (duration: 26.60589ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:48:06.02014Z","caller":"traceutil/trace.go:171","msg":"trace[539071924] transaction","detail":"{read_only:false; response_revision:14048; number_of_response:1; }","duration":"128.27795ms","start":"2026-06-02T12:48:05.891817Z","end":"2026-06-02T12:48:06.020095Z","steps":["trace[539071924] 'process raft request' (duration: 109.529678ms)","trace[539071924] 'compare' (duration: 17.756043ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:48:06.216606Z","caller":"traceutil/trace.go:171","msg":"trace[1971399849] linearizableReadLoop","detail":"{readStateIndex:14526; appliedIndex:14525; }","duration":"133.913446ms","start":"2026-06-02T12:48:06.082662Z","end":"2026-06-02T12:48:06.216576Z","steps":["trace[1971399849] 'read index received' (duration: 127.976624ms)","trace[1971399849] 'applied index is now lower than readState.Index' (duration: 5.932842ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T12:48:06.21685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.173792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.156\" ","response":"range_response_count:1 size:138"} {"level":"info","ts":"2026-06-02T12:48:06.216912Z","caller":"traceutil/trace.go:171","msg":"trace[586005592] transaction","detail":"{read_only:false; response_revision:14049; number_of_response:1; }","duration":"189.90396ms","start":"2026-06-02T12:48:06.026972Z","end":"2026-06-02T12:48:06.216876Z","steps":["trace[586005592] 'process raft request' (duration: 183.799575ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:48:06.216944Z","caller":"traceutil/trace.go:171","msg":"trace[825321705] range","detail":"{range_begin:/registry/masterleases/199.204.45.156; range_end:; response_count:1; response_revision:14049; }","duration":"134.289804ms","start":"2026-06-02T12:48:06.082592Z","end":"2026-06-02T12:48:06.216881Z","steps":["trace[825321705] 'agreement among raft nodes before linearized reading' (duration: 134.102331ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:50:33.11841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12849} {"level":"info","ts":"2026-06-02T12:50:33.196345Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12849,"took":"75.093971ms","hash":3616104063,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":30502912,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-02T12:50:33.196412Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3616104063,"revision":12849,"compact-revision":10775} {"level":"warn","ts":"2026-06-02T12:55:29.613727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.19979ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-vjngd\" ","response":"range_response_count:1 size:20866"} {"level":"info","ts":"2026-06-02T12:55:29.613811Z","caller":"traceutil/trace.go:171","msg":"trace[422758592] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-vjngd; range_end:; response_count:1; response_revision:17773; }","duration":"217.313973ms","start":"2026-06-02T12:55:29.396479Z","end":"2026-06-02T12:55:29.613793Z","steps":["trace[422758592] 'range keys from in-memory index tree' (duration: 217.028487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:55:29.614125Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.792433ms","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-02T12:55:29.614165Z","caller":"traceutil/trace.go:171","msg":"trace[1479642102] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:17773; }","duration":"207.871295ms","start":"2026-06-02T12:55:29.406284Z","end":"2026-06-02T12:55:29.614155Z","steps":["trace[1479642102] 'range keys from in-memory index tree' (duration: 207.699831ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:55:29.614392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.901095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/referencegrants/\" range_end:\"/registry/gateway.networking.k8s.io/referencegrants0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T12:55:29.614463Z","caller":"traceutil/trace.go:171","msg":"trace[2001047998] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/referencegrants/; range_end:/registry/gateway.networking.k8s.io/referencegrants0; response_count:0; response_revision:17773; }","duration":"191.999476ms","start":"2026-06-02T12:55:29.422451Z","end":"2026-06-02T12:55:29.61445Z","steps":["trace[2001047998] 'count revisions from in-memory index tree' (duration: 191.827464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:55:30.123801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.193171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T12:55:30.123914Z","caller":"traceutil/trace.go:171","msg":"trace[758223786] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17774; }","duration":"183.392454ms","start":"2026-06-02T12:55:29.940498Z","end":"2026-06-02T12:55:30.123891Z","steps":["trace[758223786] 'range keys from in-memory index tree' (duration: 183.066609ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:55:30.136393Z","caller":"traceutil/trace.go:171","msg":"trace[2036386226] linearizableReadLoop","detail":"{readStateIndex:18369; appliedIndex:18368; }","duration":"152.484924ms","start":"2026-06-02T12:55:29.983875Z","end":"2026-06-02T12:55:30.13636Z","steps":["trace[2036386226] 'read index received' (duration: 152.203189ms)","trace[2036386226] 'applied index is now lower than readState.Index' (duration: 280.005µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T12:55:30.136505Z","caller":"traceutil/trace.go:171","msg":"trace[291008993] transaction","detail":"{read_only:false; response_revision:17775; number_of_response:1; }","duration":"180.366948ms","start":"2026-06-02T12:55:29.956102Z","end":"2026-06-02T12:55:30.136469Z","steps":["trace[291008993] 'process raft request' (duration: 180.071213ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T12:55:30.136707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.817401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-7vds2\" ","response":"range_response_count:1 size:9797"} {"level":"warn","ts":"2026-06-02T12:55:30.136736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.371016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-06-02T12:55:30.136759Z","caller":"traceutil/trace.go:171","msg":"trace[599415814] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-7vds2; range_end:; response_count:1; response_revision:17775; }","duration":"152.953473ms","start":"2026-06-02T12:55:29.983793Z","end":"2026-06-02T12:55:30.136746Z","steps":["trace[599415814] 'agreement among raft nodes before linearized reading' (duration: 152.751019ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:55:30.136803Z","caller":"traceutil/trace.go:171","msg":"trace[1574492505] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:17775; }","duration":"132.493969ms","start":"2026-06-02T12:55:30.004287Z","end":"2026-06-02T12:55:30.136781Z","steps":["trace[1574492505] 'agreement among raft nodes before linearized reading' (duration: 132.306785ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T12:55:33.124088Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15443} {"level":"info","ts":"2026-06-02T12:55:33.218169Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15443,"took":"91.669972ms","hash":304002356,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":32534528,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-02T12:55:33.218275Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":304002356,"revision":15443,"compact-revision":12849} {"level":"info","ts":"2026-06-02T12:58:45.239266Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T12:58:45.244289Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-02T12:58:45.244394Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-02T13:00:33.131503Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17811} {"level":"info","ts":"2026-06-02T13:00:33.224902Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17811,"took":"90.038809ms","hash":2977272313,"current-db-size-bytes":57417728,"current-db-size":"57 MB","current-db-size-in-use-bytes":34643968,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-02T13:00:33.224973Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2977272313,"revision":17811,"compact-revision":15443} {"level":"info","ts":"2026-06-02T13:00:38.075705Z","caller":"traceutil/trace.go:171","msg":"trace[888616624] transaction","detail":"{read_only:false; response_revision:20232; number_of_response:1; }","duration":"130.39638ms","start":"2026-06-02T13:00:37.945287Z","end":"2026-06-02T13:00:38.075684Z","steps":["trace[888616624] 'process raft request' (duration: 130.265398ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:00:43.772405Z","caller":"traceutil/trace.go:171","msg":"trace[1547803879] transaction","detail":"{read_only:false; response_revision:20262; number_of_response:1; }","duration":"125.895706ms","start":"2026-06-02T13:00:43.646479Z","end":"2026-06-02T13:00:43.772375Z","steps":["trace[1547803879] 'process raft request' (duration: 125.756083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:00:43.919512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.826726ms","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-02T13:00:43.919598Z","caller":"traceutil/trace.go:171","msg":"trace[593318040] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20262; }","duration":"142.01535ms","start":"2026-06-02T13:00:43.777564Z","end":"2026-06-02T13:00:43.919579Z","steps":["trace[593318040] 'range keys from in-memory index tree' (duration: 141.654302ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:00:44.22519Z","caller":"traceutil/trace.go:171","msg":"trace[562163106] linearizableReadLoop","detail":"{readStateIndex:20941; appliedIndex:20940; }","duration":"262.265309ms","start":"2026-06-02T13:00:43.962901Z","end":"2026-06-02T13:00:44.225166Z","steps":["trace[562163106] 'read index received' (duration: 262.213158ms)","trace[562163106] 'applied index is now lower than readState.Index' (duration: 51.301µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:00:44.225499Z","caller":"traceutil/trace.go:171","msg":"trace[1332203907] transaction","detail":"{read_only:false; response_revision:20263; number_of_response:1; }","duration":"302.008659ms","start":"2026-06-02T13:00:43.923456Z","end":"2026-06-02T13:00:44.225464Z","steps":["trace[1332203907] 'process raft request' (duration: 301.569801ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:00:44.225715Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:00:43.923431Z","time spent":"302.149242ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:00:44.22576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.85573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"} {"level":"info","ts":"2026-06-02T13:00:44.225818Z","caller":"traceutil/trace.go:171","msg":"trace[340820754] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:20263; }","duration":"262.954612ms","start":"2026-06-02T13:00:43.962846Z","end":"2026-06-02T13:00:44.225801Z","steps":["trace[340820754] 'agreement among raft nodes before linearized reading' (duration: 262.742898ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:00:44.459349Z","caller":"traceutil/trace.go:171","msg":"trace[1636568815] linearizableReadLoop","detail":"{readStateIndex:20942; appliedIndex:20941; }","duration":"234.062977ms","start":"2026-06-02T13:00:44.22526Z","end":"2026-06-02T13:00:44.459323Z","steps":["trace[1636568815] 'read index received' (duration: 171.426154ms)","trace[1636568815] 'applied index is now lower than readState.Index' (duration: 62.635783ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:00:44.459475Z","caller":"traceutil/trace.go:171","msg":"trace[996302147] transaction","detail":"{read_only:false; response_revision:20264; number_of_response:1; }","duration":"364.293444ms","start":"2026-06-02T13:00:44.09517Z","end":"2026-06-02T13:00:44.459463Z","steps":["trace[996302147] 'process raft request' (duration: 301.594461ms)","trace[996302147] 'compare' (duration: 62.428398ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:00:44.459571Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:00:44.095139Z","time spent":"364.362505ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:00:44.459803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.498389ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-8dd13361-cb04-4d97-bd31-cf1ee6b27baa\" ","response":"range_response_count:1 size:1304"} {"level":"info","ts":"2026-06-02T13:00:44.459866Z","caller":"traceutil/trace.go:171","msg":"trace[216740644] range","detail":"{range_begin:/registry/persistentvolumes/pvc-8dd13361-cb04-4d97-bd31-cf1ee6b27baa; range_end:; response_count:1; response_revision:20264; }","duration":"230.60156ms","start":"2026-06-02T13:00:44.229251Z","end":"2026-06-02T13:00:44.459852Z","steps":["trace[216740644] 'agreement among raft nodes before linearized reading' (duration: 230.331585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:00:44.460062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.827542ms","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-02T13:00:44.460145Z","caller":"traceutil/trace.go:171","msg":"trace[315201779] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20264; }","duration":"322.957824ms","start":"2026-06-02T13:00:44.137165Z","end":"2026-06-02T13:00:44.460123Z","steps":["trace[315201779] 'agreement among raft nodes before linearized reading' (duration: 322.594987ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:00:44.460197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:00:44.137142Z","time spent":"323.041615ms","remote":"127.0.0.1:59432","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":"info","ts":"2026-06-02T13:00:45.089554Z","caller":"traceutil/trace.go:171","msg":"trace[1649822026] linearizableReadLoop","detail":"{readStateIndex:20946; appliedIndex:20944; }","duration":"147.850249ms","start":"2026-06-02T13:00:44.941679Z","end":"2026-06-02T13:00:45.089529Z","steps":["trace[1649822026] 'read index received' (duration: 96.226215ms)","trace[1649822026] 'applied index is now lower than readState.Index' (duration: 51.622954ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:00:45.089893Z","caller":"traceutil/trace.go:171","msg":"trace[1082353503] transaction","detail":"{read_only:false; response_revision:20267; number_of_response:1; }","duration":"188.547777ms","start":"2026-06-02T13:00:44.901324Z","end":"2026-06-02T13:00:45.089872Z","steps":["trace[1082353503] 'process raft request' (duration: 136.591377ms)","trace[1082353503] 'compare' (duration: 50.967142ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:00:45.090023Z","caller":"traceutil/trace.go:171","msg":"trace[2038872567] transaction","detail":"{read_only:false; response_revision:20268; number_of_response:1; }","duration":"187.215092ms","start":"2026-06-02T13:00:44.902782Z","end":"2026-06-02T13:00:45.089997Z","steps":["trace[2038872567] 'process raft request' (duration: 186.698852ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:00:45.090229Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.546063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:00:45.090268Z","caller":"traceutil/trace.go:171","msg":"trace[1191544252] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20268; }","duration":"148.670946ms","start":"2026-06-02T13:00:44.941585Z","end":"2026-06-02T13:00:45.090256Z","steps":["trace[1191544252] 'agreement among raft nodes before linearized reading' (duration: 148.588505ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:02:52.376041Z","caller":"traceutil/trace.go:171","msg":"trace[890412920] transaction","detail":"{read_only:false; response_revision:21304; number_of_response:1; }","duration":"136.525786ms","start":"2026-06-02T13:02:52.239461Z","end":"2026-06-02T13:02:52.375987Z","steps":["trace[890412920] 'process raft request' (duration: 96.256837ms)","trace[890412920] 'compare' (duration: 39.80327ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:02:52.375971Z","caller":"traceutil/trace.go:171","msg":"trace[2124939340] transaction","detail":"{read_only:false; response_revision:21305; number_of_response:1; }","duration":"132.168183ms","start":"2026-06-02T13:02:52.243775Z","end":"2026-06-02T13:02:52.375944Z","steps":["trace[2124939340] 'process raft request' (duration: 132.068611ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:04:33.235099Z","caller":"traceutil/trace.go:171","msg":"trace[1316892145] transaction","detail":"{read_only:false; response_revision:22642; number_of_response:1; }","duration":"206.760682ms","start":"2026-06-02T13:04:33.028309Z","end":"2026-06-02T13:04:33.23507Z","steps":["trace[1316892145] 'process raft request' (duration: 112.235858ms)","trace[1316892145] 'compare' (duration: 94.366471ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:04:33.474487Z","caller":"traceutil/trace.go:171","msg":"trace[857732495] transaction","detail":"{read_only:false; response_revision:22644; number_of_response:1; }","duration":"231.50659ms","start":"2026-06-02T13:04:33.242953Z","end":"2026-06-02T13:04:33.47446Z","steps":["trace[857732495] 'process raft request' (duration: 231.443778ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:04:33.474688Z","caller":"traceutil/trace.go:171","msg":"trace[1967149264] transaction","detail":"{read_only:false; response_revision:22643; number_of_response:1; }","duration":"249.256764ms","start":"2026-06-02T13:04:33.225393Z","end":"2026-06-02T13:04:33.47465Z","steps":["trace[1967149264] 'process raft request' (duration: 160.092091ms)","trace[1967149264] 'compare' (duration: 88.719265ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:05:33.138467Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20208} {"level":"info","ts":"2026-06-02T13:05:33.246028Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20208,"took":"103.553514ms","hash":3809328528,"current-db-size-bytes":58261504,"current-db-size":"58 MB","current-db-size-in-use-bytes":42483712,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-06-02T13:05:33.246097Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3809328528,"revision":20208,"compact-revision":17811} {"level":"warn","ts":"2026-06-02T13:07:45.271275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.757013ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:07:45.271398Z","caller":"traceutil/trace.go:171","msg":"trace[541841099] transaction","detail":"{read_only:false; response_revision:24667; number_of_response:1; }","duration":"319.519839ms","start":"2026-06-02T13:07:44.95186Z","end":"2026-06-02T13:07:45.27138Z","steps":["trace[541841099] 'process raft request' (duration: 123.587102ms)","trace[541841099] 'compare' (duration: 195.326606ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:45.271444Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:44.951825Z","time spent":"319.597401ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:45.416541Z","caller":"traceutil/trace.go:171","msg":"trace[1371864369] transaction","detail":"{read_only:false; response_revision:24669; number_of_response:1; }","duration":"176.430999ms","start":"2026-06-02T13:07:45.240082Z","end":"2026-06-02T13:07:45.416513Z","steps":["trace[1371864369] 'process raft request' (duration: 176.339637ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:45.416599Z","caller":"traceutil/trace.go:171","msg":"trace[98936987] linearizableReadLoop","detail":"{readStateIndex:25466; appliedIndex:25464; }","duration":"145.21618ms","start":"2026-06-02T13:07:45.271345Z","end":"2026-06-02T13:07:45.416561Z","steps":["trace[98936987] 'read index received' (duration: 120.035785ms)","trace[98936987] 'applied index is now lower than readState.Index' (duration: 25.179485ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:45.416774Z","caller":"traceutil/trace.go:171","msg":"trace[2087011203] transaction","detail":"{read_only:false; response_revision:24670; number_of_response:1; }","duration":"116.775513ms","start":"2026-06-02T13:07:45.299982Z","end":"2026-06-02T13:07:45.416758Z","steps":["trace[2087011203] 'process raft request' (duration: 116.493788ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:45.416771Z","caller":"traceutil/trace.go:171","msg":"trace[801001609] transaction","detail":"{read_only:false; response_revision:24668; number_of_response:1; }","duration":"218.685507ms","start":"2026-06-02T13:07:45.198051Z","end":"2026-06-02T13:07:45.416737Z","steps":["trace[801001609] 'process raft request' (duration: 193.315868ms)","trace[801001609] 'compare' (duration: 24.90767ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:45.417056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.498531ms","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-02T13:07:45.417102Z","caller":"traceutil/trace.go:171","msg":"trace[398102227] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24670; }","duration":"219.601124ms","start":"2026-06-02T13:07:45.19749Z","end":"2026-06-02T13:07:45.417091Z","steps":["trace[398102227] 'agreement among raft nodes before linearized reading' (duration: 219.45252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:45.417098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.225037ms","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-02T13:07:45.417156Z","caller":"traceutil/trace.go:171","msg":"trace[2005772584] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24670; }","duration":"220.332058ms","start":"2026-06-02T13:07:45.196805Z","end":"2026-06-02T13:07:45.417137Z","steps":["trace[2005772584] 'agreement among raft nodes before linearized reading' (duration: 219.856158ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:45.809397Z","caller":"traceutil/trace.go:171","msg":"trace[484771870] transaction","detail":"{read_only:false; response_revision:24671; number_of_response:1; }","duration":"388.659384ms","start":"2026-06-02T13:07:45.420709Z","end":"2026-06-02T13:07:45.809369Z","steps":["trace[484771870] 'process raft request' (duration: 388.487991ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:45.809557Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:45.42067Z","time spent":"388.804907ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":417,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:46.075748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.6971ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:07:46.075952Z","caller":"traceutil/trace.go:171","msg":"trace[399000074] linearizableReadLoop","detail":"{readStateIndex:25471; appliedIndex:25467; }","duration":"344.525521ms","start":"2026-06-02T13:07:45.731407Z","end":"2026-06-02T13:07:46.075932Z","steps":["trace[399000074] 'read index received' (duration: 77.769848ms)","trace[399000074] 'applied index is now lower than readState.Index' (duration: 266.754583ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:46.076188Z","caller":"traceutil/trace.go:171","msg":"trace[1464180142] transaction","detail":"{read_only:false; response_revision:24674; number_of_response:1; }","duration":"479.511578ms","start":"2026-06-02T13:07:45.596653Z","end":"2026-06-02T13:07:46.076165Z","steps":["trace[1464180142] 'process raft request' (duration: 479.238313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.076227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.797556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T13:07:46.076226Z","caller":"traceutil/trace.go:171","msg":"trace[697987039] transaction","detail":"{read_only:false; response_revision:24672; number_of_response:1; }","duration":"654.900097ms","start":"2026-06-02T13:07:45.421262Z","end":"2026-06-02T13:07:46.076162Z","steps":["trace[697987039] 'process raft request' (duration: 517.718168ms)","trace[697987039] 'compare' (duration: 136.374954ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:46.076302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.106297ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/\" range_end:\"/registry/cilium.io/ciliumendpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T13:07:46.076305Z","caller":"traceutil/trace.go:171","msg":"trace[1578721105] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:24674; }","duration":"344.9841ms","start":"2026-06-02T13:07:45.731301Z","end":"2026-06-02T13:07:46.076285Z","steps":["trace[1578721105] 'agreement among raft nodes before linearized reading' (duration: 344.814477ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:46.076345Z","caller":"traceutil/trace.go:171","msg":"trace[314953543] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/; range_end:/registry/cilium.io/ciliumendpoints0; response_count:0; response_revision:24674; }","duration":"287.21615ms","start":"2026-06-02T13:07:45.789117Z","end":"2026-06-02T13:07:46.076333Z","steps":["trace[314953543] 'agreement among raft nodes before linearized reading' (duration: 287.033266ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.076358Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:45.731286Z","time spent":"345.060771ms","remote":"127.0.0.1:38156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":23,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true "} {"level":"warn","ts":"2026-06-02T13:07:46.076367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:45.596629Z","time spent":"479.634229ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:46.076399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:45.421252Z","time spent":"655.055169ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:46.076325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.005016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T13:07:46.076461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.02771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/\" range_end:\"/registry/minions0\" ","response":"range_response_count:1 size:18624"} {"level":"info","ts":"2026-06-02T13:07:46.076189Z","caller":"traceutil/trace.go:171","msg":"trace[739560976] transaction","detail":"{read_only:false; response_revision:24673; number_of_response:1; }","duration":"569.68977ms","start":"2026-06-02T13:07:45.506472Z","end":"2026-06-02T13:07:46.076161Z","steps":["trace[739560976] 'process raft request' (duration: 569.366404ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:46.076607Z","caller":"traceutil/trace.go:171","msg":"trace[492607781] range","detail":"{range_begin:/registry/minions/; range_end:/registry/minions0; response_count:1; response_revision:24674; }","duration":"114.204925ms","start":"2026-06-02T13:07:45.962352Z","end":"2026-06-02T13:07:46.076557Z","steps":["trace[492607781] 'agreement among raft nodes before linearized reading' (duration: 113.828917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.076649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:45.506444Z","time spent":"570.17987ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:46.076662Z","caller":"traceutil/trace.go:171","msg":"trace[325966244] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24674; }","duration":"136.413175ms","start":"2026-06-02T13:07:45.94019Z","end":"2026-06-02T13:07:46.076604Z","steps":["trace[325966244] 'agreement among raft nodes before linearized reading' (duration: 135.974856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.686527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.068459ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:46.686627Z","caller":"traceutil/trace.go:171","msg":"trace[1808073979] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24674; }","duration":"277.178721ms","start":"2026-06-02T13:07:46.409433Z","end":"2026-06-02T13:07:46.686612Z","steps":["trace[1808073979] 'range keys from in-memory index tree' (duration: 277.055068ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.686908Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.539736ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:40"} {"level":"info","ts":"2026-06-02T13:07:46.687055Z","caller":"traceutil/trace.go:171","msg":"trace[1572291326] linearizableReadLoop","detail":"{readStateIndex:25473; appliedIndex:25471; }","duration":"327.965549ms","start":"2026-06-02T13:07:46.359081Z","end":"2026-06-02T13:07:46.687047Z","steps":["trace[1572291326] 'read index received' (duration: 38.041µs)","trace[1572291326] 'applied index is now lower than readState.Index' (duration: 327.926988ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:46.68713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.060531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T13:07:46.687112Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:46.148434Z","time spent":"538.668994ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-06-02T13:07:46.687119Z","caller":"traceutil/trace.go:171","msg":"trace[1912775275] transaction","detail":"{read_only:false; response_revision:24675; number_of_response:1; }","duration":"519.984922ms","start":"2026-06-02T13:07:46.167105Z","end":"2026-06-02T13:07:46.68709Z","steps":["trace[1912775275] 'process raft request' (duration: 519.852179ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.687203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.393651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:46.687224Z","caller":"traceutil/trace.go:171","msg":"trace[1708406360] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24675; }","duration":"103.443913ms","start":"2026-06-02T13:07:46.583774Z","end":"2026-06-02T13:07:46.687218Z","steps":["trace[1708406360] 'agreement among raft nodes before linearized reading' (duration: 103.408742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.687263Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:46.167085Z","time spent":"520.105435ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:46.687324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.588901ms","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-02T13:07:46.68736Z","caller":"traceutil/trace.go:171","msg":"trace[117440579] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24675; }","duration":"212.652273ms","start":"2026-06-02T13:07:46.474697Z","end":"2026-06-02T13:07:46.687349Z","steps":["trace[117440579] 'agreement among raft nodes before linearized reading' (duration: 212.530621ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.687323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.151422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T13:07:46.687154Z","caller":"traceutil/trace.go:171","msg":"trace[1990017734] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:24675; }","duration":"328.117202ms","start":"2026-06-02T13:07:46.35903Z","end":"2026-06-02T13:07:46.687147Z","steps":["trace[1990017734] 'agreement among raft nodes before linearized reading' (duration: 328.072291ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.687432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:46.359015Z","time spent":"328.407747ms","remote":"127.0.0.1:37360","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true "} {"level":"info","ts":"2026-06-02T13:07:46.68742Z","caller":"traceutil/trace.go:171","msg":"trace[1258227360] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24675; }","duration":"213.294556ms","start":"2026-06-02T13:07:46.4741Z","end":"2026-06-02T13:07:46.687395Z","steps":["trace[1258227360] 'agreement among raft nodes before linearized reading' (duration: 213.038371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.995796Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.708391ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:07:46.996096Z","caller":"traceutil/trace.go:171","msg":"trace[1713960322] linearizableReadLoop","detail":"{readStateIndex:25477; appliedIndex:25473; }","duration":"134.336135ms","start":"2026-06-02T13:07:46.861742Z","end":"2026-06-02T13:07:46.996078Z","steps":["trace[1713960322] 'read index received' (duration: 65.865913ms)","trace[1713960322] 'applied index is now lower than readState.Index' (duration: 68.468562ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:46.996178Z","caller":"traceutil/trace.go:171","msg":"trace[1945699135] transaction","detail":"{read_only:false; response_revision:24676; number_of_response:1; }","duration":"307.003033ms","start":"2026-06-02T13:07:46.689164Z","end":"2026-06-02T13:07:46.996167Z","steps":["trace[1945699135] 'process raft request' (duration: 99.825253ms)","trace[1945699135] 'compare' (duration: 206.592559ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:46.996238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:46.689141Z","time spent":"307.064104ms","remote":"127.0.0.1:59200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":121,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:46.996524Z","caller":"traceutil/trace.go:171","msg":"trace[1366326167] transaction","detail":"{read_only:false; response_revision:24679; number_of_response:1; }","duration":"294.488897ms","start":"2026-06-02T13:07:46.702005Z","end":"2026-06-02T13:07:46.996494Z","steps":["trace[1366326167] 'process raft request' (duration: 294.029388ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:46.996553Z","caller":"traceutil/trace.go:171","msg":"trace[577288775] transaction","detail":"{read_only:false; response_revision:24677; number_of_response:1; }","duration":"304.916524ms","start":"2026-06-02T13:07:46.691606Z","end":"2026-06-02T13:07:46.996522Z","steps":["trace[577288775] 'process raft request' (duration: 304.321302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.996572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.812474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:46.996588Z","caller":"traceutil/trace.go:171","msg":"trace[1277854187] transaction","detail":"{read_only:false; response_revision:24678; number_of_response:1; }","duration":"304.539177ms","start":"2026-06-02T13:07:46.691998Z","end":"2026-06-02T13:07:46.996537Z","steps":["trace[1277854187] 'process raft request' (duration: 303.997856ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:46.996648Z","caller":"traceutil/trace.go:171","msg":"trace[932172099] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:24679; }","duration":"134.925397ms","start":"2026-06-02T13:07:46.861701Z","end":"2026-06-02T13:07:46.996627Z","steps":["trace[932172099] 'agreement among raft nodes before linearized reading' (duration: 134.797475ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:46.99671Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:46.691585Z","time spent":"305.041976ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:46.996736Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:46.691968Z","time spent":"304.685639ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:47.053773Z","caller":"traceutil/trace.go:171","msg":"trace[1934652819] transaction","detail":"{read_only:false; response_revision:24680; number_of_response:1; }","duration":"182.449502ms","start":"2026-06-02T13:07:46.871298Z","end":"2026-06-02T13:07:47.053748Z","steps":["trace[1934652819] 'process raft request' (duration: 182.245198ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:47.053964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.138815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:47.053997Z","caller":"traceutil/trace.go:171","msg":"trace[1344568457] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24680; }","duration":"113.231106ms","start":"2026-06-02T13:07:46.940756Z","end":"2026-06-02T13:07:47.053987Z","steps":["trace[1344568457] 'agreement among raft nodes before linearized reading' (duration: 113.159635ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:52.300343Z","caller":"traceutil/trace.go:171","msg":"trace[1685427182] transaction","detail":"{read_only:false; response_revision:24718; number_of_response:1; }","duration":"194.55568ms","start":"2026-06-02T13:07:52.105755Z","end":"2026-06-02T13:07:52.300311Z","steps":["trace[1685427182] 'process raft request' (duration: 143.105019ms)","trace[1685427182] 'compare' (duration: 51.213766ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:52.697112Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.562818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:52.6972Z","caller":"traceutil/trace.go:171","msg":"trace[1980567370] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24718; }","duration":"251.70872ms","start":"2026-06-02T13:07:52.445471Z","end":"2026-06-02T13:07:52.697179Z","steps":["trace[1980567370] 'range keys from in-memory index tree' (duration: 251.476625ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:52.6982Z","caller":"traceutil/trace.go:171","msg":"trace[1825270073] transaction","detail":"{read_only:false; response_revision:24719; number_of_response:1; }","duration":"177.058452ms","start":"2026-06-02T13:07:52.521037Z","end":"2026-06-02T13:07:52.698096Z","steps":["trace[1825270073] 'process raft request' (duration: 176.563052ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:52.893475Z","caller":"traceutil/trace.go:171","msg":"trace[1775658953] linearizableReadLoop","detail":"{readStateIndex:25519; appliedIndex:25518; }","duration":"186.135432ms","start":"2026-06-02T13:07:52.707313Z","end":"2026-06-02T13:07:52.893448Z","steps":["trace[1775658953] 'read index received' (duration: 157.586744ms)","trace[1775658953] 'applied index is now lower than readState.Index' (duration: 28.547858ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:52.89353Z","caller":"traceutil/trace.go:171","msg":"trace[449305330] transaction","detail":"{read_only:false; response_revision:24720; number_of_response:1; }","duration":"187.173651ms","start":"2026-06-02T13:07:52.706318Z","end":"2026-06-02T13:07:52.893492Z","steps":["trace[449305330] 'process raft request' (duration: 158.637163ms)","trace[449305330] 'compare' (duration: 28.361275ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:52.893672Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.340256ms","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-02T13:07:52.893726Z","caller":"traceutil/trace.go:171","msg":"trace[1006530500] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:24720; }","duration":"186.417687ms","start":"2026-06-02T13:07:52.707294Z","end":"2026-06-02T13:07:52.893712Z","steps":["trace[1006530500] 'agreement among raft nodes before linearized reading' (duration: 186.278795ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:53.134833Z","caller":"traceutil/trace.go:171","msg":"trace[988093130] transaction","detail":"{read_only:false; response_revision:24721; number_of_response:1; }","duration":"115.747025ms","start":"2026-06-02T13:07:53.019045Z","end":"2026-06-02T13:07:53.134792Z","steps":["trace[988093130] 'process raft request' (duration: 114.048012ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:53.135167Z","caller":"traceutil/trace.go:171","msg":"trace[1103470209] linearizableReadLoop","detail":"{readStateIndex:25520; appliedIndex:25519; }","duration":"116.0332ms","start":"2026-06-02T13:07:53.019121Z","end":"2026-06-02T13:07:53.135154Z","steps":["trace[1103470209] 'read index received' (duration: 113.93817ms)","trace[1103470209] 'applied index is now lower than readState.Index' (duration: 2.09254ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:53.135348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.212213ms","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-02T13:07:53.135385Z","caller":"traceutil/trace.go:171","msg":"trace[588237643] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24721; }","duration":"116.288995ms","start":"2026-06-02T13:07:53.019086Z","end":"2026-06-02T13:07:53.135375Z","steps":["trace[588237643] 'agreement among raft nodes before linearized reading' (duration: 116.146252ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:53.136029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.588785ms","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-02T13:07:53.136114Z","caller":"traceutil/trace.go:171","msg":"trace[1522105031] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24722; }","duration":"112.722168ms","start":"2026-06-02T13:07:53.023371Z","end":"2026-06-02T13:07:53.136094Z","steps":["trace[1522105031] 'agreement among raft nodes before linearized reading' (duration: 112.435041ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:53.59414Z","caller":"traceutil/trace.go:171","msg":"trace[594864381] linearizableReadLoop","detail":"{readStateIndex:25524; appliedIndex:25523; }","duration":"240.263614ms","start":"2026-06-02T13:07:53.353851Z","end":"2026-06-02T13:07:53.594115Z","steps":["trace[594864381] 'read index received' (duration: 240.132102ms)","trace[594864381] 'applied index is now lower than readState.Index' (duration: 130.512µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:53.594244Z","caller":"traceutil/trace.go:171","msg":"trace[905718931] transaction","detail":"{read_only:false; response_revision:24725; number_of_response:1; }","duration":"252.24202ms","start":"2026-06-02T13:07:53.341981Z","end":"2026-06-02T13:07:53.594223Z","steps":["trace[905718931] 'process raft request' (duration: 251.958935ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:53.594314Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.445147ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T13:07:53.59435Z","caller":"traceutil/trace.go:171","msg":"trace[1732514930] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:24725; }","duration":"240.541079ms","start":"2026-06-02T13:07:53.353797Z","end":"2026-06-02T13:07:53.594338Z","steps":["trace[1732514930] 'agreement among raft nodes before linearized reading' (duration: 240.432297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:53.807587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.359538ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:07:53.807891Z","caller":"traceutil/trace.go:171","msg":"trace[812348459] linearizableReadLoop","detail":"{readStateIndex:25527; appliedIndex:25524; }","duration":"213.662321ms","start":"2026-06-02T13:07:53.594204Z","end":"2026-06-02T13:07:53.807866Z","steps":["trace[812348459] 'read index received' (duration: 71.919617ms)","trace[812348459] 'applied index is now lower than readState.Index' (duration: 141.741324ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:53.80804Z","caller":"traceutil/trace.go:171","msg":"trace[1746762567] transaction","detail":"{read_only:false; response_revision:24727; number_of_response:1; }","duration":"364.59477ms","start":"2026-06-02T13:07:53.443429Z","end":"2026-06-02T13:07:53.808024Z","steps":["trace[1746762567] 'process raft request' (duration: 364.284734ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:53.808121Z","caller":"traceutil/trace.go:171","msg":"trace[557517886] transaction","detail":"{read_only:false; response_revision:24726; number_of_response:1; }","duration":"368.28803ms","start":"2026-06-02T13:07:53.439802Z","end":"2026-06-02T13:07:53.80809Z","steps":["trace[557517886] 'process raft request' (duration: 226.29288ms)","trace[557517886] 'compare' (duration: 141.175134ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:53.808134Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:53.443409Z","time spent":"364.670942ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:53.808236Z","caller":"traceutil/trace.go:171","msg":"trace[1819453349] transaction","detail":"{read_only:false; response_revision:24728; number_of_response:1; }","duration":"362.931469ms","start":"2026-06-02T13:07:53.445259Z","end":"2026-06-02T13:07:53.808191Z","steps":["trace[1819453349] 'process raft request' (duration: 362.541781ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:53.808269Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:53.439775Z","time spent":"368.404423ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:53.808277Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.50513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-02T13:07:53.808369Z","caller":"traceutil/trace.go:171","msg":"trace[585805891] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24728; }","duration":"452.634742ms","start":"2026-06-02T13:07:53.355708Z","end":"2026-06-02T13:07:53.808343Z","steps":["trace[585805891] 'agreement among raft nodes before linearized reading' (duration: 452.369387ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:53.808418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:53.355698Z","time spent":"452.710484ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":584,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-02T13:07:53.80844Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:53.445235Z","time spent":"363.088042ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:54.064201Z","caller":"traceutil/trace.go:171","msg":"trace[1915875553] linearizableReadLoop","detail":"{readStateIndex:25529; appliedIndex:25528; }","duration":"179.235182ms","start":"2026-06-02T13:07:53.884933Z","end":"2026-06-02T13:07:54.064168Z","steps":["trace[1915875553] 'read index received' (duration: 100.15063ms)","trace[1915875553] 'applied index is now lower than readState.Index' (duration: 79.082982ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:54.064249Z","caller":"traceutil/trace.go:171","msg":"trace[618624365] transaction","detail":"{read_only:false; response_revision:24730; number_of_response:1; }","duration":"220.798316ms","start":"2026-06-02T13:07:53.843416Z","end":"2026-06-02T13:07:54.064214Z","steps":["trace[618624365] 'process raft request' (duration: 141.615632ms)","trace[618624365] 'compare' (duration: 78.92761ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:54.064369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.409747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T13:07:54.064407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.048221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:54.064443Z","caller":"traceutil/trace.go:171","msg":"trace[1003574991] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24730; }","duration":"124.151373ms","start":"2026-06-02T13:07:53.94028Z","end":"2026-06-02T13:07:54.064432Z","steps":["trace[1003574991] 'agreement among raft nodes before linearized reading' (duration: 124.062952ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:54.064447Z","caller":"traceutil/trace.go:171","msg":"trace[1585968524] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24730; }","duration":"179.498448ms","start":"2026-06-02T13:07:53.884928Z","end":"2026-06-02T13:07:54.064426Z","steps":["trace[1585968524] 'agreement among raft nodes before linearized reading' (duration: 179.356496ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:54.482674Z","caller":"traceutil/trace.go:171","msg":"trace[1441591263] linearizableReadLoop","detail":"{readStateIndex:25530; appliedIndex:25529; }","duration":"412.32581ms","start":"2026-06-02T13:07:54.070318Z","end":"2026-06-02T13:07:54.482644Z","steps":["trace[1441591263] 'read index received' (duration: 412.118126ms)","trace[1441591263] 'applied index is now lower than readState.Index' (duration: 205.884µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:54.482725Z","caller":"traceutil/trace.go:171","msg":"trace[2060937061] transaction","detail":"{read_only:false; response_revision:24731; number_of_response:1; }","duration":"413.182017ms","start":"2026-06-02T13:07:54.069504Z","end":"2026-06-02T13:07:54.482686Z","steps":["trace[2060937061] 'process raft request' (duration: 412.935412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:54.48289Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:54.069483Z","time spent":"413.315569ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":513,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:54.482941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"412.601516ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18624"} {"level":"info","ts":"2026-06-02T13:07:54.482979Z","caller":"traceutil/trace.go:171","msg":"trace[2074873849] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24731; }","duration":"412.668747ms","start":"2026-06-02T13:07:54.0703Z","end":"2026-06-02T13:07:54.482969Z","steps":["trace[2074873849] 'agreement among raft nodes before linearized reading' (duration: 412.483142ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:54.483021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:54.070293Z","time spent":"412.720868ms","remote":"127.0.0.1:59328","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18646,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-02T13:07:54.500851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.496681ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterrestores/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterrestores0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T13:07:54.500884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.861244ms","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-02T13:07:54.500911Z","caller":"traceutil/trace.go:171","msg":"trace[2022881632] transaction","detail":"{read_only:false; response_revision:24732; number_of_response:1; }","duration":"397.090692ms","start":"2026-06-02T13:07:54.1038Z","end":"2026-06-02T13:07:54.500891Z","steps":["trace[2022881632] 'process raft request' (duration: 396.714835ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:54.501022Z","caller":"traceutil/trace.go:171","msg":"trace[459271473] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24733; }","duration":"197.015296ms","start":"2026-06-02T13:07:54.30394Z","end":"2026-06-02T13:07:54.500956Z","steps":["trace[459271473] 'agreement among raft nodes before linearized reading' (duration: 196.735591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:54.501042Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:54.103775Z","time spent":"397.188384ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:54.501016Z","caller":"traceutil/trace.go:171","msg":"trace[1814896740] transaction","detail":"{read_only:false; response_revision:24733; number_of_response:1; }","duration":"394.708317ms","start":"2026-06-02T13:07:54.106268Z","end":"2026-06-02T13:07:54.500976Z","steps":["trace[1814896740] 'process raft request' (duration: 394.32834ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:54.500925Z","caller":"traceutil/trace.go:171","msg":"trace[1100739559] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterrestores/; range_end:/registry/pxc.percona.com/perconaxtradbclusterrestores0; response_count:0; response_revision:24733; }","duration":"237.626903ms","start":"2026-06-02T13:07:54.263283Z","end":"2026-06-02T13:07:54.500909Z","steps":["trace[1100739559] 'agreement among raft nodes before linearized reading' (duration: 237.519631ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:54.501201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:54.106224Z","time spent":"394.878071ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:55.339084Z","caller":"traceutil/trace.go:171","msg":"trace[785717409] transaction","detail":"{read_only:false; response_revision:24736; number_of_response:1; }","duration":"198.494175ms","start":"2026-06-02T13:07:55.140565Z","end":"2026-06-02T13:07:55.33906Z","steps":["trace[785717409] 'process raft request' (duration: 198.354603ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:55.453657Z","caller":"traceutil/trace.go:171","msg":"trace[2067109845] linearizableReadLoop","detail":"{readStateIndex:25536; appliedIndex:25534; }","duration":"283.612453ms","start":"2026-06-02T13:07:55.170024Z","end":"2026-06-02T13:07:55.453637Z","steps":["trace[2067109845] 'read index received' (duration: 168.925048ms)","trace[2067109845] 'applied index is now lower than readState.Index' (duration: 114.658404ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:55.453735Z","caller":"traceutil/trace.go:171","msg":"trace[819832840] transaction","detail":"{read_only:false; response_revision:24737; number_of_response:1; }","duration":"312.591849ms","start":"2026-06-02T13:07:55.141109Z","end":"2026-06-02T13:07:55.453701Z","steps":["trace[819832840] 'process raft request' (duration: 311.022049ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:55.453813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.402415ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:55.453852Z","caller":"traceutil/trace.go:171","msg":"trace[281643902] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:24737; }","duration":"232.496757ms","start":"2026-06-02T13:07:55.221344Z","end":"2026-06-02T13:07:55.453841Z","steps":["trace[281643902] 'agreement among raft nodes before linearized reading' (duration: 232.415696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:55.453866Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:55.141095Z","time spent":"312.69588ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:07:55.453851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.817276ms","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":"warn","ts":"2026-06-02T13:07:55.453854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.654843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/applicationcredentials/\" range_end:\"/registry/openstack.k-orc.cloud/applicationcredentials0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:55.453907Z","caller":"traceutil/trace.go:171","msg":"trace[832841760] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24737; }","duration":"283.920068ms","start":"2026-06-02T13:07:55.169973Z","end":"2026-06-02T13:07:55.453893Z","steps":["trace[832841760] 'agreement among raft nodes before linearized reading' (duration: 283.724965ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:55.453915Z","caller":"traceutil/trace.go:171","msg":"trace[243245627] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/applicationcredentials/; range_end:/registry/openstack.k-orc.cloud/applicationcredentials0; response_count:0; response_revision:24737; }","duration":"274.767364ms","start":"2026-06-02T13:07:55.179132Z","end":"2026-06-02T13:07:55.4539Z","steps":["trace[243245627] 'agreement among raft nodes before linearized reading' (duration: 274.648112ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:55.453966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.54022ms","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-02T13:07:55.453985Z","caller":"traceutil/trace.go:171","msg":"trace[589343600] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24737; }","duration":"283.601981ms","start":"2026-06-02T13:07:55.170377Z","end":"2026-06-02T13:07:55.453979Z","steps":["trace[589343600] 'agreement among raft nodes before linearized reading' (duration: 283.363497ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:55.703014Z","caller":"traceutil/trace.go:171","msg":"trace[902030460] transaction","detail":"{read_only:false; response_revision:24738; number_of_response:1; }","duration":"246.156035ms","start":"2026-06-02T13:07:55.456821Z","end":"2026-06-02T13:07:55.702977Z","steps":["trace[902030460] 'process raft request' (duration: 196.750493ms)","trace[902030460] 'compare' (duration: 48.857282ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:55.703019Z","caller":"traceutil/trace.go:171","msg":"trace[1709685905] transaction","detail":"{read_only:false; response_revision:24739; number_of_response:1; }","duration":"245.773528ms","start":"2026-06-02T13:07:55.457214Z","end":"2026-06-02T13:07:55.702987Z","steps":["trace[1709685905] 'process raft request' (duration: 245.617045ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:55.703145Z","caller":"traceutil/trace.go:171","msg":"trace[419622160] linearizableReadLoop","detail":"{readStateIndex:25538; appliedIndex:25536; }","duration":"105.038812ms","start":"2026-06-02T13:07:55.598078Z","end":"2026-06-02T13:07:55.703116Z","steps":["trace[419622160] 'read index received' (duration: 55.660691ms)","trace[419622160] 'applied index is now lower than readState.Index' (duration: 49.375791ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:55.703313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.225296ms","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-02T13:07:55.703364Z","caller":"traceutil/trace.go:171","msg":"trace[2117202282] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24740; }","duration":"105.323757ms","start":"2026-06-02T13:07:55.598027Z","end":"2026-06-02T13:07:55.70335Z","steps":["trace[2117202282] 'agreement among raft nodes before linearized reading' (duration: 105.169324ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:55.998551Z","caller":"traceutil/trace.go:171","msg":"trace[1771132797] transaction","detail":"{read_only:false; response_revision:24742; number_of_response:1; }","duration":"185.285216ms","start":"2026-06-02T13:07:55.813241Z","end":"2026-06-02T13:07:55.998527Z","steps":["trace[1771132797] 'process raft request' (duration: 185.122543ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:56.010614Z","caller":"traceutil/trace.go:171","msg":"trace[229588298] transaction","detail":"{read_only:false; response_revision:24743; number_of_response:1; }","duration":"196.756503ms","start":"2026-06-02T13:07:55.81383Z","end":"2026-06-02T13:07:56.010587Z","steps":["trace[229588298] 'process raft request' (duration: 196.579689ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:56.010845Z","caller":"traceutil/trace.go:171","msg":"trace[1456059259] transaction","detail":"{read_only:false; response_revision:24744; number_of_response:1; }","duration":"196.928136ms","start":"2026-06-02T13:07:55.813885Z","end":"2026-06-02T13:07:56.010813Z","steps":["trace[1456059259] 'process raft request' (duration: 196.659731ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:56.461198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.134646ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:07:56.461569Z","caller":"traceutil/trace.go:171","msg":"trace[961511851] transaction","detail":"{read_only:false; response_revision:24746; number_of_response:1; }","duration":"290.018103ms","start":"2026-06-02T13:07:56.171521Z","end":"2026-06-02T13:07:56.461539Z","steps":["trace[961511851] 'process raft request' (duration: 132.445368ms)","trace[961511851] 'compare' (duration: 156.995693ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:56.612239Z","caller":"traceutil/trace.go:171","msg":"trace[341186983] transaction","detail":"{read_only:false; response_revision:24747; number_of_response:1; }","duration":"107.101751ms","start":"2026-06-02T13:07:56.505112Z","end":"2026-06-02T13:07:56.612214Z","steps":["trace[341186983] 'process raft request' (duration: 106.936718ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:56.635335Z","caller":"traceutil/trace.go:171","msg":"trace[377152242] linearizableReadLoop","detail":"{readStateIndex:25548; appliedIndex:25546; }","duration":"104.92897ms","start":"2026-06-02T13:07:56.530381Z","end":"2026-06-02T13:07:56.63531Z","steps":["trace[377152242] 'read index received' (duration: 81.634781ms)","trace[377152242] 'applied index is now lower than readState.Index' (duration: 23.292829ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:56.635384Z","caller":"traceutil/trace.go:171","msg":"trace[1961612774] transaction","detail":"{read_only:false; response_revision:24748; number_of_response:1; }","duration":"129.181907ms","start":"2026-06-02T13:07:56.506175Z","end":"2026-06-02T13:07:56.635357Z","steps":["trace[1961612774] 'process raft request' (duration: 128.990344ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:56.635516Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.117344ms","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-02T13:07:56.635557Z","caller":"traceutil/trace.go:171","msg":"trace[128243954] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24748; }","duration":"105.207205ms","start":"2026-06-02T13:07:56.530337Z","end":"2026-06-02T13:07:56.635545Z","steps":["trace[128243954] 'agreement among raft nodes before linearized reading' (duration: 105.063642ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:56.811228Z","caller":"traceutil/trace.go:171","msg":"trace[1134688513] transaction","detail":"{read_only:false; response_revision:24749; number_of_response:1; }","duration":"172.179769ms","start":"2026-06-02T13:07:56.639016Z","end":"2026-06-02T13:07:56.811196Z","steps":["trace[1134688513] 'process raft request' (duration: 157.716486ms)","trace[1134688513] 'compare' (duration: 14.289349ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:57.588275Z","caller":"traceutil/trace.go:171","msg":"trace[1469335994] transaction","detail":"{read_only:false; response_revision:24752; number_of_response:1; }","duration":"129.617865ms","start":"2026-06-02T13:07:57.458638Z","end":"2026-06-02T13:07:57.588256Z","steps":["trace[1469335994] 'process raft request' (duration: 115.222404ms)","trace[1469335994] 'compare' (duration: 13.950503ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:57.92167Z","caller":"traceutil/trace.go:171","msg":"trace[635911111] linearizableReadLoop","detail":"{readStateIndex:25553; appliedIndex:25552; }","duration":"215.226121ms","start":"2026-06-02T13:07:57.70642Z","end":"2026-06-02T13:07:57.921646Z","steps":["trace[635911111] 'read index received' (duration: 214.714861ms)","trace[635911111] 'applied index is now lower than readState.Index' (duration: 510.14µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:07:57.921787Z","caller":"traceutil/trace.go:171","msg":"trace[1218230455] transaction","detail":"{read_only:false; response_revision:24753; number_of_response:1; }","duration":"216.899983ms","start":"2026-06-02T13:07:57.704846Z","end":"2026-06-02T13:07:57.921746Z","steps":["trace[1218230455] 'process raft request' (duration: 216.402733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:57.921923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.06168ms","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-02T13:07:57.921968Z","caller":"traceutil/trace.go:171","msg":"trace[928075537] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24753; }","duration":"214.157311ms","start":"2026-06-02T13:07:57.707797Z","end":"2026-06-02T13:07:57.921954Z","steps":["trace[928075537] 'agreement among raft nodes before linearized reading' (duration: 213.986248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:57.921943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.498897ms","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-02T13:07:57.922016Z","caller":"traceutil/trace.go:171","msg":"trace[578330624] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24753; }","duration":"215.607099ms","start":"2026-06-02T13:07:57.706391Z","end":"2026-06-02T13:07:57.921998Z","steps":["trace[578330624] 'agreement among raft nodes before linearized reading' (duration: 215.377655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:57.922015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.639156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:57.922098Z","caller":"traceutil/trace.go:171","msg":"trace[385248253] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:24753; }","duration":"173.750258ms","start":"2026-06-02T13:07:57.748328Z","end":"2026-06-02T13:07:57.922078Z","steps":["trace[385248253] 'agreement among raft nodes before linearized reading' (duration: 173.562335ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:57.922043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.5665ms","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-02T13:07:57.922189Z","caller":"traceutil/trace.go:171","msg":"trace[170947360] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24753; }","duration":"196.750603ms","start":"2026-06-02T13:07:57.725426Z","end":"2026-06-02T13:07:57.922177Z","steps":["trace[170947360] 'agreement among raft nodes before linearized reading' (duration: 196.500308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:58.098668Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.522053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:58.09875Z","caller":"traceutil/trace.go:171","msg":"trace[915724133] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24756; }","duration":"156.659416ms","start":"2026-06-02T13:07:57.942071Z","end":"2026-06-02T13:07:58.098731Z","steps":["trace[915724133] 'range keys from in-memory index tree' (duration: 156.443732ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:58.147256Z","caller":"traceutil/trace.go:171","msg":"trace[1312535842] transaction","detail":"{read_only:false; response_revision:24757; number_of_response:1; }","duration":"143.117571ms","start":"2026-06-02T13:07:58.004117Z","end":"2026-06-02T13:07:58.147235Z","steps":["trace[1312535842] 'process raft request' (duration: 142.974549ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:58.378237Z","caller":"traceutil/trace.go:171","msg":"trace[857485465] transaction","detail":"{read_only:false; response_revision:24758; number_of_response:1; }","duration":"363.156904ms","start":"2026-06-02T13:07:58.015065Z","end":"2026-06-02T13:07:58.378222Z","steps":["trace[857485465] 'process raft request' (duration: 353.827687ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:58.378332Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:58.015041Z","time spent":"363.240245ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:07:58.378928Z","caller":"traceutil/trace.go:171","msg":"trace[777518598] linearizableReadLoop","detail":"{readStateIndex:25559; appliedIndex:25557; }","duration":"279.238269ms","start":"2026-06-02T13:07:58.099672Z","end":"2026-06-02T13:07:58.37891Z","steps":["trace[777518598] 'read index received' (duration: 47.567898ms)","trace[777518598] 'applied index is now lower than readState.Index' (duration: 231.669261ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:07:58.379019Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.347851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:58.379045Z","caller":"traceutil/trace.go:171","msg":"trace[129939774] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24759; }","duration":"279.411152ms","start":"2026-06-02T13:07:58.099628Z","end":"2026-06-02T13:07:58.379039Z","steps":["trace[129939774] 'agreement among raft nodes before linearized reading' (duration: 279.370101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:58.379132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.838449ms","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-02T13:07:58.379177Z","caller":"traceutil/trace.go:171","msg":"trace[1921168728] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24759; }","duration":"218.92146ms","start":"2026-06-02T13:07:58.160245Z","end":"2026-06-02T13:07:58.379167Z","steps":["trace[1921168728] 'agreement among raft nodes before linearized reading' (duration: 218.772887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:58.379244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.945675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretexports/\" range_end:\"/registry/secretgen.carvel.dev/secretexports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:07:58.37931Z","caller":"traceutil/trace.go:171","msg":"trace[1736319123] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretexports/; range_end:/registry/secretgen.carvel.dev/secretexports0; response_count:0; response_revision:24759; }","duration":"198.052536ms","start":"2026-06-02T13:07:58.181241Z","end":"2026-06-02T13:07:58.379293Z","steps":["trace[1736319123] 'agreement among raft nodes before linearized reading' (duration: 197.924974ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:07:58.37924Z","caller":"traceutil/trace.go:171","msg":"trace[928678810] transaction","detail":"{read_only:false; response_revision:24759; number_of_response:1; }","duration":"363.988359ms","start":"2026-06-02T13:07:58.015148Z","end":"2026-06-02T13:07:58.379136Z","steps":["trace[928678810] 'process raft request' (duration: 363.048662ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:07:58.379499Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:07:58.015141Z","time spent":"364.257134ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:08:02.764302Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.978954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:02.764515Z","caller":"traceutil/trace.go:171","msg":"trace[204083362] range","detail":"{range_begin:/registry/rabbitmq.com/exchanges/; range_end:/registry/rabbitmq.com/exchanges0; response_count:0; response_revision:24786; }","duration":"466.30145ms","start":"2026-06-02T13:08:02.298178Z","end":"2026-06-02T13:08:02.764479Z","steps":["trace[204083362] 'count revisions from in-memory index tree' (duration: 465.880062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:02.764612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.298159Z","time spent":"466.415872ms","remote":"127.0.0.1:36890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":72,"response count":0,"response size":28,"request content":"key:\"/registry/rabbitmq.com/exchanges/\" range_end:\"/registry/rabbitmq.com/exchanges0\" count_only:true "} {"level":"warn","ts":"2026-06-02T13:08:02.764983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"464.564237ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:02.765089Z","caller":"traceutil/trace.go:171","msg":"trace[350078819] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/users/; range_end:/registry/openstack.k-orc.cloud/users0; response_count:0; response_revision:24786; }","duration":"464.70978ms","start":"2026-06-02T13:08:02.300352Z","end":"2026-06-02T13:08:02.765062Z","steps":["trace[350078819] 'count revisions from in-memory index tree' (duration: 464.497086ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:02.765147Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.300294Z","time spent":"464.840892ms","remote":"127.0.0.1:37474","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":28,"request content":"key:\"/registry/openstack.k-orc.cloud/users/\" range_end:\"/registry/openstack.k-orc.cloud/users0\" count_only:true "} {"level":"warn","ts":"2026-06-02T13:08:02.765489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.563781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T13:08:02.765525Z","caller":"traceutil/trace.go:171","msg":"trace[792064704] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:24786; }","duration":"451.604122ms","start":"2026-06-02T13:08:02.313911Z","end":"2026-06-02T13:08:02.765515Z","steps":["trace[792064704] 'count revisions from in-memory index tree' (duration: 451.51017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:02.76556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.313879Z","time spent":"451.669282ms","remote":"127.0.0.1:59678","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":19,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"warn","ts":"2026-06-02T13:08:02.766349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.954183ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:08:02.766519Z","caller":"traceutil/trace.go:171","msg":"trace[1385082835] transaction","detail":"{read_only:false; response_revision:24787; number_of_response:1; }","duration":"367.294272ms","start":"2026-06-02T13:08:02.399191Z","end":"2026-06-02T13:08:02.766485Z","steps":["trace[1385082835] 'process raft request' (duration: 95.132175ms)","trace[1385082835] 'compare' (duration: 270.756091ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:02.766642Z","caller":"traceutil/trace.go:171","msg":"trace[1011294006] transaction","detail":"{read_only:false; response_revision:24788; number_of_response:1; }","duration":"357.333973ms","start":"2026-06-02T13:08:02.409266Z","end":"2026-06-02T13:08:02.7666Z","steps":["trace[1011294006] 'process raft request' (duration: 357.203751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:02.766701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"353.930739ms","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-02T13:08:02.766743Z","caller":"traceutil/trace.go:171","msg":"trace[1221459815] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24788; }","duration":"354.012501ms","start":"2026-06-02T13:08:02.412722Z","end":"2026-06-02T13:08:02.766734Z","steps":["trace[1221459815] 'agreement among raft nodes before linearized reading' (duration: 353.878308ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:02.766771Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.412702Z","time spent":"354.062221ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":458,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-02T13:08:02.766576Z","caller":"traceutil/trace.go:171","msg":"trace[1258185837] linearizableReadLoop","detail":"{readStateIndex:25589; appliedIndex:25587; }","duration":"352.984981ms","start":"2026-06-02T13:08:02.413577Z","end":"2026-06-02T13:08:02.766562Z","steps":["trace[1258185837] 'read index received' (duration: 80.677351ms)","trace[1258185837] 'applied index is now lower than readState.Index' (duration: 272.30625ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:02.766765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.399171Z","time spent":"367.480665ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:08:02.766814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.409239Z","time spent":"357.479986ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:08:02.781489Z","caller":"traceutil/trace.go:171","msg":"trace[1817950068] transaction","detail":"{read_only:false; response_revision:24789; number_of_response:1; }","duration":"152.15592ms","start":"2026-06-02T13:08:02.629308Z","end":"2026-06-02T13:08:02.781464Z","steps":["trace[1817950068] 'process raft request' (duration: 152.012128ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:03.207367Z","caller":"traceutil/trace.go:171","msg":"trace[679076319] transaction","detail":"{read_only:false; response_revision:24790; number_of_response:1; }","duration":"554.939862ms","start":"2026-06-02T13:08:02.652395Z","end":"2026-06-02T13:08:03.207335Z","steps":["trace[679076319] 'process raft request' (duration: 554.702947ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:03.207649Z","caller":"traceutil/trace.go:171","msg":"trace[346249965] linearizableReadLoop","detail":"{readStateIndex:25591; appliedIndex:25589; }","duration":"440.812618ms","start":"2026-06-02T13:08:02.766806Z","end":"2026-06-02T13:08:03.207618Z","steps":["trace[346249965] 'read index received' (duration: 14.431062ms)","trace[346249965] 'applied index is now lower than readState.Index' (duration: 426.379496ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:03.207704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.652381Z","time spent":"555.066704ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:08:03.207912Z","caller":"traceutil/trace.go:171","msg":"trace[2028588971] transaction","detail":"{read_only:false; response_revision:24791; number_of_response:1; }","duration":"436.836093ms","start":"2026-06-02T13:08:02.771061Z","end":"2026-06-02T13:08:03.207897Z","steps":["trace[2028588971] 'process raft request' (duration: 436.230722ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:03.208052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.771034Z","time spent":"436.915864ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:08:03.20824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.727999ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T13:08:03.208281Z","caller":"traceutil/trace.go:171","msg":"trace[663690567] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:24791; }","duration":"712.824931ms","start":"2026-06-02T13:08:02.495444Z","end":"2026-06-02T13:08:03.208269Z","steps":["trace[663690567] 'agreement among raft nodes before linearized reading' (duration: 712.731519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:03.208312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.495413Z","time spent":"712.886753ms","remote":"127.0.0.1:59646","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":8,"response size":30,"request content":"key:\"/registry/prioritylevelconfigurations/\" range_end:\"/registry/prioritylevelconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-02T13:08:03.524928Z","caller":"traceutil/trace.go:171","msg":"trace[1649278318] transaction","detail":"{read_only:false; response_revision:24793; number_of_response:1; }","duration":"522.584871ms","start":"2026-06-02T13:08:03.002323Z","end":"2026-06-02T13:08:03.524908Z","steps":["trace[1649278318] 'process raft request' (duration: 522.451218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:03.525046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:03.002293Z","time spent":"522.687744ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:08:03.525313Z","caller":"traceutil/trace.go:171","msg":"trace[1827397600] transaction","detail":"{read_only:false; response_revision:24792; number_of_response:1; }","duration":"596.974105ms","start":"2026-06-02T13:08:02.928327Z","end":"2026-06-02T13:08:03.525301Z","steps":["trace[1827397600] 'process raft request' (duration: 521.428479ms)","trace[1827397600] 'compare' (duration: 74.786741ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:03.525328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"580.940563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:03.525422Z","caller":"traceutil/trace.go:171","msg":"trace[1773422337] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24793; }","duration":"581.078505ms","start":"2026-06-02T13:08:02.944325Z","end":"2026-06-02T13:08:03.525403Z","steps":["trace[1773422337] 'agreement among raft nodes before linearized reading' (duration: 580.894111ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:03.525446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"597.260921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T13:08:03.52549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.898926ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:03.525526Z","caller":"traceutil/trace.go:171","msg":"trace[980164286] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24793; }","duration":"597.442454ms","start":"2026-06-02T13:08:02.928066Z","end":"2026-06-02T13:08:03.525509Z","steps":["trace[980164286] 'agreement among raft nodes before linearized reading' (duration: 597.26614ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:03.525554Z","caller":"traceutil/trace.go:171","msg":"trace[632159823] range","detail":"{range_begin:/registry/monitoring.coreos.com/scrapeconfigs/; range_end:/registry/monitoring.coreos.com/scrapeconfigs0; response_count:0; response_revision:24793; }","duration":"338.030949ms","start":"2026-06-02T13:08:03.187509Z","end":"2026-06-02T13:08:03.52554Z","steps":["trace[632159823] 'agreement among raft nodes before linearized reading' (duration: 337.897067ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:03.525566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.928026Z","time spent":"597.533306ms","remote":"127.0.0.1:37378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"warn","ts":"2026-06-02T13:08:03.525468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.944311Z","time spent":"581.150076ms","remote":"127.0.0.1:59192","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-02T13:08:03.525583Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:03.187479Z","time spent":"338.098591ms","remote":"127.0.0.1:38074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/scrapeconfigs/\" range_end:\"/registry/monitoring.coreos.com/scrapeconfigs0\" count_only:true "} {"level":"warn","ts":"2026-06-02T13:08:03.525368Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.928298Z","time spent":"597.039327ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:08:03.525754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"685.165229ms","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-02T13:08:03.525799Z","caller":"traceutil/trace.go:171","msg":"trace[681581439] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24793; }","duration":"685.24813ms","start":"2026-06-02T13:08:02.840538Z","end":"2026-06-02T13:08:03.525786Z","steps":["trace[681581439] 'agreement among raft nodes before linearized reading' (duration: 685.039596ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:03.525824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:02.840517Z","time spent":"685.303531ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":462,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-02T13:08:03.528548Z","caller":"traceutil/trace.go:171","msg":"trace[677004187] transaction","detail":"{read_only:false; response_revision:24794; number_of_response:1; }","duration":"319.784403ms","start":"2026-06-02T13:08:03.208748Z","end":"2026-06-02T13:08:03.528533Z","steps":["trace[677004187] 'process raft request' (duration: 316.808628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:03.528665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:03.208734Z","time spent":"319.853395ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":473,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T13:08:03.524918Z","caller":"traceutil/trace.go:171","msg":"trace[420323554] linearizableReadLoop","detail":"{readStateIndex:25594; appliedIndex:25592; }","duration":"317.145044ms","start":"2026-06-02T13:08:03.207744Z","end":"2026-06-02T13:08:03.524889Z","steps":["trace[420323554] 'read index received' (duration: 241.978277ms)","trace[420323554] 'applied index is now lower than readState.Index' (duration: 75.165277ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:11.771532Z","caller":"traceutil/trace.go:171","msg":"trace[731538672] linearizableReadLoop","detail":"{readStateIndex:25720; appliedIndex:25718; }","duration":"209.799739ms","start":"2026-06-02T13:08:11.561704Z","end":"2026-06-02T13:08:11.771504Z","steps":["trace[731538672] 'read index received' (duration: 68.444652ms)","trace[731538672] 'applied index is now lower than readState.Index' (duration: 141.353337ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:11.771674Z","caller":"traceutil/trace.go:171","msg":"trace[198268579] transaction","detail":"{read_only:false; response_revision:24917; number_of_response:1; }","duration":"217.488824ms","start":"2026-06-02T13:08:11.554165Z","end":"2026-06-02T13:08:11.771653Z","steps":["trace[198268579] 'process raft request' (duration: 193.282298ms)","trace[198268579] 'compare' (duration: 23.919351ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:11.77187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.159647ms","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-02T13:08:11.771926Z","caller":"traceutil/trace.go:171","msg":"trace[269776883] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24917; }","duration":"210.253948ms","start":"2026-06-02T13:08:11.56166Z","end":"2026-06-02T13:08:11.771914Z","steps":["trace[269776883] 'agreement among raft nodes before linearized reading' (duration: 210.007412ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:11.772395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.801126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f22ad13a-7360-443a-b7d4-0f1ba504def4\" ","response":"range_response_count:1 size:3644"} {"level":"info","ts":"2026-06-02T13:08:11.77248Z","caller":"traceutil/trace.go:171","msg":"trace[881956118] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f22ad13a-7360-443a-b7d4-0f1ba504def4; range_end:; response_count:1; response_revision:24918; }","duration":"133.953758ms","start":"2026-06-02T13:08:11.638508Z","end":"2026-06-02T13:08:11.772462Z","steps":["trace[881956118] 'agreement among raft nodes before linearized reading' (duration: 133.688043ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:11.772642Z","caller":"traceutil/trace.go:171","msg":"trace[2141522212] transaction","detail":"{read_only:false; response_revision:24918; number_of_response:1; }","duration":"124.398857ms","start":"2026-06-02T13:08:11.648216Z","end":"2026-06-02T13:08:11.772615Z","steps":["trace[2141522212] 'process raft request' (duration: 123.822037ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:12.16615Z","caller":"traceutil/trace.go:171","msg":"trace[2013161209] linearizableReadLoop","detail":"{readStateIndex:25723; appliedIndex:25722; }","duration":"167.654084ms","start":"2026-06-02T13:08:11.998467Z","end":"2026-06-02T13:08:12.166121Z","steps":["trace[2013161209] 'read index received' (duration: 167.495151ms)","trace[2013161209] 'applied index is now lower than readState.Index' (duration: 157.723µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:12.166254Z","caller":"traceutil/trace.go:171","msg":"trace[62042336] transaction","detail":"{read_only:false; response_revision:24920; number_of_response:1; }","duration":"168.978578ms","start":"2026-06-02T13:08:11.997241Z","end":"2026-06-02T13:08:12.166219Z","steps":["trace[62042336] 'process raft request' (duration: 168.732204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:12.166421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.90785ms","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-02T13:08:12.166465Z","caller":"traceutil/trace.go:171","msg":"trace[1120685896] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24920; }","duration":"164.982243ms","start":"2026-06-02T13:08:12.001469Z","end":"2026-06-02T13:08:12.166452Z","steps":["trace[1120685896] 'agreement among raft nodes before linearized reading' (duration: 164.81888ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:12.16644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.95451ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T13:08:12.166773Z","caller":"traceutil/trace.go:171","msg":"trace[1647949545] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24920; }","duration":"168.333637ms","start":"2026-06-02T13:08:11.99842Z","end":"2026-06-02T13:08:12.166753Z","steps":["trace[1647949545] 'agreement among raft nodes before linearized reading' (duration: 167.843687ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:12.32158Z","caller":"traceutil/trace.go:171","msg":"trace[1026612278] transaction","detail":"{read_only:false; response_revision:24924; number_of_response:1; }","duration":"118.66206ms","start":"2026-06-02T13:08:12.202893Z","end":"2026-06-02T13:08:12.321555Z","steps":["trace[1026612278] 'process raft request' (duration: 118.552778ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:12.321654Z","caller":"traceutil/trace.go:171","msg":"trace[100868782] transaction","detail":"{read_only:false; response_revision:24923; number_of_response:1; }","duration":"146.348981ms","start":"2026-06-02T13:08:12.175257Z","end":"2026-06-02T13:08:12.321606Z","steps":["trace[100868782] 'process raft request' (duration: 146.118526ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:12.32166Z","caller":"traceutil/trace.go:171","msg":"trace[809288848] transaction","detail":"{read_only:false; response_revision:24922; number_of_response:1; }","duration":"150.081722ms","start":"2026-06-02T13:08:12.171451Z","end":"2026-06-02T13:08:12.321533Z","steps":["trace[809288848] 'process raft request' (duration: 149.758136ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:12.919119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.430047ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:08:12.919265Z","caller":"traceutil/trace.go:171","msg":"trace[1161425111] transaction","detail":"{read_only:false; response_revision:24928; number_of_response:1; }","duration":"119.403693ms","start":"2026-06-02T13:08:12.799844Z","end":"2026-06-02T13:08:12.919248Z","steps":["trace[1161425111] 'process raft request' (duration: 119.352392ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:12.919379Z","caller":"traceutil/trace.go:171","msg":"trace[151366638] transaction","detail":"{read_only:false; response_revision:24927; number_of_response:1; }","duration":"253.817979ms","start":"2026-06-02T13:08:12.665531Z","end":"2026-06-02T13:08:12.919349Z","steps":["trace[151366638] 'process raft request' (duration: 146.086416ms)","trace[151366638] 'compare' (duration: 107.174552ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:12.91942Z","caller":"traceutil/trace.go:171","msg":"trace[1001863654] linearizableReadLoop","detail":"{readStateIndex:25730; appliedIndex:25729; }","duration":"142.352266ms","start":"2026-06-02T13:08:12.77706Z","end":"2026-06-02T13:08:12.919413Z","steps":["trace[1001863654] 'read index received' (duration: 34.570412ms)","trace[1001863654] 'applied index is now lower than readState.Index' (duration: 107.780944ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:12.919866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.780233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f22ad13a-7360-443a-b7d4-0f1ba504def4\" ","response":"range_response_count:1 size:3758"} {"level":"info","ts":"2026-06-02T13:08:12.920039Z","caller":"traceutil/trace.go:171","msg":"trace[1788838566] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f22ad13a-7360-443a-b7d4-0f1ba504def4; range_end:; response_count:1; response_revision:24928; }","duration":"142.997009ms","start":"2026-06-02T13:08:12.777022Z","end":"2026-06-02T13:08:12.920019Z","steps":["trace[1788838566] 'agreement among raft nodes before linearized reading' (duration: 142.680052ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:12.951871Z","caller":"traceutil/trace.go:171","msg":"trace[549165316] transaction","detail":"{read_only:false; response_revision:24929; number_of_response:1; }","duration":"128.721859ms","start":"2026-06-02T13:08:12.823132Z","end":"2026-06-02T13:08:12.951853Z","steps":["trace[549165316] 'process raft request' (duration: 128.549386ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:12.952014Z","caller":"traceutil/trace.go:171","msg":"trace[500171979] transaction","detail":"{read_only:false; response_revision:24930; number_of_response:1; }","duration":"127.055946ms","start":"2026-06-02T13:08:12.824949Z","end":"2026-06-02T13:08:12.952005Z","steps":["trace[500171979] 'process raft request' (duration: 126.863563ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:15.550851Z","caller":"traceutil/trace.go:171","msg":"trace[2045384942] linearizableReadLoop","detail":"{readStateIndex:25750; appliedIndex:25749; }","duration":"292.076522ms","start":"2026-06-02T13:08:15.258743Z","end":"2026-06-02T13:08:15.55082Z","steps":["trace[2045384942] 'read index received' (duration: 291.824466ms)","trace[2045384942] 'applied index is now lower than readState.Index' (duration: 250.716µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:15.551116Z","caller":"traceutil/trace.go:171","msg":"trace[1244167214] transaction","detail":"{read_only:false; response_revision:24947; number_of_response:1; }","duration":"297.919802ms","start":"2026-06-02T13:08:15.253136Z","end":"2026-06-02T13:08:15.551056Z","steps":["trace[1244167214] 'process raft request' (duration: 297.506843ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:15.551205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.445568ms","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-02T13:08:15.551273Z","caller":"traceutil/trace.go:171","msg":"trace[1964365259] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24947; }","duration":"292.569861ms","start":"2026-06-02T13:08:15.258687Z","end":"2026-06-02T13:08:15.551257Z","steps":["trace[1964365259] 'agreement among raft nodes before linearized reading' (duration: 292.316856ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:15.551312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.10921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-06-02T13:08:15.5514Z","caller":"traceutil/trace.go:171","msg":"trace[164673788] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:24947; }","duration":"179.261493ms","start":"2026-06-02T13:08:15.372118Z","end":"2026-06-02T13:08:15.551379Z","steps":["trace[164673788] 'agreement among raft nodes before linearized reading' (duration: 178.981968ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:15.697822Z","caller":"traceutil/trace.go:171","msg":"trace[292480483] linearizableReadLoop","detail":"{readStateIndex:25751; appliedIndex:25750; }","duration":"135.09804ms","start":"2026-06-02T13:08:15.562698Z","end":"2026-06-02T13:08:15.697796Z","steps":["trace[292480483] 'read index received' (duration: 93.879932ms)","trace[292480483] 'applied index is now lower than readState.Index' (duration: 41.216988ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:15.697913Z","caller":"traceutil/trace.go:171","msg":"trace[1811976670] transaction","detail":"{read_only:false; response_revision:24948; number_of_response:1; }","duration":"142.163323ms","start":"2026-06-02T13:08:15.5557Z","end":"2026-06-02T13:08:15.697863Z","steps":["trace[1811976670] 'process raft request' (duration: 100.883064ms)","trace[1811976670] 'compare' (duration: 41.093945ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:15.697987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.267753ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/poddisruptionbudgets/\" range_end:\"/registry/poddisruptionbudgets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T13:08:15.698087Z","caller":"traceutil/trace.go:171","msg":"trace[1897073914] range","detail":"{range_begin:/registry/poddisruptionbudgets/; range_end:/registry/poddisruptionbudgets0; response_count:0; response_revision:24948; }","duration":"135.363784ms","start":"2026-06-02T13:08:15.562651Z","end":"2026-06-02T13:08:15.698015Z","steps":["trace[1897073914] 'agreement among raft nodes before linearized reading' (duration: 135.246502ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:15.749026Z","caller":"traceutil/trace.go:171","msg":"trace[18409680] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"103.044504ms","start":"2026-06-02T13:08:15.645949Z","end":"2026-06-02T13:08:15.748994Z","steps":["trace[18409680] 'process raft request' (duration: 102.889171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:20.694758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.350603ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:08:20.69511Z","caller":"traceutil/trace.go:171","msg":"trace[1419323404] linearizableReadLoop","detail":"{readStateIndex:25812; appliedIndex:25810; }","duration":"339.989426ms","start":"2026-06-02T13:08:20.355094Z","end":"2026-06-02T13:08:20.695084Z","steps":["trace[1419323404] 'read index received' (duration: 35.199304ms)","trace[1419323404] 'applied index is now lower than readState.Index' (duration: 304.788722ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:20.695139Z","caller":"traceutil/trace.go:171","msg":"trace[1853567145] transaction","detail":"{read_only:false; response_revision:25006; number_of_response:1; }","duration":"406.697505ms","start":"2026-06-02T13:08:20.288387Z","end":"2026-06-02T13:08:20.695085Z","steps":["trace[1853567145] 'process raft request' (duration: 101.855562ms)","trace[1853567145] 'compare' (duration: 304.008757ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:20.695163Z","caller":"traceutil/trace.go:171","msg":"trace[1114580591] transaction","detail":"{read_only:false; response_revision:25007; number_of_response:1; }","duration":"346.859335ms","start":"2026-06-02T13:08:20.348267Z","end":"2026-06-02T13:08:20.695127Z","steps":["trace[1114580591] 'process raft request' (duration: 346.667002ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:20.695323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:20.348257Z","time spent":"346.977147ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:08:20.695328Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:20.288367Z","time spent":"406.845527ms","remote":"127.0.0.1:59432","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T13:08:20.695422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.266736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"warn","ts":"2026-06-02T13:08:20.695422Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.319001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T13:08:20.695508Z","caller":"traceutil/trace.go:171","msg":"trace[1151555549] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25007; }","duration":"132.399469ms","start":"2026-06-02T13:08:20.563085Z","end":"2026-06-02T13:08:20.695485Z","steps":["trace[1151555549] 'agreement among raft nodes before linearized reading' (duration: 132.235586ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:20.695516Z","caller":"traceutil/trace.go:171","msg":"trace[237910573] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25007; }","duration":"340.467054ms","start":"2026-06-02T13:08:20.355036Z","end":"2026-06-02T13:08:20.695503Z","steps":["trace[237910573] 'agreement among raft nodes before linearized reading' (duration: 340.110948ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:20.695652Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T13:08:20.355011Z","time spent":"340.593506ms","remote":"127.0.0.1:59432","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-02T13:08:20.695643Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.788075ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:20.695864Z","caller":"traceutil/trace.go:171","msg":"trace[1055640613] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:25007; }","duration":"249.201992ms","start":"2026-06-02T13:08:20.446638Z","end":"2026-06-02T13:08:20.69584Z","steps":["trace[1055640613] 'agreement among raft nodes before linearized reading' (duration: 248.679233ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:20.922188Z","caller":"traceutil/trace.go:171","msg":"trace[93587205] transaction","detail":"{read_only:false; response_revision:25008; number_of_response:1; }","duration":"222.720102ms","start":"2026-06-02T13:08:20.69943Z","end":"2026-06-02T13:08:20.92215Z","steps":["trace[93587205] 'process raft request' (duration: 128.407243ms)","trace[93587205] 'compare' (duration: 94.095185ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:21.095943Z","caller":"traceutil/trace.go:171","msg":"trace[1878599288] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"147.466852ms","start":"2026-06-02T13:08:20.948448Z","end":"2026-06-02T13:08:21.095915Z","steps":["trace[1878599288] 'process raft request' (duration: 147.250598ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:21.096395Z","caller":"traceutil/trace.go:171","msg":"trace[1690491040] transaction","detail":"{read_only:false; response_revision:25010; number_of_response:1; }","duration":"115.468728ms","start":"2026-06-02T13:08:20.980908Z","end":"2026-06-02T13:08:21.096377Z","steps":["trace[1690491040] 'process raft request' (duration: 115.352206ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:21.096547Z","caller":"traceutil/trace.go:171","msg":"trace[654549105] transaction","detail":"{read_only:false; response_revision:25011; number_of_response:1; }","duration":"114.186284ms","start":"2026-06-02T13:08:20.982324Z","end":"2026-06-02T13:08:21.09651Z","steps":["trace[654549105] 'process raft request' (duration: 114.015461ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:44.029591Z","caller":"traceutil/trace.go:171","msg":"trace[63777497] linearizableReadLoop","detail":"{readStateIndex:26008; appliedIndex:26007; }","duration":"152.625889ms","start":"2026-06-02T13:08:43.876938Z","end":"2026-06-02T13:08:44.029564Z","steps":["trace[63777497] 'read index received' (duration: 114.54067ms)","trace[63777497] 'applied index is now lower than readState.Index' (duration: 38.084089ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:44.029759Z","caller":"traceutil/trace.go:171","msg":"trace[1310155880] transaction","detail":"{read_only:false; response_revision:25197; number_of_response:1; }","duration":"187.731192ms","start":"2026-06-02T13:08:43.842016Z","end":"2026-06-02T13:08:44.029748Z","steps":["trace[1310155880] 'process raft request' (duration: 149.370507ms)","trace[1310155880] 'compare' (duration: 37.969507ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:44.029996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.033748ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:44.030026Z","caller":"traceutil/trace.go:171","msg":"trace[954342244] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:25197; }","duration":"153.124479ms","start":"2026-06-02T13:08:43.876893Z","end":"2026-06-02T13:08:44.030017Z","steps":["trace[954342244] 'agreement among raft nodes before linearized reading' (duration: 153.030577ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:44.044076Z","caller":"traceutil/trace.go:171","msg":"trace[1709243061] transaction","detail":"{read_only:false; response_revision:25198; number_of_response:1; }","duration":"155.092136ms","start":"2026-06-02T13:08:43.888955Z","end":"2026-06-02T13:08:44.044047Z","steps":["trace[1709243061] 'process raft request' (duration: 154.873052ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:08:44.044349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.219074ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:44.044412Z","caller":"traceutil/trace.go:171","msg":"trace[1965789205] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:25199; }","duration":"141.301097ms","start":"2026-06-02T13:08:43.903096Z","end":"2026-06-02T13:08:44.044397Z","steps":["trace[1965789205] 'agreement among raft nodes before linearized reading' (duration: 141.114763ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:44.044531Z","caller":"traceutil/trace.go:171","msg":"trace[2041137179] transaction","detail":"{read_only:false; response_revision:25199; number_of_response:1; }","duration":"155.33272ms","start":"2026-06-02T13:08:43.889162Z","end":"2026-06-02T13:08:44.044494Z","steps":["trace[2041137179] 'process raft request' (duration: 154.835091ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:44.89664Z","caller":"traceutil/trace.go:171","msg":"trace[1004999898] transaction","detail":"{read_only:false; response_revision:25202; number_of_response:1; }","duration":"116.956928ms","start":"2026-06-02T13:08:44.779588Z","end":"2026-06-02T13:08:44.896545Z","steps":["trace[1004999898] 'process raft request' (duration: 116.756784ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:45.141298Z","caller":"traceutil/trace.go:171","msg":"trace[1120719793] transaction","detail":"{read_only:false; response_revision:25204; number_of_response:1; }","duration":"110.281572ms","start":"2026-06-02T13:08:45.030988Z","end":"2026-06-02T13:08:45.141269Z","steps":["trace[1120719793] 'process raft request' (duration: 110.102577ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:46.174578Z","caller":"traceutil/trace.go:171","msg":"trace[916323717] transaction","detail":"{read_only:false; response_revision:25211; number_of_response:1; }","duration":"125.57973ms","start":"2026-06-02T13:08:46.048973Z","end":"2026-06-02T13:08:46.174553Z","steps":["trace[916323717] 'process raft request' (duration: 125.153382ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:46.17491Z","caller":"traceutil/trace.go:171","msg":"trace[835102918] transaction","detail":"{read_only:false; response_revision:25212; number_of_response:1; }","duration":"101.171298ms","start":"2026-06-02T13:08:46.073722Z","end":"2026-06-02T13:08:46.174893Z","steps":["trace[835102918] 'process raft request' (duration: 100.567907ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:46.317501Z","caller":"traceutil/trace.go:171","msg":"trace[1974619249] linearizableReadLoop","detail":"{readStateIndex:26025; appliedIndex:26023; }","duration":"135.052359ms","start":"2026-06-02T13:08:46.182424Z","end":"2026-06-02T13:08:46.317476Z","steps":["trace[1974619249] 'read index received' (duration: 95.764708ms)","trace[1974619249] 'applied index is now lower than readState.Index' (duration: 39.286711ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:08:46.317659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.192122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/probes/\" range_end:\"/registry/monitoring.coreos.com/probes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:08:46.317702Z","caller":"traceutil/trace.go:171","msg":"trace[1254561460] range","detail":"{range_begin:/registry/monitoring.coreos.com/probes/; range_end:/registry/monitoring.coreos.com/probes0; response_count:0; response_revision:25213; }","duration":"135.274883ms","start":"2026-06-02T13:08:46.182416Z","end":"2026-06-02T13:08:46.317691Z","steps":["trace[1254561460] 'agreement among raft nodes before linearized reading' (duration: 135.148961ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:46.317852Z","caller":"traceutil/trace.go:171","msg":"trace[708692449] transaction","detail":"{read_only:false; response_revision:25213; number_of_response:1; }","duration":"137.679908ms","start":"2026-06-02T13:08:46.180144Z","end":"2026-06-02T13:08:46.317824Z","steps":["trace[708692449] 'process raft request' (duration: 137.188709ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:47.019531Z","caller":"traceutil/trace.go:171","msg":"trace[434893191] transaction","detail":"{read_only:false; response_revision:25216; number_of_response:1; }","duration":"117.008928ms","start":"2026-06-02T13:08:46.902476Z","end":"2026-06-02T13:08:47.019485Z","steps":["trace[434893191] 'process raft request' (duration: 116.793594ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:47.141289Z","caller":"traceutil/trace.go:171","msg":"trace[1125384375] transaction","detail":"{read_only:false; response_revision:25217; number_of_response:1; }","duration":"115.452427ms","start":"2026-06-02T13:08:47.025784Z","end":"2026-06-02T13:08:47.141236Z","steps":["trace[1125384375] 'process raft request' (duration: 36.167741ms)","trace[1125384375] 'compare' (duration: 78.969131ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:08:47.397131Z","caller":"traceutil/trace.go:171","msg":"trace[1404696466] transaction","detail":"{read_only:false; response_revision:25221; number_of_response:1; }","duration":"118.464966ms","start":"2026-06-02T13:08:47.278637Z","end":"2026-06-02T13:08:47.397102Z","steps":["trace[1404696466] 'process raft request' (duration: 118.324783ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:08:58.888303Z","caller":"traceutil/trace.go:171","msg":"trace[135505466] transaction","detail":"{read_only:false; response_revision:25314; number_of_response:1; }","duration":"213.224988ms","start":"2026-06-02T13:08:58.675043Z","end":"2026-06-02T13:08:58.888268Z","steps":["trace[135505466] 'process raft request' (duration: 138.505731ms)","trace[135505466] 'compare' (duration: 74.456983ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:09:19.529826Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.340606ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:09:19.529974Z","caller":"traceutil/trace.go:171","msg":"trace[946569980] linearizableReadLoop","detail":"{readStateIndex:26283; appliedIndex:26282; }","duration":"191.809224ms","start":"2026-06-02T13:09:19.338143Z","end":"2026-06-02T13:09:19.529952Z","steps":["trace[946569980] 'read index received' (duration: 61.09564ms)","trace[946569980] 'applied index is now lower than readState.Index' (duration: 130.712144ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:09:19.530186Z","caller":"traceutil/trace.go:171","msg":"trace[348882164] transaction","detail":"{read_only:false; response_revision:25465; number_of_response:1; }","duration":"216.768625ms","start":"2026-06-02T13:09:19.313347Z","end":"2026-06-02T13:09:19.530115Z","steps":["trace[348882164] 'process raft request' (duration: 86.02072ms)","trace[348882164] 'compare' (duration: 130.140633ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T13:09:19.530275Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.12404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T13:09:19.530353Z","caller":"traceutil/trace.go:171","msg":"trace[988478990] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25465; }","duration":"192.231342ms","start":"2026-06-02T13:09:19.338106Z","end":"2026-06-02T13:09:19.530337Z","steps":["trace[988478990] 'agreement among raft nodes before linearized reading' (duration: 191.905256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:09:24.891975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.417207ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T13:09:24.892199Z","caller":"traceutil/trace.go:171","msg":"trace[974562419] transaction","detail":"{read_only:false; response_revision:25505; number_of_response:1; }","duration":"208.956727ms","start":"2026-06-02T13:09:24.683175Z","end":"2026-06-02T13:09:24.892131Z","steps":["trace[974562419] 'process raft request' (duration: 60.169724ms)","trace[974562419] 'compare' (duration: 147.870067ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:09:25.620411Z","caller":"traceutil/trace.go:171","msg":"trace[578201826] transaction","detail":"{read_only:false; response_revision:25508; number_of_response:1; }","duration":"256.646997ms","start":"2026-06-02T13:09:25.363743Z","end":"2026-06-02T13:09:25.62039Z","steps":["trace[578201826] 'process raft request' (duration: 256.485533ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:09:26.110081Z","caller":"traceutil/trace.go:171","msg":"trace[1341004770] linearizableReadLoop","detail":"{readStateIndex:26332; appliedIndex:26331; }","duration":"167.887053ms","start":"2026-06-02T13:09:25.942167Z","end":"2026-06-02T13:09:26.110054Z","steps":["trace[1341004770] 'read index received' (duration: 167.72283ms)","trace[1341004770] 'applied index is now lower than readState.Index' (duration: 163.253µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T13:09:26.110166Z","caller":"traceutil/trace.go:171","msg":"trace[1735781261] transaction","detail":"{read_only:false; response_revision:25513; number_of_response:1; }","duration":"174.323344ms","start":"2026-06-02T13:09:25.935788Z","end":"2026-06-02T13:09:26.110111Z","steps":["trace[1735781261] 'process raft request' (duration: 174.042519ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T13:09:26.110206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.043047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T13:09:26.110249Z","caller":"traceutil/trace.go:171","msg":"trace[923848417] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25513; }","duration":"168.153149ms","start":"2026-06-02T13:09:25.942082Z","end":"2026-06-02T13:09:26.110235Z","steps":["trace[923848417] 'agreement among raft nodes before linearized reading' (duration: 168.067137ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T13:10:28.941296Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006995.wal"} {"level":"info","ts":"2026-06-02T13:10:33.148878Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23414} {"level":"info","ts":"2026-06-02T13:10:33.36755Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23414,"took":"214.580105ms","hash":1712380570,"current-db-size-bytes":60370944,"current-db-size":"60 MB","current-db-size-in-use-bytes":36634624,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-02T13:10:33.367614Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1712380570,"revision":23414,"compact-revision":20208} {"level":"info","ts":"2026-06-02T13:15:33.154555Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26235} {"level":"info","ts":"2026-06-02T13:15:33.30388Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26235,"took":"142.533096ms","hash":3779768233,"current-db-size-bytes":60370944,"current-db-size":"60 MB","current-db-size-in-use-bytes":34611200,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-02T13:15:33.303974Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3779768233,"revision":26235,"compact-revision":23414} {"level":"info","ts":"2026-06-02T13:15:58.542733Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T13:15:58.548178Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-02T13:15:58.548326Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-02T13:20:33.166266Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28904} {"level":"info","ts":"2026-06-02T13:20:33.30457Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28904,"took":"133.639112ms","hash":417186439,"current-db-size-bytes":60370944,"current-db-size":"60 MB","current-db-size-in-use-bytes":30552064,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-02T13:20:33.304646Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":417186439,"revision":28904,"compact-revision":26235} {"level":"info","ts":"2026-06-02T13:25:33.17067Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31124} {"level":"info","ts":"2026-06-02T13:25:33.296106Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31124,"took":"121.704269ms","hash":1689699782,"current-db-size-bytes":60370944,"current-db-size":"60 MB","current-db-size-in-use-bytes":30490624,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-02T13:25:33.296194Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1689699782,"revision":31124,"compact-revision":28904} {"level":"info","ts":"2026-06-02T13:30:33.182841Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33389} {"level":"info","ts":"2026-06-02T13:30:33.3424Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33389,"took":"155.944582ms","hash":1898843314,"current-db-size-bytes":60370944,"current-db-size":"60 MB","current-db-size-in-use-bytes":32440320,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-02T13:30:33.342455Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1898843314,"revision":33389,"compact-revision":31124} {"level":"info","ts":"2026-06-02T13:35:33.198863Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35686} {"level":"info","ts":"2026-06-02T13:35:33.335076Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35686,"took":"132.920009ms","hash":2061427355,"current-db-size-bytes":62111744,"current-db-size":"62 MB","current-db-size-in-use-bytes":31342592,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-02T13:35:33.335134Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2061427355,"revision":35686,"compact-revision":33389} {"level":"info","ts":"2026-06-02T13:37:26.607127Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5ac240a6daec2148","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T13:37:26.612077Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-02T13:37:26.612201Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004}