{"level":"warn","ts":"2026-06-10T10:08:40.493241Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:08:40.493328Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95: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.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-10T10:08:40.493394Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-10T10:08:40.493402Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-06-10T10:08:40.493423Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T10:08:40.494096Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-06-10T10:08:40.494166Z","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.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-10T10:08:40.499523Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.757601ms"} {"level":"info","ts":"2026-06-10T10:08:40.51228Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-06-10T10:08:40.512375Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-06-10T10:08:40.512433Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-06-10T10:08:40.512449Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-10T10:08:40.512459Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-06-10T10:08:40.512576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-06-10T10:08:40.518247Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-10T10:08:40.519401Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-10T10:08:40.520597Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-10T10:08:40.524291Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-10T10:08:40.524838Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-10T10:08:40.5247Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:08:40.52533Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:08:40.525358Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-10T10:08:40.525526Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-06-10T10:08:40.525659Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-06-10T10:08:40.527144Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-10T10:08:40.527318Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-06-10T10:08:40.527374Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-06-10T10:08:40.527394Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-10T10:08:40.527422Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-10T10:08:41.513807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-06-10T10:08:41.513867Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-06-10T10:08:41.513916Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-06-10T10:08:41.513946Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-06-10T10:08:41.513986Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-06-10T10:08:41.514079Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-06-10T10:08:41.514148Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-06-10T10:08:41.515732Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-06-10T10:08:41.515743Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:08:41.515767Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:41.515845Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-10T10:08:41.516082Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-10T10:08:41.516181Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-10T10:08:41.516702Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:41.516897Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:41.51694Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-10T10:08:41.51931Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-10T10:08:41.52093Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-06-10T10:08:53.474265Z","caller":"traceutil/trace.go:171","msg":"trace[1410355642] transaction","detail":"{read_only:false; response_revision:400; number_of_response:1; }","duration":"170.641951ms","start":"2026-06-10T10:08:53.303585Z","end":"2026-06-10T10:08:53.474227Z","steps":["trace[1410355642] 'process raft request' (duration: 170.398224ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:53.796087Z","caller":"traceutil/trace.go:171","msg":"trace[502271000] transaction","detail":"{read_only:false; response_revision:401; number_of_response:1; }","duration":"313.480102ms","start":"2026-06-10T10:08:53.482565Z","end":"2026-06-10T10:08:53.796045Z","steps":["trace[502271000] 'process raft request' (duration: 313.216215ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:08:53.796256Z","caller":"traceutil/trace.go:171","msg":"trace[1423746946] linearizableReadLoop","detail":"{readStateIndex:409; appliedIndex:408; }","duration":"241.363217ms","start":"2026-06-10T10:08:53.554582Z","end":"2026-06-10T10:08:53.795945Z","steps":["trace[1423746946] 'read index received' (duration: 240.883853ms)","trace[1423746946] 'applied index is now lower than readState.Index' (duration: 478.314µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:08:53.796215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.600443ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:08:53.796472Z","caller":"traceutil/trace.go:171","msg":"trace[721688245] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:401; }","duration":"241.872662ms","start":"2026-06-10T10:08:53.554573Z","end":"2026-06-10T10:08:53.796445Z","steps":["trace[721688245] 'agreement among raft nodes before linearized reading' (duration: 241.552063ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:08:53.796943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:08:53.482535Z","time spent":"313.72867ms","remote":"127.0.0.1:50218","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2903,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:08:54.001037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.42047ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T10:08:54.001085Z","caller":"traceutil/trace.go:171","msg":"trace[884506395] transaction","detail":"{read_only:false; response_revision:402; number_of_response:1; }","duration":"195.172729ms","start":"2026-06-10T10:08:53.805879Z","end":"2026-06-10T10:08:54.001052Z","steps":["trace[884506395] 'process raft request' (duration: 100.84093ms)","trace[884506395] 'compare' (duration: 94.154074ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:08:54.001156Z","caller":"traceutil/trace.go:171","msg":"trace[1438331457] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:401; }","duration":"198.572633ms","start":"2026-06-10T10:08:53.802556Z","end":"2026-06-10T10:08:54.001128Z","steps":["trace[1438331457] 'range keys from in-memory index tree' (duration: 198.317066ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:22.294462Z","caller":"traceutil/trace.go:171","msg":"trace[921234368] transaction","detail":"{read_only:false; response_revision:627; number_of_response:1; }","duration":"114.702454ms","start":"2026-06-10T10:09:22.179739Z","end":"2026-06-10T10:09:22.294442Z","steps":["trace[921234368] 'process raft request' (duration: 114.530199ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:23.146502Z","caller":"traceutil/trace.go:171","msg":"trace[582256207] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"172.898723ms","start":"2026-06-10T10:09:22.973579Z","end":"2026-06-10T10:09:23.146477Z","steps":["trace[582256207] 'process raft request' (duration: 172.752639ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:23.332028Z","caller":"traceutil/trace.go:171","msg":"trace[1240535481] linearizableReadLoop","detail":"{readStateIndex:654; appliedIndex:653; }","duration":"141.972787ms","start":"2026-06-10T10:09:23.190031Z","end":"2026-06-10T10:09:23.332004Z","steps":["trace[1240535481] 'read index received' (duration: 114.818057ms)","trace[1240535481] 'applied index is now lower than readState.Index' (duration: 27.15111ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:09:23.332115Z","caller":"traceutil/trace.go:171","msg":"trace[1683592277] transaction","detail":"{read_only:false; response_revision:633; number_of_response:1; }","duration":"355.844765ms","start":"2026-06-10T10:09:22.976245Z","end":"2026-06-10T10:09:23.332089Z","steps":["trace[1683592277] 'process raft request' (duration: 328.801527ms)","trace[1683592277] 'compare' (duration: 26.618456ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:09:23.332251Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:09:22.976215Z","time spent":"355.955968ms","remote":"127.0.0.1:49840","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036309,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:09:23.332323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.252866ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:504"} {"level":"info","ts":"2026-06-10T10:09:23.332424Z","caller":"traceutil/trace.go:171","msg":"trace[777724805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:633; }","duration":"142.41133ms","start":"2026-06-10T10:09:23.189991Z","end":"2026-06-10T10:09:23.332402Z","steps":["trace[777724805] 'agreement among raft nodes before linearized reading' (duration: 142.107191ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:09:23.654467Z","caller":"traceutil/trace.go:171","msg":"trace[1039174350] transaction","detail":"{read_only:false; response_revision:635; number_of_response:1; }","duration":"258.847221ms","start":"2026-06-10T10:09:23.395545Z","end":"2026-06-10T10:09:23.654392Z","steps":["trace[1039174350] 'process raft request' (duration: 243.028354ms)","trace[1039174350] 'compare' (duration: 15.587431ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:09:39.530086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.712774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-10T10:09:39.53018Z","caller":"traceutil/trace.go:171","msg":"trace[188309018] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:797; }","duration":"118.866349ms","start":"2026-06-10T10:09:39.411299Z","end":"2026-06-10T10:09:39.530165Z","steps":["trace[188309018] 'range keys from in-memory index tree' (duration: 118.537949ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:10:53.045813Z","caller":"traceutil/trace.go:171","msg":"trace[429135564] transaction","detail":"{read_only:false; response_revision:1860; number_of_response:1; }","duration":"263.916529ms","start":"2026-06-10T10:10:52.781872Z","end":"2026-06-10T10:10:53.045788Z","steps":["trace[429135564] 'process raft request' (duration: 263.748004ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:10:53.108029Z","caller":"traceutil/trace.go:171","msg":"trace[1469448647] linearizableReadLoop","detail":"{readStateIndex:1930; appliedIndex:1928; }","duration":"311.436873ms","start":"2026-06-10T10:10:52.796568Z","end":"2026-06-10T10:10:53.108005Z","steps":["trace[1469448647] 'read index received' (duration: 249.067948ms)","trace[1469448647] 'applied index is now lower than readState.Index' (duration: 62.367765ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:10:53.108098Z","caller":"traceutil/trace.go:171","msg":"trace[326012455] transaction","detail":"{read_only:false; response_revision:1861; number_of_response:1; }","duration":"312.635746ms","start":"2026-06-10T10:10:52.795434Z","end":"2026-06-10T10:10:53.10807Z","steps":["trace[326012455] 'process raft request' (duration: 291.815721ms)","trace[326012455] 'compare' (duration: 20.645311ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:10:53.108263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.538552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f3441b09-571f-4374-88c1-0978180c22b7\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-06-10T10:10:53.108267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:52.795412Z","time spent":"312.753259ms","remote":"127.0.0.1:50016","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-10T10:10:53.108301Z","caller":"traceutil/trace.go:171","msg":"trace[260176782] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f3441b09-571f-4374-88c1-0978180c22b7; range_end:; response_count:1; response_revision:1861; }","duration":"304.613344ms","start":"2026-06-10T10:10:52.803675Z","end":"2026-06-10T10:10:53.108288Z","steps":["trace[260176782] 'agreement among raft nodes before linearized reading' (duration: 304.4638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:53.108336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:52.803663Z","time spent":"304.664205ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f3441b09-571f-4374-88c1-0978180c22b7\" "} {"level":"warn","ts":"2026-06-10T10:10:53.108317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.728051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-10T10:10:53.108406Z","caller":"traceutil/trace.go:171","msg":"trace[1734462244] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1861; }","duration":"311.894236ms","start":"2026-06-10T10:10:52.796484Z","end":"2026-06-10T10:10:53.108379Z","steps":["trace[1734462244] 'agreement among raft nodes before linearized reading' (duration: 311.652169ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:53.108457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:10:52.796461Z","time spent":"311.987728ms","remote":"127.0.0.1:50878","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5436,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-06-10T10:10:53.542157Z","caller":"traceutil/trace.go:171","msg":"trace[1349911396] linearizableReadLoop","detail":"{readStateIndex:1938; appliedIndex:1937; }","duration":"181.51705ms","start":"2026-06-10T10:10:53.360614Z","end":"2026-06-10T10:10:53.542131Z","steps":["trace[1349911396] 'read index received' (duration: 99.817341ms)","trace[1349911396] 'applied index is now lower than readState.Index' (duration: 81.698709ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:10:53.542239Z","caller":"traceutil/trace.go:171","msg":"trace[1567172734] transaction","detail":"{read_only:false; response_revision:1869; number_of_response:1; }","duration":"196.588827ms","start":"2026-06-10T10:10:53.34559Z","end":"2026-06-10T10:10:53.542179Z","steps":["trace[1567172734] 'process raft request' (duration: 114.97667ms)","trace[1567172734] 'compare' (duration: 81.421582ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:10:53.542294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.667835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:10:53.542377Z","caller":"traceutil/trace.go:171","msg":"trace[282564598] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1869; }","duration":"181.759717ms","start":"2026-06-10T10:10:53.360599Z","end":"2026-06-10T10:10:53.542359Z","steps":["trace[282564598] 'agreement among raft nodes before linearized reading' (duration: 181.625244ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:10:53.542418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.608388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f3441b09-571f-4374-88c1-0978180c22b7\" ","response":"range_response_count:1 size:3746"} {"level":"info","ts":"2026-06-10T10:10:53.542459Z","caller":"traceutil/trace.go:171","msg":"trace[515482480] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f3441b09-571f-4374-88c1-0978180c22b7; range_end:; response_count:1; response_revision:1869; }","duration":"136.709811ms","start":"2026-06-10T10:10:53.405737Z","end":"2026-06-10T10:10:53.542447Z","steps":["trace[515482480] 'agreement among raft nodes before linearized reading' (duration: 136.545046ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:09.272472Z","caller":"traceutil/trace.go:171","msg":"trace[1431742968] transaction","detail":"{read_only:false; response_revision:2000; number_of_response:1; }","duration":"111.174474ms","start":"2026-06-10T10:11:09.161268Z","end":"2026-06-10T10:11:09.272443Z","steps":["trace[1431742968] 'process raft request' (duration: 110.989659ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:09.464273Z","caller":"traceutil/trace.go:171","msg":"trace[14370722] linearizableReadLoop","detail":"{readStateIndex:2074; appliedIndex:2073; }","duration":"100.416338ms","start":"2026-06-10T10:11:09.363837Z","end":"2026-06-10T10:11:09.464253Z","steps":["trace[14370722] 'read index received' (duration: 100.253453ms)","trace[14370722] 'applied index is now lower than readState.Index' (duration: 161.934µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:11:09.464389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.53352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:11:09.464438Z","caller":"traceutil/trace.go:171","msg":"trace[26220385] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2001; }","duration":"100.608702ms","start":"2026-06-10T10:11:09.363821Z","end":"2026-06-10T10:11:09.46443Z","steps":["trace[26220385] 'agreement among raft nodes before linearized reading' (duration: 100.51738ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:09.46467Z","caller":"traceutil/trace.go:171","msg":"trace[838556969] transaction","detail":"{read_only:false; response_revision:2001; number_of_response:1; }","duration":"181.772008ms","start":"2026-06-10T10:11:09.282884Z","end":"2026-06-10T10:11:09.464656Z","steps":["trace[838556969] 'process raft request' (duration: 181.253393ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:11:43.381081Z","caller":"traceutil/trace.go:171","msg":"trace[1980875851] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"103.025269ms","start":"2026-06-10T10:11:43.278027Z","end":"2026-06-10T10:11:43.381053Z","steps":["trace[1980875851] 'process raft request' (duration: 102.743012ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:03.296639Z","caller":"traceutil/trace.go:171","msg":"trace[1155299764] transaction","detail":"{read_only:false; response_revision:5172; number_of_response:1; }","duration":"109.839783ms","start":"2026-06-10T10:17:03.186755Z","end":"2026-06-10T10:17:03.296595Z","steps":["trace[1155299764] 'process raft request' (duration: 76.352608ms)","trace[1155299764] 'compare' (duration: 33.195807ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:11.563263Z","caller":"traceutil/trace.go:171","msg":"trace[1225066752] linearizableReadLoop","detail":"{readStateIndex:5491; appliedIndex:5490; }","duration":"202.803239ms","start":"2026-06-10T10:17:11.360436Z","end":"2026-06-10T10:17:11.563239Z","steps":["trace[1225066752] 'read index received' (duration: 202.634335ms)","trace[1225066752] 'applied index is now lower than readState.Index' (duration: 167.634µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:17:11.563324Z","caller":"traceutil/trace.go:171","msg":"trace[883414435] transaction","detail":"{read_only:false; response_revision:5295; number_of_response:1; }","duration":"210.956325ms","start":"2026-06-10T10:17:11.352336Z","end":"2026-06-10T10:17:11.563292Z","steps":["trace[883414435] 'process raft request' (duration: 210.752529ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:11.563442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.964064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:17:11.563545Z","caller":"traceutil/trace.go:171","msg":"trace[1463979075] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5295; }","duration":"203.113738ms","start":"2026-06-10T10:17:11.360416Z","end":"2026-06-10T10:17:11.56353Z","steps":["trace[1463979075] 'agreement among raft nodes before linearized reading' (duration: 202.950644ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:17:11.598979Z","caller":"traceutil/trace.go:171","msg":"trace[223387256] transaction","detail":"{read_only:false; response_revision:5296; number_of_response:1; }","duration":"221.749153ms","start":"2026-06-10T10:17:11.377189Z","end":"2026-06-10T10:17:11.598938Z","steps":["trace[223387256] 'process raft request' (duration: 221.524097ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:11.599077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.65208ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-10T10:17:11.59914Z","caller":"traceutil/trace.go:171","msg":"trace[1728164529] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5296; }","duration":"217.766993ms","start":"2026-06-10T10:17:11.381358Z","end":"2026-06-10T10:17:11.599125Z","steps":["trace[1728164529] 'agreement among raft nodes before linearized reading' (duration: 217.539887ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:17:12.045986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.863395ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:17:12.046132Z","caller":"traceutil/trace.go:171","msg":"trace[636281960] transaction","detail":"{read_only:false; response_revision:5300; number_of_response:1; }","duration":"150.724081ms","start":"2026-06-10T10:17:11.895381Z","end":"2026-06-10T10:17:12.046105Z","steps":["trace[636281960] 'process raft request' (duration: 28.479326ms)","trace[636281960] 'compare' (duration: 121.69015ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:18:41.549908Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3025} {"level":"info","ts":"2026-06-10T10:18:41.63462Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3025,"took":"83.499917ms","hash":4232319971,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":32243712,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T10:18:41.634705Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4232319971,"revision":3025,"compact-revision":-1} {"level":"info","ts":"2026-06-10T10:23:32.45412Z","caller":"traceutil/trace.go:171","msg":"trace[1796341617] linearizableReadLoop","detail":"{readStateIndex:8585; appliedIndex:8584; }","duration":"120.61722ms","start":"2026-06-10T10:23:32.333482Z","end":"2026-06-10T10:23:32.454099Z","steps":["trace[1796341617] 'read index received' (duration: 120.496607ms)","trace[1796341617] 'applied index is now lower than readState.Index' (duration: 119.943µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:23:32.45416Z","caller":"traceutil/trace.go:171","msg":"trace[131241856] transaction","detail":"{read_only:false; response_revision:8294; number_of_response:1; }","duration":"120.679962ms","start":"2026-06-10T10:23:32.33344Z","end":"2026-06-10T10:23:32.45412Z","steps":["trace[131241856] 'process raft request' (duration: 120.530298ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:23:32.454293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.791235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-06-10T10:23:32.454325Z","caller":"traceutil/trace.go:171","msg":"trace[983139938] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:8294; }","duration":"120.840026ms","start":"2026-06-10T10:23:32.333475Z","end":"2026-06-10T10:23:32.454315Z","steps":["trace[983139938] 'agreement among raft nodes before linearized reading' (duration: 120.709083ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:23:32.632402Z","caller":"traceutil/trace.go:171","msg":"trace[1239009582] transaction","detail":"{read_only:false; response_revision:8295; number_of_response:1; }","duration":"145.426255ms","start":"2026-06-10T10:23:32.486946Z","end":"2026-06-10T10:23:32.632372Z","steps":["trace[1239009582] 'process raft request' (duration: 144.16081ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:23:41.555682Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6172} {"level":"info","ts":"2026-06-10T10:23:41.653265Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6172,"took":"95.793635ms","hash":2235936597,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":23863296,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-10T10:23:41.653347Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2235936597,"revision":6172,"compact-revision":3025} {"level":"info","ts":"2026-06-10T10:23:44.175424Z","caller":"traceutil/trace.go:171","msg":"trace[18238991] transaction","detail":"{read_only:false; response_revision:8357; number_of_response:1; }","duration":"104.669779ms","start":"2026-06-10T10:23:44.070731Z","end":"2026-06-10T10:23:44.175401Z","steps":["trace[18238991] 'process raft request' (duration: 32.170578ms)","trace[18238991] 'compare' (duration: 72.408019ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:23:44.936163Z","caller":"traceutil/trace.go:171","msg":"trace[139463034] transaction","detail":"{read_only:false; response_revision:8362; number_of_response:1; }","duration":"156.258293ms","start":"2026-06-10T10:23:44.779879Z","end":"2026-06-10T10:23:44.936137Z","steps":["trace[139463034] 'process raft request' (duration: 156.095959ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:23:46.36565Z","caller":"traceutil/trace.go:171","msg":"trace[480163959] transaction","detail":"{read_only:false; response_revision:8369; number_of_response:1; }","duration":"140.870549ms","start":"2026-06-10T10:23:46.22475Z","end":"2026-06-10T10:23:46.365621Z","steps":["trace[480163959] 'process raft request' (duration: 140.582071ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:13.136678Z","caller":"traceutil/trace.go:171","msg":"trace[103982165] transaction","detail":"{read_only:false; response_revision:8565; number_of_response:1; }","duration":"102.100749ms","start":"2026-06-10T10:24:13.034544Z","end":"2026-06-10T10:24:13.136644Z","steps":["trace[103982165] 'process raft request' (duration: 101.925974ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:24:13.313945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.341986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-10T10:24:13.314058Z","caller":"traceutil/trace.go:171","msg":"trace[976588163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8565; }","duration":"102.49355ms","start":"2026-06-10T10:24:13.211542Z","end":"2026-06-10T10:24:13.314035Z","steps":["trace[976588163] 'range keys from in-memory index tree' (duration: 102.207652ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:25.893706Z","caller":"traceutil/trace.go:171","msg":"trace[1240883564] transaction","detail":"{read_only:false; response_revision:8676; number_of_response:1; }","duration":"100.771842ms","start":"2026-06-10T10:24:25.792917Z","end":"2026-06-10T10:24:25.893688Z","steps":["trace[1240883564] 'process raft request' (duration: 100.388531ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:26.064279Z","caller":"traceutil/trace.go:171","msg":"trace[1911433636] transaction","detail":"{read_only:false; response_revision:8677; number_of_response:1; }","duration":"167.735071ms","start":"2026-06-10T10:24:25.896519Z","end":"2026-06-10T10:24:26.064254Z","steps":["trace[1911433636] 'process raft request' (duration: 160.170262ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:26.067569Z","caller":"traceutil/trace.go:171","msg":"trace[1472168642] transaction","detail":"{read_only:false; response_revision:8678; number_of_response:1; }","duration":"170.690723ms","start":"2026-06-10T10:24:25.896853Z","end":"2026-06-10T10:24:26.067544Z","steps":["trace[1472168642] 'process raft request' (duration: 170.539698ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:24:41.62712Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023b9.wal"} {"level":"info","ts":"2026-06-10T10:26:15.126997Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T10:26:15.132039Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-10T10:26:15.132122Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"warn","ts":"2026-06-10T10:26:28.710105Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813656627,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:26:29.21097Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813656627,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:26:29.711325Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813656627,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:26:30.211809Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813656627,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T10:26:30.712395Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813656627,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:26:31.079482Z","caller":"traceutil/trace.go:171","msg":"trace[205325830] transaction","detail":"{read_only:false; response_revision:9757; number_of_response:1; }","duration":"3.089478943s","start":"2026-06-10T10:26:27.98998Z","end":"2026-06-10T10:26:31.079459Z","steps":["trace[205325830] 'process raft request' (duration: 3.089323388s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.07961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:27.98996Z","time spent":"3.089584046s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.089773Z","caller":"traceutil/trace.go:171","msg":"trace[2004142265] transaction","detail":"{read_only:false; response_revision:9759; number_of_response:1; }","duration":"2.629970614s","start":"2026-06-10T10:26:28.459778Z","end":"2026-06-10T10:26:31.089749Z","steps":["trace[2004142265] 'process raft request' (duration: 2.629910662s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.089903Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.459753Z","time spent":"2.630089037s","remote":"127.0.0.1:50016","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-10T10:26:31.089774Z","caller":"traceutil/trace.go:171","msg":"trace[1732731349] transaction","detail":"{read_only:false; response_revision:9758; number_of_response:1; }","duration":"3.097116363s","start":"2026-06-10T10:26:27.992622Z","end":"2026-06-10T10:26:31.089739Z","steps":["trace[1732731349] 'process raft request' (duration: 3.096958119s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.09003Z","caller":"traceutil/trace.go:171","msg":"trace[1453915961] transaction","detail":"{read_only:false; response_revision:9760; number_of_response:1; }","duration":"1.928374744s","start":"2026-06-10T10:26:29.16163Z","end":"2026-06-10T10:26:31.090005Z","steps":["trace[1453915961] 'process raft request' (duration: 1.928094116s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.090083Z","caller":"traceutil/trace.go:171","msg":"trace[1177184186] transaction","detail":"{read_only:false; response_revision:9761; number_of_response:1; }","duration":"1.701777951s","start":"2026-06-10T10:26:29.388278Z","end":"2026-06-10T10:26:31.090056Z","steps":["trace[1177184186] 'process raft request' (duration: 1.701611896s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.090197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.161609Z","time spent":"1.928479607s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:31.090072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:27.992601Z","time spent":"3.097389391s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:26:31.090255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.388255Z","time spent":"1.701913364s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:26:31.090138Z","caller":"traceutil/trace.go:171","msg":"trace[1322493287] transaction","detail":"{read_only:false; response_revision:9762; number_of_response:1; }","duration":"1.411946313s","start":"2026-06-10T10:26:29.678182Z","end":"2026-06-10T10:26:31.090128Z","steps":["trace[1322493287] 'process raft request' (duration: 1.411792049s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.090528Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.678159Z","time spent":"1.412337153s","remote":"127.0.0.1:50016","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-10T10:26:31.09368Z","caller":"traceutil/trace.go:171","msg":"trace[275259429] linearizableReadLoop","detail":"{readStateIndex:10100; appliedIndex:10093; }","duration":"2.88463508s","start":"2026-06-10T10:26:28.209031Z","end":"2026-06-10T10:26:31.093666Z","steps":["trace[275259429] 'read index received' (duration: 2.870346576s)","trace[275259429] 'applied index is now lower than readState.Index' (duration: 14.287514ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:26:31.093883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.884853316s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-sbtkb\" ","response":"range_response_count:1 size:6441"} {"level":"warn","ts":"2026-06-10T10:26:31.093906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.82059602s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T10:26:31.093945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.494235793s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-06-10T10:26:31.093919Z","caller":"traceutil/trace.go:171","msg":"trace[2038557936] range","detail":"{range_begin:/registry/pods/openstack/keepalived-sbtkb; range_end:; response_count:1; response_revision:9762; }","duration":"2.884939208s","start":"2026-06-10T10:26:28.208971Z","end":"2026-06-10T10:26:31.09391Z","steps":["trace[2038557936] 'agreement among raft nodes before linearized reading' (duration: 2.884818005s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.093964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.600671595s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-10T10:26:31.093977Z","caller":"traceutil/trace.go:171","msg":"trace[657701902] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:9762; }","duration":"1.494317746s","start":"2026-06-10T10:26:29.59965Z","end":"2026-06-10T10:26:31.093968Z","steps":["trace[657701902] 'agreement among raft nodes before linearized reading' (duration: 1.494243984s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.093984Z","caller":"traceutil/trace.go:171","msg":"trace[394087459] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:9762; }","duration":"2.600721596s","start":"2026-06-10T10:26:28.493256Z","end":"2026-06-10T10:26:31.093978Z","steps":["trace[394087459] 'agreement among raft nodes before linearized reading' (duration: 2.600681855s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.093998Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.599629Z","time spent":"1.494364186s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":583,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-10T10:26:31.094061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.468270601s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-06-10T10:26:31.094085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.73474611s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:26:31.094107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.492012736s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"warn","ts":"2026-06-10T10:26:31.094119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.570987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:26:31.094118Z","caller":"traceutil/trace.go:171","msg":"trace[800068350] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:9762; }","duration":"1.734815702s","start":"2026-06-10T10:26:29.359293Z","end":"2026-06-10T10:26:31.094108Z","steps":["trace[800068350] 'agreement among raft nodes before linearized reading' (duration: 1.73475943s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.094138Z","caller":"traceutil/trace.go:171","msg":"trace[306409233] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:9762; }","duration":"2.492083368s","start":"2026-06-10T10:26:28.602047Z","end":"2026-06-10T10:26:31.094131Z","steps":["trace[306409233] 'agreement among raft nodes before linearized reading' (duration: 2.491967365s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.094143Z","caller":"traceutil/trace.go:171","msg":"trace[622377199] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:9762; }","duration":"382.625518ms","start":"2026-06-10T10:26:30.71151Z","end":"2026-06-10T10:26:31.094135Z","steps":["trace[622377199] 'agreement among raft nodes before linearized reading' (duration: 382.585117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.094148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.359279Z","time spent":"1.734864854s","remote":"127.0.0.1:46092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":29,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-10T10:26:31.094107Z","caller":"traceutil/trace.go:171","msg":"trace[1542571962] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:9762; }","duration":"2.468392085s","start":"2026-06-10T10:26:28.625701Z","end":"2026-06-10T10:26:31.094093Z","steps":["trace[1542571962] 'agreement among raft nodes before linearized reading' (duration: 2.46819194s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.094152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.789346007s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T10:26:31.094162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.711493Z","time spent":"382.662569ms","remote":"127.0.0.1:33306","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":29,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.094177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.625678Z","time spent":"2.468491837s","remote":"127.0.0.1:50016","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-10T10:26:31.094179Z","caller":"traceutil/trace.go:171","msg":"trace[1984403153] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:9762; }","duration":"1.789403278s","start":"2026-06-10T10:26:29.304768Z","end":"2026-06-10T10:26:31.094171Z","steps":["trace[1984403153] 'agreement among raft nodes before linearized reading' (duration: 1.789357077s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.094207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.30475Z","time spent":"1.789450949s","remote":"127.0.0.1:40428","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":31,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.094217Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.605405245s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:26:31.094162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.325881502s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:26:31.094004Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.49324Z","time spent":"2.600758968s","remote":"127.0.0.1:49890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":8,"response size":31,"request content":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.094278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.981904ms","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:5"} {"level":"info","ts":"2026-06-10T10:26:31.094297Z","caller":"traceutil/trace.go:171","msg":"trace[1996789862] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:9762; }","duration":"493.042686ms","start":"2026-06-10T10:26:30.601248Z","end":"2026-06-10T10:26:31.09429Z","steps":["trace[1996789862] 'agreement among raft nodes before linearized reading' (duration: 493.012115ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.094281Z","caller":"traceutil/trace.go:171","msg":"trace[134666744] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:9762; }","duration":"2.326056717s","start":"2026-06-10T10:26:28.768209Z","end":"2026-06-10T10:26:31.094266Z","steps":["trace[134666744] 'agreement among raft nodes before linearized reading' (duration: 2.32581387s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.094317Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.601231Z","time spent":"493.077906ms","remote":"127.0.0.1:36244","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":29,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.094322Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.734247456s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1857"} {"level":"warn","ts":"2026-06-10T10:26:31.094336Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.768191Z","time spent":"2.326132439s","remote":"127.0.0.1:50046","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:26:31.094354Z","caller":"traceutil/trace.go:171","msg":"trace[1137008304] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:9762; }","duration":"1.734287207s","start":"2026-06-10T10:26:29.360055Z","end":"2026-06-10T10:26:31.094343Z","steps":["trace[1137008304] 'agreement among raft nodes before linearized reading' (duration: 1.734212105s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.09418Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.602027Z","time spent":"2.49214703s","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-10T10:26:31.094378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.360049Z","time spent":"1.734323789s","remote":"127.0.0.1:49906","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1881,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" "} {"level":"warn","ts":"2026-06-10T10:26:31.094397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"491.103192ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-06-10T10:26:31.093979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.208947Z","time spent":"2.885025761s","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6465,"request content":"key:\"/registry/pods/openstack/keepalived-sbtkb\" "} {"level":"info","ts":"2026-06-10T10:26:31.094242Z","caller":"traceutil/trace.go:171","msg":"trace[752430357] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:9762; }","duration":"2.605458417s","start":"2026-06-10T10:26:28.488777Z","end":"2026-06-10T10:26:31.094235Z","steps":["trace[752430357] 'agreement among raft nodes before linearized reading' (duration: 2.605419526s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.094491Z","caller":"traceutil/trace.go:171","msg":"trace[1888926780] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9762; }","duration":"491.247006ms","start":"2026-06-10T10:26:30.60321Z","end":"2026-06-10T10:26:31.094457Z","steps":["trace[1888926780] 'agreement among raft nodes before linearized reading' (duration: 491.048261ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.094518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.954454702s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-10T10:26:31.09452Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.488761Z","time spent":"2.605741644s","remote":"127.0.0.1:57966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":78,"response count":0,"response size":29,"request content":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.094531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:30.603184Z","time spent":"491.337288ms","remote":"127.0.0.1:50846","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:26:31.094553Z","caller":"traceutil/trace.go:171","msg":"trace[541887585] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:9762; }","duration":"1.954520475s","start":"2026-06-10T10:26:29.140023Z","end":"2026-06-10T10:26:31.094543Z","steps":["trace[541887585] 'agreement among raft nodes before linearized reading' (duration: 1.954444382s)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:26:31.09395Z","caller":"traceutil/trace.go:171","msg":"trace[786148651] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:9762; }","duration":"1.820670921s","start":"2026-06-10T10:26:29.273269Z","end":"2026-06-10T10:26:31.09394Z","steps":["trace[786148651] 'agreement among raft nodes before linearized reading' (duration: 1.820592179s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.094576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.14001Z","time spent":"1.954559155s","remote":"127.0.0.1:50730","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.0946Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:29.273258Z","time spent":"1.82132397s","remote":"127.0.0.1:50842","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":31,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:26:31.09461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.46460809s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-10T10:26:31.09484Z","caller":"traceutil/trace.go:171","msg":"trace[1603785649] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9762; }","duration":"2.464925678s","start":"2026-06-10T10:26:28.629906Z","end":"2026-06-10T10:26:31.094832Z","steps":["trace[1603785649] 'agreement among raft nodes before linearized reading' (duration: 2.464356843s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.094872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.629898Z","time spent":"2.46496617s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T10:26:31.093959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.64867761s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-06-10T10:26:31.095137Z","caller":"traceutil/trace.go:171","msg":"trace[1505694512] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9762; }","duration":"2.649898083s","start":"2026-06-10T10:26:28.445225Z","end":"2026-06-10T10:26:31.095123Z","steps":["trace[1505694512] 'agreement among raft nodes before linearized reading' (duration: 2.648626158s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:26:31.095196Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:26:28.445203Z","time spent":"2.649982535s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-10T10:28:41.561964Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8344} {"level":"info","ts":"2026-06-10T10:28:41.639347Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8344,"took":"75.218715ms","hash":428874750,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":26230784,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-10T10:28:41.639435Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":428874750,"revision":8344,"compact-revision":6172} {"level":"info","ts":"2026-06-10T10:29:23.863308Z","caller":"traceutil/trace.go:171","msg":"trace[1358433299] transaction","detail":"{read_only:false; response_revision:11248; number_of_response:1; }","duration":"106.728564ms","start":"2026-06-10T10:29:23.756553Z","end":"2026-06-10T10:29:23.863282Z","steps":["trace[1358433299] 'process raft request' (duration: 99.057863ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:29:23.865647Z","caller":"traceutil/trace.go:171","msg":"trace[82391680] transaction","detail":"{read_only:false; response_revision:11250; number_of_response:1; }","duration":"100.219815ms","start":"2026-06-10T10:29:23.765406Z","end":"2026-06-10T10:29:23.865626Z","steps":["trace[82391680] 'process raft request' (duration: 100.188704ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:29:23.865775Z","caller":"traceutil/trace.go:171","msg":"trace[1432284065] transaction","detail":"{read_only:false; response_revision:11249; number_of_response:1; }","duration":"103.467154ms","start":"2026-06-10T10:29:23.762301Z","end":"2026-06-10T10:29:23.865768Z","steps":["trace[1432284065] 'process raft request' (duration: 103.195186ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:33:41.56848Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10830} {"level":"info","ts":"2026-06-10T10:33:41.64361Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10830,"took":"72.400117ms","hash":1647904325,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":27406336,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-10T10:33:41.643681Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1647904325,"revision":10830,"compact-revision":8344} {"level":"warn","ts":"2026-06-10T10:35:50.236805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"299.902672ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-10T10:35:50.237125Z","caller":"traceutil/trace.go:171","msg":"trace[799780186] transaction","detail":"{read_only:false; response_revision:13847; number_of_response:1; }","duration":"405.24889ms","start":"2026-06-10T10:35:49.831846Z","end":"2026-06-10T10:35:50.237095Z","steps":["trace[799780186] 'process raft request' (duration: 104.971517ms)","trace[799780186] 'compare' (duration: 299.683686ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:35:50.237193Z","caller":"traceutil/trace.go:171","msg":"trace[327080441] transaction","detail":"{read_only:false; response_revision:13848; number_of_response:1; }","duration":"404.94458ms","start":"2026-06-10T10:35:49.832216Z","end":"2026-06-10T10:35:50.237161Z","steps":["trace[327080441] 'process raft request' (duration: 404.694934ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:35:50.237244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:35:49.831836Z","time spent":"405.344332ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:35:50.237256Z","caller":"traceutil/trace.go:171","msg":"trace[497508886] transaction","detail":"{read_only:false; response_revision:13849; number_of_response:1; }","duration":"404.079237ms","start":"2026-06-10T10:35:49.833143Z","end":"2026-06-10T10:35:50.237222Z","steps":["trace[497508886] 'process raft request' (duration: 403.82066ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:35:50.237333Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:35:49.832208Z","time spent":"405.057854ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:35:50.237565Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:35:49.833136Z","time spent":"404.1781ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:35:58.870403Z","caller":"traceutil/trace.go:171","msg":"trace[1715829701] transaction","detail":"{read_only:false; response_revision:14008; number_of_response:1; }","duration":"155.095059ms","start":"2026-06-10T10:35:58.715282Z","end":"2026-06-10T10:35:58.870377Z","steps":["trace[1715829701] 'process raft request' (duration: 154.941205ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:35:59.075151Z","caller":"traceutil/trace.go:171","msg":"trace[82950527] transaction","detail":"{read_only:false; response_revision:14009; number_of_response:1; }","duration":"156.985021ms","start":"2026-06-10T10:35:58.91814Z","end":"2026-06-10T10:35:59.075125Z","steps":["trace[82950527] 'process raft request' (duration: 156.826267ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:37:38.627821Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.434065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:37:38.627925Z","caller":"traceutil/trace.go:171","msg":"trace[1998446787] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15095; }","duration":"119.59688ms","start":"2026-06-10T10:37:38.508306Z","end":"2026-06-10T10:37:38.627903Z","steps":["trace[1998446787] 'range keys from in-memory index tree' (duration: 119.24654ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:37:38.628018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.675683ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-06-10T10:37:38.628093Z","caller":"traceutil/trace.go:171","msg":"trace[462268630] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15095; }","duration":"110.778156ms","start":"2026-06-10T10:37:38.517298Z","end":"2026-06-10T10:37:38.628076Z","steps":["trace[462268630] 'range keys from in-memory index tree' (duration: 110.542779ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:37:38.628109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.611332ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-10T10:37:38.62828Z","caller":"traceutil/trace.go:171","msg":"trace[932281253] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:15095; }","duration":"131.823117ms","start":"2026-06-10T10:37:38.496436Z","end":"2026-06-10T10:37:38.628259Z","steps":["trace[932281253] 'range keys from in-memory index tree' (duration: 131.589171ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:37:38.628312Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.771436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-10T10:37:38.628398Z","caller":"traceutil/trace.go:171","msg":"trace[161564270] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15095; }","duration":"106.885449ms","start":"2026-06-10T10:37:38.521494Z","end":"2026-06-10T10:37:38.62838Z","steps":["trace[161564270] 'range keys from in-memory index tree' (duration: 106.55274ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:38:41.577568Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13004} {"level":"info","ts":"2026-06-10T10:38:41.648948Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13004,"took":"68.600702ms","hash":587608932,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":31002624,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T10:38:41.649007Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":587608932,"revision":13004,"compact-revision":10830} {"level":"warn","ts":"2026-06-10T10:43:16.381093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.832623ms","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-10T10:43:16.381164Z","caller":"traceutil/trace.go:171","msg":"trace[491040651] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:17686; }","duration":"100.951176ms","start":"2026-06-10T10:43:16.280197Z","end":"2026-06-10T10:43:16.381148Z","steps":["trace[491040651] 'count revisions from in-memory index tree' (duration: 100.75933ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:16.381288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.830702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:43:16.381318Z","caller":"traceutil/trace.go:171","msg":"trace[2010083730] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17686; }","duration":"100.877944ms","start":"2026-06-10T10:43:16.280429Z","end":"2026-06-10T10:43:16.381307Z","steps":["trace[2010083730] 'count revisions from in-memory index tree' (duration: 100.796312ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:22.471882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.790475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-compute-default-6kqkt\" ","response":"range_response_count:1 size:22011"} {"level":"info","ts":"2026-06-10T10:43:22.471956Z","caller":"traceutil/trace.go:171","msg":"trace[1043706395] range","detail":"{range_begin:/registry/pods/openstack/nova-compute-default-6kqkt; range_end:; response_count:1; response_revision:17726; }","duration":"215.905908ms","start":"2026-06-10T10:43:22.256032Z","end":"2026-06-10T10:43:22.471937Z","steps":["trace[1043706395] 'range keys from in-memory index tree' (duration: 215.62569ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:22.851603Z","caller":"traceutil/trace.go:171","msg":"trace[760848657] transaction","detail":"{read_only:false; response_revision:17727; number_of_response:1; }","duration":"333.822582ms","start":"2026-06-10T10:43:22.517755Z","end":"2026-06-10T10:43:22.851577Z","steps":["trace[760848657] 'process raft request' (duration: 333.632837ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:22.851777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:43:22.517743Z","time spent":"333.942445ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:43:23.033756Z","caller":"traceutil/trace.go:171","msg":"trace[535182851] transaction","detail":"{read_only:false; response_revision:17728; number_of_response:1; }","duration":"513.710106ms","start":"2026-06-10T10:43:22.520016Z","end":"2026-06-10T10:43:23.033726Z","steps":["trace[535182851] 'process raft request' (duration: 513.423158ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:23.033838Z","caller":"traceutil/trace.go:171","msg":"trace[409625206] transaction","detail":"{read_only:false; response_revision:17729; number_of_response:1; }","duration":"513.666035ms","start":"2026-06-10T10:43:22.520146Z","end":"2026-06-10T10:43:23.033812Z","steps":["trace[409625206] 'process raft request' (duration: 513.454489ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:23.033845Z","caller":"traceutil/trace.go:171","msg":"trace[1157725863] transaction","detail":"{read_only:false; response_revision:17730; number_of_response:1; }","duration":"306.115927ms","start":"2026-06-10T10:43:22.727711Z","end":"2026-06-10T10:43:23.033827Z","steps":["trace[1157725863] 'process raft request' (duration: 305.964403ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:23.033935Z","caller":"traceutil/trace.go:171","msg":"trace[2099730765] linearizableReadLoop","detail":"{readStateIndex:18322; appliedIndex:18319; }","duration":"482.463894ms","start":"2026-06-10T10:43:22.551448Z","end":"2026-06-10T10:43:23.033912Z","steps":["trace[2099730765] 'read index received' (duration: 299.950677ms)","trace[2099730765] 'applied index is now lower than readState.Index' (duration: 182.512217ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:43:23.033975Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:43:22.727682Z","time spent":"306.21449ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:43:23.033995Z","caller":"traceutil/trace.go:171","msg":"trace[162111978] transaction","detail":"{read_only:false; response_revision:17732; number_of_response:1; }","duration":"265.666651ms","start":"2026-06-10T10:43:22.768297Z","end":"2026-06-10T10:43:23.033963Z","steps":["trace[162111978] 'process raft request' (duration: 265.508637ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:43:23.033975Z","caller":"traceutil/trace.go:171","msg":"trace[677575940] transaction","detail":"{read_only:false; response_revision:17731; number_of_response:1; }","duration":"299.501475ms","start":"2026-06-10T10:43:22.73445Z","end":"2026-06-10T10:43:23.033951Z","steps":["trace[677575940] 'process raft request' (duration: 299.306709ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:23.033977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:43:22.52012Z","time spent":"513.767987ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:43:23.034018Z","caller":"traceutil/trace.go:171","msg":"trace[1974781662] transaction","detail":"{read_only:false; response_revision:17733; number_of_response:1; }","duration":"243.292773ms","start":"2026-06-10T10:43:22.790716Z","end":"2026-06-10T10:43:23.034009Z","steps":["trace[1974781662] 'process raft request' (duration: 243.15465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:23.034177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"482.70603ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:43:23.034237Z","caller":"traceutil/trace.go:171","msg":"trace[1033516974] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:17733; }","duration":"482.827303ms","start":"2026-06-10T10:43:22.551397Z","end":"2026-06-10T10:43:23.034224Z","steps":["trace[1033516974] 'agreement among raft nodes before linearized reading' (duration: 482.638478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:23.034189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.620518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-kmkdw\" ","response":"range_response_count:1 size:9709"} {"level":"warn","ts":"2026-06-10T10:43:23.034285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:43:22.551376Z","time spent":"482.897346ms","remote":"127.0.0.1:40384","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":30,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:43:23.034287Z","caller":"traceutil/trace.go:171","msg":"trace[420625217] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-kmkdw; range_end:; response_count:1; response_revision:17733; }","duration":"378.755962ms","start":"2026-06-10T10:43:22.655517Z","end":"2026-06-10T10:43:23.034273Z","steps":["trace[420625217] 'agreement among raft nodes before linearized reading' (duration: 378.540326ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:43:23.034219Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:43:22.520007Z","time spent":"513.847ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:43:23.034534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:43:22.655494Z","time spent":"379.02909ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":9733,"request content":"key:\"/registry/pods/openstack/nova-cell-setup-kmkdw\" "} {"level":"info","ts":"2026-06-10T10:43:41.584253Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15514} {"level":"info","ts":"2026-06-10T10:43:41.682679Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15514,"took":"95.534976ms","hash":2120676915,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":33124352,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-10T10:43:41.682737Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2120676915,"revision":15514,"compact-revision":13004} {"level":"info","ts":"2026-06-10T10:46:41.722688Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T10:46:41.727991Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-10T10:46:41.72842Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-10T10:48:41.591761Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18076} {"level":"info","ts":"2026-06-10T10:48:41.702837Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18076,"took":"107.6228ms","hash":3785998835,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":30183424,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T10:48:41.702913Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3785998835,"revision":18076,"compact-revision":15514} {"level":"warn","ts":"2026-06-10T10:48:54.910721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.910237ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:48:54.910939Z","caller":"traceutil/trace.go:171","msg":"trace[1012251408] transaction","detail":"{read_only:false; response_revision:20246; number_of_response:1; }","duration":"181.404886ms","start":"2026-06-10T10:48:54.729499Z","end":"2026-06-10T10:48:54.910904Z","steps":["trace[1012251408] 'process raft request' (duration: 35.240022ms)","trace[1012251408] 'compare' (duration: 145.798964ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:48:54.911137Z","caller":"traceutil/trace.go:171","msg":"trace[621094255] transaction","detail":"{read_only:false; response_revision:20247; number_of_response:1; }","duration":"178.701721ms","start":"2026-06-10T10:48:54.732394Z","end":"2026-06-10T10:48:54.911095Z","steps":["trace[621094255] 'process raft request' (duration: 178.416793ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:48:54.91117Z","caller":"traceutil/trace.go:171","msg":"trace[447619088] transaction","detail":"{read_only:false; response_revision:20248; number_of_response:1; }","duration":"178.339531ms","start":"2026-06-10T10:48:54.732786Z","end":"2026-06-10T10:48:54.911126Z","steps":["trace[447619088] 'process raft request' (duration: 178.079864ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:48:55.183843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.60498ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:48:55.183933Z","caller":"traceutil/trace.go:171","msg":"trace[330475348] linearizableReadLoop","detail":"{readStateIndex:20928; appliedIndex:20927; }","duration":"271.123262ms","start":"2026-06-10T10:48:54.912794Z","end":"2026-06-10T10:48:55.183918Z","steps":["trace[330475348] 'read index received' (duration: 138.4456ms)","trace[330475348] 'applied index is now lower than readState.Index' (duration: 132.676562ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:48:55.184076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.279436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-06-10T10:48:55.184102Z","caller":"traceutil/trace.go:171","msg":"trace[1879070231] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:20249; }","duration":"271.337778ms","start":"2026-06-10T10:48:54.912756Z","end":"2026-06-10T10:48:55.184093Z","steps":["trace[1879070231] 'agreement among raft nodes before linearized reading' (duration: 271.205184ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:48:55.184262Z","caller":"traceutil/trace.go:171","msg":"trace[1484554240] transaction","detail":"{read_only:false; response_revision:20249; number_of_response:1; }","duration":"319.541938ms","start":"2026-06-10T10:48:54.864678Z","end":"2026-06-10T10:48:55.18422Z","steps":["trace[1484554240] 'process raft request' (duration: 186.490746ms)","trace[1484554240] 'compare' (duration: 132.502547ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:48:55.184459Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:48:54.864667Z","time spent":"319.685012ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:48:55.952439Z","caller":"traceutil/trace.go:171","msg":"trace[1308511117] transaction","detail":"{read_only:false; response_revision:20250; number_of_response:1; }","duration":"221.79755ms","start":"2026-06-10T10:48:55.730623Z","end":"2026-06-10T10:48:55.95242Z","steps":["trace[1308511117] 'process raft request' (duration: 221.668296ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:48:56.082154Z","caller":"traceutil/trace.go:171","msg":"trace[491296194] linearizableReadLoop","detail":"{readStateIndex:20930; appliedIndex:20928; }","duration":"276.1673ms","start":"2026-06-10T10:48:55.805958Z","end":"2026-06-10T10:48:56.082126Z","steps":["trace[491296194] 'read index received' (duration: 146.346038ms)","trace[491296194] 'applied index is now lower than readState.Index' (duration: 129.819892ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:48:56.082279Z","caller":"traceutil/trace.go:171","msg":"trace[1258137180] transaction","detail":"{read_only:false; response_revision:20251; number_of_response:1; }","duration":"348.891038ms","start":"2026-06-10T10:48:55.733349Z","end":"2026-06-10T10:48:56.08224Z","steps":["trace[1258137180] 'process raft request' (duration: 345.022921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:48:56.082457Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:48:55.733336Z","time spent":"349.033892ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:48:56.082534Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.552202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:417426"} {"level":"info","ts":"2026-06-10T10:48:56.082584Z","caller":"traceutil/trace.go:171","msg":"trace[602406849] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:20251; }","duration":"276.657865ms","start":"2026-06-10T10:48:55.805914Z","end":"2026-06-10T10:48:56.082572Z","steps":["trace[602406849] 'agreement among raft nodes before linearized reading' (duration: 276.315555ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:48:56.336199Z","caller":"traceutil/trace.go:171","msg":"trace[216462408] transaction","detail":"{read_only:false; response_revision:20252; number_of_response:1; }","duration":"183.675619ms","start":"2026-06-10T10:48:56.152493Z","end":"2026-06-10T10:48:56.336168Z","steps":["trace[216462408] 'process raft request' (duration: 90.250461ms)","trace[216462408] 'compare' (duration: 93.275264ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:48:56.338888Z","caller":"traceutil/trace.go:171","msg":"trace[342487843] transaction","detail":"{read_only:false; response_revision:20253; number_of_response:1; }","duration":"185.135609ms","start":"2026-06-10T10:48:56.153737Z","end":"2026-06-10T10:48:56.338873Z","steps":["trace[342487843] 'process raft request' (duration: 184.997105ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:48:56.339184Z","caller":"traceutil/trace.go:171","msg":"trace[1787752584] transaction","detail":"{read_only:false; response_revision:20254; number_of_response:1; }","duration":"184.46382ms","start":"2026-06-10T10:48:56.154695Z","end":"2026-06-10T10:48:56.339158Z","steps":["trace[1787752584] 'process raft request' (duration: 184.136421ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:48:56.339975Z","caller":"traceutil/trace.go:171","msg":"trace[893070816] transaction","detail":"{read_only:false; response_revision:20255; number_of_response:1; }","duration":"184.553613ms","start":"2026-06-10T10:48:56.155402Z","end":"2026-06-10T10:48:56.339956Z","steps":["trace[893070816] 'process raft request' (duration: 183.665189ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:53:41.599337Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20175} {"level":"info","ts":"2026-06-10T10:53:41.70043Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20175,"took":"98.20725ms","hash":2259053078,"current-db-size-bytes":59113472,"current-db-size":"59 MB","current-db-size-in-use-bytes":40775680,"current-db-size-in-use":"41 MB"} {"level":"info","ts":"2026-06-10T10:53:41.700496Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2259053078,"revision":20175,"compact-revision":18076} {"level":"info","ts":"2026-06-10T10:54:18.9875Z","caller":"traceutil/trace.go:171","msg":"trace[2142734926] transaction","detail":"{read_only:false; response_revision:23622; number_of_response:1; }","duration":"145.156096ms","start":"2026-06-10T10:54:18.842306Z","end":"2026-06-10T10:54:18.987462Z","steps":["trace[2142734926] 'process raft request' (duration: 138.326107ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:14.031519Z","caller":"traceutil/trace.go:171","msg":"trace[1048228831] transaction","detail":"{read_only:false; response_revision:24775; number_of_response:1; }","duration":"138.524923ms","start":"2026-06-10T10:56:13.89296Z","end":"2026-06-10T10:56:14.031485Z","steps":["trace[1048228831] 'process raft request' (duration: 138.41311ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:14.031555Z","caller":"traceutil/trace.go:171","msg":"trace[1570859562] transaction","detail":"{read_only:false; response_revision:24776; number_of_response:1; }","duration":"137.046532ms","start":"2026-06-10T10:56:13.894473Z","end":"2026-06-10T10:56:14.03152Z","steps":["trace[1570859562] 'process raft request' (duration: 136.940119ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:14.031569Z","caller":"traceutil/trace.go:171","msg":"trace[1469556182] transaction","detail":"{read_only:false; response_revision:24774; number_of_response:1; }","duration":"144.050435ms","start":"2026-06-10T10:56:13.887487Z","end":"2026-06-10T10:56:14.031537Z","steps":["trace[1469556182] 'process raft request' (duration: 143.716086ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:19.66481Z","caller":"traceutil/trace.go:171","msg":"trace[1122247838] transaction","detail":"{read_only:false; response_revision:24815; number_of_response:1; }","duration":"244.343122ms","start":"2026-06-10T10:56:19.420447Z","end":"2026-06-10T10:56:19.66479Z","steps":["trace[1122247838] 'process raft request' (duration: 244.213059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:19.857881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.94393ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-10T10:56:19.950395Z","caller":"traceutil/trace.go:171","msg":"trace[1294422341] linearizableReadLoop","detail":"{readStateIndex:25625; appliedIndex:25624; }","duration":"214.708245ms","start":"2026-06-10T10:56:19.735665Z","end":"2026-06-10T10:56:19.950373Z","steps":["trace[1294422341] 'read index received' (duration: 214.670604ms)","trace[1294422341] 'applied index is now lower than readState.Index' (duration: 36.671µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:19.950566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.88906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:19.9506Z","caller":"traceutil/trace.go:171","msg":"trace[808402346] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:24816; }","duration":"214.979862ms","start":"2026-06-10T10:56:19.735611Z","end":"2026-06-10T10:56:19.950591Z","steps":["trace[808402346] 'agreement among raft nodes before linearized reading' (duration: 214.880779ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:19.950778Z","caller":"traceutil/trace.go:171","msg":"trace[1852575624] transaction","detail":"{read_only:false; response_revision:24816; number_of_response:1; }","duration":"223.050915ms","start":"2026-06-10T10:56:19.7277Z","end":"2026-06-10T10:56:19.950751Z","steps":["trace[1852575624] 'process raft request' (duration: 222.537011ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:24.308923Z","caller":"traceutil/trace.go:171","msg":"trace[638517776] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"199.252859ms","start":"2026-06-10T10:56:24.109644Z","end":"2026-06-10T10:56:24.308896Z","steps":["trace[638517776] 'process raft request' (duration: 199.038603ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:24.402441Z","caller":"traceutil/trace.go:171","msg":"trace[1529362950] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"291.951766ms","start":"2026-06-10T10:56:24.110454Z","end":"2026-06-10T10:56:24.402405Z","steps":["trace[1529362950] 'process raft request' (duration: 289.736445ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:24.402696Z","caller":"traceutil/trace.go:171","msg":"trace[900298719] linearizableReadLoop","detail":"{readStateIndex:25664; appliedIndex:25661; }","duration":"289.284482ms","start":"2026-06-10T10:56:24.113377Z","end":"2026-06-10T10:56:24.402662Z","steps":["trace[900298719] 'read index received' (duration: 195.364211ms)","trace[900298719] 'applied index is now lower than readState.Index' (duration: 93.917391ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:24.402888Z","caller":"traceutil/trace.go:171","msg":"trace[853330211] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"291.507854ms","start":"2026-06-10T10:56:24.111366Z","end":"2026-06-10T10:56:24.402874Z","steps":["trace[853330211] 'process raft request' (duration: 290.99377ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:24.403049Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.865038ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T10:56:24.403117Z","caller":"traceutil/trace.go:171","msg":"trace[704918320] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24855; }","duration":"252.984691ms","start":"2026-06-10T10:56:24.150114Z","end":"2026-06-10T10:56:24.403099Z","steps":["trace[704918320] 'agreement among raft nodes before linearized reading' (duration: 252.786226ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:24.403329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.933431ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-10T10:56:24.403405Z","caller":"traceutil/trace.go:171","msg":"trace[451171495] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24855; }","duration":"290.074234ms","start":"2026-06-10T10:56:24.113311Z","end":"2026-06-10T10:56:24.403385Z","steps":["trace[451171495] 'agreement among raft nodes before linearized reading' (duration: 289.92624ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:24.711263Z","caller":"traceutil/trace.go:171","msg":"trace[1679200217] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"273.690023ms","start":"2026-06-10T10:56:24.437527Z","end":"2026-06-10T10:56:24.711217Z","steps":["trace[1679200217] 'process raft request' (duration: 273.496717ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:24.894538Z","caller":"traceutil/trace.go:171","msg":"trace[218729612] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"179.876344ms","start":"2026-06-10T10:56:24.71463Z","end":"2026-06-10T10:56:24.894506Z","steps":["trace[218729612] 'process raft request' (duration: 179.462853ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:24.894228Z","caller":"traceutil/trace.go:171","msg":"trace[334793884] linearizableReadLoop","detail":"{readStateIndex:25669; appliedIndex:25667; }","duration":"168.689215ms","start":"2026-06-10T10:56:24.725517Z","end":"2026-06-10T10:56:24.894206Z","steps":["trace[334793884] 'read index received' (duration: 74.782123ms)","trace[334793884] 'applied index is now lower than readState.Index' (duration: 93.906162ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:24.894703Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.158488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:24.894835Z","caller":"traceutil/trace.go:171","msg":"trace[2071060277] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24859; }","duration":"169.294962ms","start":"2026-06-10T10:56:24.725491Z","end":"2026-06-10T10:56:24.894786Z","steps":["trace[2071060277] 'agreement among raft nodes before linearized reading' (duration: 169.089346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:25.194904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.390007ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:56:25.194983Z","caller":"traceutil/trace.go:171","msg":"trace[1094686762] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"149.393732ms","start":"2026-06-10T10:56:25.045577Z","end":"2026-06-10T10:56:25.194971Z","steps":["trace[1094686762] 'process raft request' (duration: 26.872411ms)","trace[1094686762] 'compare' (duration: 122.292915ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:25.353279Z","caller":"traceutil/trace.go:171","msg":"trace[2134506150] transaction","detail":"{read_only:false; response_revision:24862; number_of_response:1; }","duration":"132.184218ms","start":"2026-06-10T10:56:25.221065Z","end":"2026-06-10T10:56:25.353249Z","steps":["trace[2134506150] 'process raft request' (duration: 131.515009ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:25.353268Z","caller":"traceutil/trace.go:171","msg":"trace[1257248451] linearizableReadLoop","detail":"{readStateIndex:25672; appliedIndex:25671; }","duration":"127.136468ms","start":"2026-06-10T10:56:25.226103Z","end":"2026-06-10T10:56:25.35324Z","steps":["trace[1257248451] 'read index received' (duration: 126.401577ms)","trace[1257248451] 'applied index is now lower than readState.Index' (duration: 733.481µs)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:25.353812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.859869ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T10:56:25.353867Z","caller":"traceutil/trace.go:171","msg":"trace[185304770] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24862; }","duration":"111.026824ms","start":"2026-06-10T10:56:25.242825Z","end":"2026-06-10T10:56:25.353852Z","steps":["trace[185304770] 'agreement among raft nodes before linearized reading' (duration: 110.742356ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:25.354036Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.91341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-06-10T10:56:25.354094Z","caller":"traceutil/trace.go:171","msg":"trace[176218128] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24862; }","duration":"128.003102ms","start":"2026-06-10T10:56:25.226068Z","end":"2026-06-10T10:56:25.354071Z","steps":["trace[176218128] 'agreement among raft nodes before linearized reading' (duration: 127.268701ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:25.661975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.087175ms","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-10T10:56:25.662077Z","caller":"traceutil/trace.go:171","msg":"trace[825765745] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24863; }","duration":"157.230479ms","start":"2026-06-10T10:56:25.504813Z","end":"2026-06-10T10:56:25.662044Z","steps":["trace[825765745] 'range keys from in-memory index tree' (duration: 157.027503ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:26.262296Z","caller":"traceutil/trace.go:171","msg":"trace[2087127723] transaction","detail":"{read_only:false; response_revision:24865; number_of_response:1; }","duration":"265.535988ms","start":"2026-06-10T10:56:25.996728Z","end":"2026-06-10T10:56:26.262264Z","steps":["trace[2087127723] 'process raft request' (duration: 265.310891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:26.434888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.308593ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:56:26.435476Z","caller":"traceutil/trace.go:171","msg":"trace[622674434] transaction","detail":"{read_only:false; response_revision:24866; number_of_response:1; }","duration":"418.215561ms","start":"2026-06-10T10:56:26.017216Z","end":"2026-06-10T10:56:26.435432Z","steps":["trace[622674434] 'process raft request' (duration: 282.203118ms)","trace[622674434] 'compare' (duration: 134.776889ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:26.435662Z","caller":"traceutil/trace.go:171","msg":"trace[1209648277] transaction","detail":"{read_only:false; response_revision:24867; number_of_response:1; }","duration":"120.098024ms","start":"2026-06-10T10:56:26.315521Z","end":"2026-06-10T10:56:26.435619Z","steps":["trace[1209648277] 'process raft request' (duration: 119.520028ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:26.435694Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:26.017177Z","time spent":"418.416907ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:26.435766Z","caller":"traceutil/trace.go:171","msg":"trace[698708111] linearizableReadLoop","detail":"{readStateIndex:25677; appliedIndex:25675; }","duration":"108.669379ms","start":"2026-06-10T10:56:26.327071Z","end":"2026-06-10T10:56:26.43574Z","steps":["trace[698708111] 'read index received' (duration: 106.489708ms)","trace[698708111] 'applied index is now lower than readState.Index' (duration: 2.177861ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:26.436056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.966588ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:26.436106Z","caller":"traceutil/trace.go:171","msg":"trace[1631511020] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:24868; }","duration":"109.08653ms","start":"2026-06-10T10:56:26.327007Z","end":"2026-06-10T10:56:26.436094Z","steps":["trace[1631511020] 'agreement among raft nodes before linearized reading' (duration: 108.852794ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:26.679058Z","caller":"traceutil/trace.go:171","msg":"trace[2071525114] transaction","detail":"{read_only:false; response_revision:24870; number_of_response:1; }","duration":"239.071087ms","start":"2026-06-10T10:56:26.439962Z","end":"2026-06-10T10:56:26.679033Z","steps":["trace[2071525114] 'process raft request' (duration: 238.871342ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:26.816144Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.460078ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:56:26.816254Z","caller":"traceutil/trace.go:171","msg":"trace[631825144] linearizableReadLoop","detail":"{readStateIndex:25681; appliedIndex:25679; }","duration":"373.9547ms","start":"2026-06-10T10:56:26.44228Z","end":"2026-06-10T10:56:26.816234Z","steps":["trace[631825144] 'read index received' (duration: 236.518217ms)","trace[631825144] 'applied index is now lower than readState.Index' (duration: 137.435073ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:26.816323Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.061903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:26.816349Z","caller":"traceutil/trace.go:171","msg":"trace[983656772] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24871; }","duration":"374.089054ms","start":"2026-06-10T10:56:26.442251Z","end":"2026-06-10T10:56:26.81634Z","steps":["trace[983656772] 'agreement among raft nodes before linearized reading' (duration: 374.032752ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:26.816391Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:26.442183Z","time spent":"374.197027ms","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"info","ts":"2026-06-10T10:56:26.816597Z","caller":"traceutil/trace.go:171","msg":"trace[796955430] transaction","detail":"{read_only:false; response_revision:24871; number_of_response:1; }","duration":"375.363738ms","start":"2026-06-10T10:56:26.440995Z","end":"2026-06-10T10:56:26.816358Z","steps":["trace[796955430] 'process raft request' (duration: 268.601512ms)","trace[796955430] 'compare' (duration: 106.340924ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:26.816853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:26.440986Z","time spent":"375.724089ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:26.829581Z","caller":"traceutil/trace.go:171","msg":"trace[2024462063] transaction","detail":"{read_only:false; response_revision:24872; number_of_response:1; }","duration":"110.156529ms","start":"2026-06-10T10:56:26.719406Z","end":"2026-06-10T10:56:26.829562Z","steps":["trace[2024462063] 'process raft request' (duration: 110.039686ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:27.391958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.232304ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinepools/\" range_end:\"/registry/cluster.x-k8s.io/machinepools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:27.392037Z","caller":"traceutil/trace.go:171","msg":"trace[1360630159] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:24873; }","duration":"263.361408ms","start":"2026-06-10T10:56:27.128657Z","end":"2026-06-10T10:56:27.392019Z","steps":["trace[1360630159] 'count revisions from in-memory index tree' (duration: 263.140952ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:27.394458Z","caller":"traceutil/trace.go:171","msg":"trace[490427372] linearizableReadLoop","detail":"{readStateIndex:25684; appliedIndex:25683; }","duration":"127.688243ms","start":"2026-06-10T10:56:27.266751Z","end":"2026-06-10T10:56:27.39444Z","steps":["trace[490427372] 'read index received' (duration: 127.501528ms)","trace[490427372] 'applied index is now lower than readState.Index' (duration: 185.435µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:27.394787Z","caller":"traceutil/trace.go:171","msg":"trace[1164251601] transaction","detail":"{read_only:false; response_revision:24874; number_of_response:1; }","duration":"194.834037ms","start":"2026-06-10T10:56:27.199938Z","end":"2026-06-10T10:56:27.394772Z","steps":["trace[1164251601] 'process raft request' (duration: 194.371204ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:27.395401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.63981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:56:27.39549Z","caller":"traceutil/trace.go:171","msg":"trace[2098505207] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:24874; }","duration":"128.730753ms","start":"2026-06-10T10:56:27.266707Z","end":"2026-06-10T10:56:27.395437Z","steps":["trace[2098505207] 'agreement among raft nodes before linearized reading' (duration: 128.61803ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:27.814069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.25576ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:56:27.814354Z","caller":"traceutil/trace.go:171","msg":"trace[731343183] transaction","detail":"{read_only:false; response_revision:24877; number_of_response:1; }","duration":"381.749554ms","start":"2026-06-10T10:56:27.432585Z","end":"2026-06-10T10:56:27.814334Z","steps":["trace[731343183] 'process raft request' (duration: 381.695533ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:27.814425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:27.432506Z","time spent":"381.881799ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:27.814659Z","caller":"traceutil/trace.go:171","msg":"trace[1288089047] transaction","detail":"{read_only:false; response_revision:24875; number_of_response:1; }","duration":"412.74438ms","start":"2026-06-10T10:56:27.401887Z","end":"2026-06-10T10:56:27.814631Z","steps":["trace[1288089047] 'process raft request' (duration: 204.847603ms)","trace[1288089047] 'compare' (duration: 207.041863ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:27.814847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:27.401865Z","time spent":"412.857213ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:27.814941Z","caller":"traceutil/trace.go:171","msg":"trace[716490026] transaction","detail":"{read_only:false; response_revision:24876; number_of_response:1; }","duration":"412.812921ms","start":"2026-06-10T10:56:27.4021Z","end":"2026-06-10T10:56:27.814913Z","steps":["trace[716490026] 'process raft request' (duration: 412.086741ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:27.815067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:27.402077Z","time spent":"412.923955ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:27.86744Z","caller":"traceutil/trace.go:171","msg":"trace[613717578] transaction","detail":"{read_only:false; response_revision:24878; number_of_response:1; }","duration":"143.192331ms","start":"2026-06-10T10:56:27.724228Z","end":"2026-06-10T10:56:27.86742Z","steps":["trace[613717578] 'process raft request' (duration: 143.071078ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:28.504113Z","caller":"traceutil/trace.go:171","msg":"trace[66139799] linearizableReadLoop","detail":"{readStateIndex:25690; appliedIndex:25689; }","duration":"179.308738ms","start":"2026-06-10T10:56:28.324775Z","end":"2026-06-10T10:56:28.504083Z","steps":["trace[66139799] 'read index received' (duration: 179.157204ms)","trace[66139799] 'applied index is now lower than readState.Index' (duration: 150.364µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:28.504172Z","caller":"traceutil/trace.go:171","msg":"trace[343504162] transaction","detail":"{read_only:false; response_revision:24880; number_of_response:1; }","duration":"236.775134ms","start":"2026-06-10T10:56:28.267374Z","end":"2026-06-10T10:56:28.50415Z","steps":["trace[343504162] 'process raft request' (duration: 236.502986ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:28.504371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.573305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:56:28.50442Z","caller":"traceutil/trace.go:171","msg":"trace[1581431538] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:24880; }","duration":"179.708109ms","start":"2026-06-10T10:56:28.324701Z","end":"2026-06-10T10:56:28.504409Z","steps":["trace[1581431538] 'agreement among raft nodes before linearized reading' (duration: 179.511854ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:28.516776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.607337ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:28.51686Z","caller":"traceutil/trace.go:171","msg":"trace[1429327108] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24884; }","duration":"154.705459ms","start":"2026-06-10T10:56:28.362136Z","end":"2026-06-10T10:56:28.516841Z","steps":["trace[1429327108] 'agreement among raft nodes before linearized reading' (duration: 154.537675ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:29.006711Z","caller":"traceutil/trace.go:171","msg":"trace[1253075247] transaction","detail":"{read_only:false; response_revision:24886; number_of_response:1; }","duration":"171.827332ms","start":"2026-06-10T10:56:28.834859Z","end":"2026-06-10T10:56:29.006686Z","steps":["trace[1253075247] 'process raft request' (duration: 171.619876ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:29.026857Z","caller":"traceutil/trace.go:171","msg":"trace[352390681] transaction","detail":"{read_only:false; response_revision:24887; number_of_response:1; }","duration":"177.110417ms","start":"2026-06-10T10:56:28.849702Z","end":"2026-06-10T10:56:29.026812Z","steps":["trace[352390681] 'process raft request' (duration: 176.875941ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:29.186958Z","caller":"traceutil/trace.go:171","msg":"trace[1205504983] transaction","detail":"{read_only:false; response_revision:24889; number_of_response:1; }","duration":"156.159399ms","start":"2026-06-10T10:56:29.030763Z","end":"2026-06-10T10:56:29.186922Z","steps":["trace[1205504983] 'process raft request' (duration: 144.433526ms)","trace[1205504983] 'compare' (duration: 11.539748ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:29.487087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.006792ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:29.487153Z","caller":"traceutil/trace.go:171","msg":"trace[1376896508] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24889; }","duration":"124.111295ms","start":"2026-06-10T10:56:29.363025Z","end":"2026-06-10T10:56:29.487137Z","steps":["trace[1376896508] 'range keys from in-memory index tree' (duration: 123.880908ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:29.487384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.156349ms","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-10T10:56:29.487454Z","caller":"traceutil/trace.go:171","msg":"trace[52572890] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:24889; }","duration":"123.263822ms","start":"2026-06-10T10:56:29.364172Z","end":"2026-06-10T10:56:29.487436Z","steps":["trace[52572890] 'count revisions from in-memory index tree' (duration: 123.092237ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:29.844962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.862323ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-10T10:56:30.020488Z","caller":"traceutil/trace.go:171","msg":"trace[774431938] transaction","detail":"{read_only:false; response_revision:24891; number_of_response:1; }","duration":"169.994901ms","start":"2026-06-10T10:56:29.850439Z","end":"2026-06-10T10:56:30.020434Z","steps":["trace[774431938] 'process raft request' (duration: 169.782505ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:30.021179Z","caller":"traceutil/trace.go:171","msg":"trace[1774011145] transaction","detail":"{read_only:false; response_revision:24892; number_of_response:1; }","duration":"170.570727ms","start":"2026-06-10T10:56:29.850578Z","end":"2026-06-10T10:56:30.021149Z","steps":["trace[1774011145] 'process raft request' (duration: 170.338211ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:30.021281Z","caller":"traceutil/trace.go:171","msg":"trace[1686438621] linearizableReadLoop","detail":"{readStateIndex:25703; appliedIndex:25701; }","duration":"160.18669ms","start":"2026-06-10T10:56:29.861074Z","end":"2026-06-10T10:56:30.021261Z","steps":["trace[1686438621] 'read index received' (duration: 159.160222ms)","trace[1686438621] 'applied index is now lower than readState.Index' (duration: 1.025198ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:30.021415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.320845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumexternalworkloads/\" range_end:\"/registry/cilium.io/ciliumexternalworkloads0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:30.021461Z","caller":"traceutil/trace.go:171","msg":"trace[206049171] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:24893; }","duration":"160.412947ms","start":"2026-06-10T10:56:29.861032Z","end":"2026-06-10T10:56:30.021445Z","steps":["trace[206049171] 'agreement among raft nodes before linearized reading' (duration: 160.295384ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:30.021732Z","caller":"traceutil/trace.go:171","msg":"trace[1590494600] transaction","detail":"{read_only:false; response_revision:24893; number_of_response:1; }","duration":"145.143185ms","start":"2026-06-10T10:56:29.876513Z","end":"2026-06-10T10:56:30.021656Z","steps":["trace[1590494600] 'process raft request' (duration: 144.59201ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:37.557663Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813701371,"retry-timeout":"500ms"} {"level":"info","ts":"2026-06-10T10:56:37.76404Z","caller":"traceutil/trace.go:171","msg":"trace[802064682] transaction","detail":"{read_only:false; response_revision:24949; number_of_response:1; }","duration":"730.083827ms","start":"2026-06-10T10:56:37.03393Z","end":"2026-06-10T10:56:37.764014Z","steps":["trace[802064682] 'process raft request' (duration: 729.926283ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:37.764205Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.033905Z","time spent":"730.221331ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":607,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:37.803898Z","caller":"traceutil/trace.go:171","msg":"trace[768547669] linearizableReadLoop","detail":"{readStateIndex:25762; appliedIndex:25760; }","duration":"746.84785ms","start":"2026-06-10T10:56:37.057027Z","end":"2026-06-10T10:56:37.803875Z","steps":["trace[768547669] 'read index received' (duration: 706.912958ms)","trace[768547669] 'applied index is now lower than readState.Index' (duration: 39.933842ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:37.804065Z","caller":"traceutil/trace.go:171","msg":"trace[182183742] transaction","detail":"{read_only:false; response_revision:24950; number_of_response:1; }","duration":"290.515967ms","start":"2026-06-10T10:56:37.513503Z","end":"2026-06-10T10:56:37.804019Z","steps":["trace[182183742] 'process raft request' (duration: 290.237219ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:37.804134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.156876ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:56:37.804086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"610.399124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-10T10:56:37.804214Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.998496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-10T10:56:37.804217Z","caller":"traceutil/trace.go:171","msg":"trace[1884161387] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:24950; }","duration":"170.290109ms","start":"2026-06-10T10:56:37.633906Z","end":"2026-06-10T10:56:37.804196Z","steps":["trace[1884161387] 'agreement among raft nodes before linearized reading' (duration: 170.128434ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:37.804258Z","caller":"traceutil/trace.go:171","msg":"trace[661546456] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24950; }","duration":"588.053598ms","start":"2026-06-10T10:56:37.216185Z","end":"2026-06-10T10:56:37.804239Z","steps":["trace[661546456] 'agreement among raft nodes before linearized reading' (duration: 587.929535ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:37.804258Z","caller":"traceutil/trace.go:171","msg":"trace[840027450] range","detail":"{range_begin:/registry/validatingwebhookconfigurations/; range_end:/registry/validatingwebhookconfigurations0; response_count:0; response_revision:24950; }","duration":"610.60002ms","start":"2026-06-10T10:56:37.193632Z","end":"2026-06-10T10:56:37.804232Z","steps":["trace[840027450] 'agreement among raft nodes before linearized reading' (duration: 610.388074ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:37.804257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.887574ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:56:37.804302Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.216175Z","time spent":"588.118879ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T10:56:37.804312Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.193619Z","time spent":"610.678112ms","remote":"127.0.0.1:50236","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":8,"response size":32,"request content":"key:\"/registry/validatingwebhookconfigurations/\" range_end:\"/registry/validatingwebhookconfigurations0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:56:37.804353Z","caller":"traceutil/trace.go:171","msg":"trace[918907101] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24950; }","duration":"442.035308ms","start":"2026-06-10T10:56:37.362292Z","end":"2026-06-10T10:56:37.804328Z","steps":["trace[918907101] 'agreement among raft nodes before linearized reading' (duration: 441.834073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:37.804403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.362275Z","time spent":"442.12106ms","remote":"127.0.0.1:46092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T10:56:37.804196Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"747.155078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-10T10:56:37.805481Z","caller":"traceutil/trace.go:171","msg":"trace[1196228248] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24950; }","duration":"748.490035ms","start":"2026-06-10T10:56:37.056979Z","end":"2026-06-10T10:56:37.805469Z","steps":["trace[1196228248] 'agreement among raft nodes before linearized reading' (duration: 747.014804ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:37.805529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.056961Z","time spent":"748.541546ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T10:56:38.34797Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.735214ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:56:38.348072Z","caller":"traceutil/trace.go:171","msg":"trace[1118983108] transaction","detail":"{read_only:false; response_revision:24951; number_of_response:1; }","duration":"540.209848ms","start":"2026-06-10T10:56:37.807843Z","end":"2026-06-10T10:56:38.348053Z","steps":["trace[1118983108] 'process raft request' (duration: 270.293969ms)","trace[1118983108] 'compare' (duration: 269.60641ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:38.348133Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.807832Z","time spent":"540.271289ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:38.663953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.873765ms","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-10T10:56:38.664093Z","caller":"traceutil/trace.go:171","msg":"trace[810291189] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24951; }","duration":"167.031389ms","start":"2026-06-10T10:56:38.497038Z","end":"2026-06-10T10:56:38.664069Z","steps":["trace[810291189] 'range keys from in-memory index tree' (duration: 166.843894ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:38.66426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.878499ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:56:38.66448Z","caller":"traceutil/trace.go:171","msg":"trace[1954496570] transaction","detail":"{read_only:false; response_revision:24955; number_of_response:1; }","duration":"385.593061ms","start":"2026-06-10T10:56:38.278873Z","end":"2026-06-10T10:56:38.664467Z","steps":["trace[1954496570] 'process raft request' (duration: 385.55643ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:38.664555Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.278849Z","time spent":"385.663623ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:38.664628Z","caller":"traceutil/trace.go:171","msg":"trace[1443675175] transaction","detail":"{read_only:false; response_revision:24953; number_of_response:1; }","duration":"829.652224ms","start":"2026-06-10T10:56:37.834927Z","end":"2026-06-10T10:56:38.66458Z","steps":["trace[1443675175] 'process raft request' (duration: 829.422938ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:38.664733Z","caller":"traceutil/trace.go:171","msg":"trace[1551399560] transaction","detail":"{read_only:false; response_revision:24954; number_of_response:1; }","duration":"607.479933ms","start":"2026-06-10T10:56:38.057244Z","end":"2026-06-10T10:56:38.664724Z","steps":["trace[1551399560] 'process raft request' (duration: 607.143884ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:38.664743Z","caller":"traceutil/trace.go:171","msg":"trace[1433118267] linearizableReadLoop","detail":"{readStateIndex:25764; appliedIndex:25762; }","duration":"841.616665ms","start":"2026-06-10T10:56:37.823116Z","end":"2026-06-10T10:56:38.664733Z","steps":["trace[1433118267] 'read index received' (duration: 255.040908ms)","trace[1433118267] 'applied index is now lower than readState.Index' (duration: 586.574797ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:38.664777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.057219Z","time spent":"607.534845ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:38.664835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"841.689307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:38.664875Z","caller":"traceutil/trace.go:171","msg":"trace[821335149] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24955; }","duration":"841.769269ms","start":"2026-06-10T10:56:37.823087Z","end":"2026-06-10T10:56:38.664856Z","steps":["trace[821335149] 'agreement among raft nodes before linearized reading' (duration: 841.691927ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:38.664857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.834909Z","time spent":"829.8361ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:38.6649Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.823074Z","time spent":"841.81975ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Range","request count":0,"request size":67,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" "} {"level":"info","ts":"2026-06-10T10:56:38.664686Z","caller":"traceutil/trace.go:171","msg":"trace[1108170689] transaction","detail":"{read_only:false; response_revision:24952; number_of_response:1; }","duration":"854.995624ms","start":"2026-06-10T10:56:37.809667Z","end":"2026-06-10T10:56:38.664662Z","steps":["trace[1108170689] 'process raft request' (duration: 651.647232ms)","trace[1108170689] 'compare' (duration: 202.777566ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:38.665208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:37.809648Z","time spent":"855.509458ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:39.193156Z","caller":"traceutil/trace.go:171","msg":"trace[1921050184] transaction","detail":"{read_only:false; response_revision:24956; number_of_response:1; }","duration":"652.899508ms","start":"2026-06-10T10:56:38.540222Z","end":"2026-06-10T10:56:39.193121Z","steps":["trace[1921050184] 'process raft request' (duration: 612.680458ms)","trace[1921050184] 'compare' (duration: 39.969203ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:39.193399Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.540195Z","time spent":"653.058631ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:39.193537Z","caller":"traceutil/trace.go:171","msg":"trace[219043671] linearizableReadLoop","detail":"{readStateIndex:25772; appliedIndex:25767; }","duration":"528.753481ms","start":"2026-06-10T10:56:38.66476Z","end":"2026-06-10T10:56:39.193514Z","steps":["trace[219043671] 'read index received' (duration: 488.157871ms)","trace[219043671] 'applied index is now lower than readState.Index' (duration: 40.59434ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:39.193744Z","caller":"traceutil/trace.go:171","msg":"trace[2079552133] transaction","detail":"{read_only:false; response_revision:24957; number_of_response:1; }","duration":"649.559764ms","start":"2026-06-10T10:56:38.544172Z","end":"2026-06-10T10:56:39.193732Z","steps":["trace[2079552133] 'process raft request' (duration: 648.895746ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:39.193807Z","caller":"traceutil/trace.go:171","msg":"trace[63013228] transaction","detail":"{read_only:false; response_revision:24960; number_of_response:1; }","duration":"645.649867ms","start":"2026-06-10T10:56:38.548131Z","end":"2026-06-10T10:56:39.193781Z","steps":["trace[63013228] 'process raft request' (duration: 645.339048ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:39.193831Z","caller":"traceutil/trace.go:171","msg":"trace[460998975] transaction","detail":"{read_only:false; response_revision:24958; number_of_response:1; }","duration":"646.650364ms","start":"2026-06-10T10:56:38.54715Z","end":"2026-06-10T10:56:39.193801Z","steps":["trace[460998975] 'process raft request' (duration: 646.156921ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:39.193855Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.544146Z","time spent":"649.635177ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:39.193849Z","caller":"traceutil/trace.go:171","msg":"trace[2052912350] transaction","detail":"{read_only:false; response_revision:24959; number_of_response:1; }","duration":"646.568092ms","start":"2026-06-10T10:56:38.547257Z","end":"2026-06-10T10:56:39.193825Z","steps":["trace[2052912350] 'process raft request' (duration: 646.161371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:39.19393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"712.990665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:56:39.193974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.548122Z","time spent":"645.7562ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:39.193958Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.134307622s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-10T10:56:39.193977Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.547231Z","time spent":"646.679325ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:39.193979Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.547137Z","time spent":"646.761188ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:39.194028Z","caller":"traceutil/trace.go:171","msg":"trace[695907889] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:24960; }","duration":"713.132019ms","start":"2026-06-10T10:56:38.480871Z","end":"2026-06-10T10:56:39.194003Z","steps":["trace[695907889] 'agreement among raft nodes before linearized reading' (duration: 712.954614ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:39.194034Z","caller":"traceutil/trace.go:171","msg":"trace[1356968588] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24960; }","duration":"1.134422525s","start":"2026-06-10T10:56:38.059594Z","end":"2026-06-10T10:56:39.194016Z","steps":["trace[1356968588] 'agreement among raft nodes before linearized reading' (duration: 1.134200009s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:39.194075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.480853Z","time spent":"713.211281ms","remote":"127.0.0.1:36260","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":30,"request content":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true "} {"level":"warn","ts":"2026-06-10T10:56:39.194089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.059582Z","time spent":"1.134499077s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T10:56:39.193947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.130713943s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-10T10:56:39.194271Z","caller":"traceutil/trace.go:171","msg":"trace[1818197106] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24960; }","duration":"1.130944148s","start":"2026-06-10T10:56:38.063188Z","end":"2026-06-10T10:56:39.194132Z","steps":["trace[1818197106] 'agreement among raft nodes before linearized reading' (duration: 1.130599629s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:39.194351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.063177Z","time spent":"1.131153105s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-10T10:56:39.207888Z","caller":"traceutil/trace.go:171","msg":"trace[1511945347] transaction","detail":"{read_only:false; response_revision:24961; number_of_response:1; }","duration":"536.266178ms","start":"2026-06-10T10:56:38.671599Z","end":"2026-06-10T10:56:39.207865Z","steps":["trace[1511945347] 'process raft request' (duration: 536.148905ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:39.207918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.443115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:56:39.207953Z","caller":"traceutil/trace.go:171","msg":"trace[971517011] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24961; }","duration":"473.479256ms","start":"2026-06-10T10:56:38.734465Z","end":"2026-06-10T10:56:39.207944Z","steps":["trace[971517011] 'agreement among raft nodes before linearized reading' (duration: 473.366702ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:39.207974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.734422Z","time spent":"473.547257ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:56:39.208009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.394844ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T10:56:39.208105Z","caller":"traceutil/trace.go:171","msg":"trace[423354846] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/; range_end:/registry/nfd.k8s-sigs.io/nodefeatures0; response_count:0; response_revision:24961; }","duration":"390.559487ms","start":"2026-06-10T10:56:38.817523Z","end":"2026-06-10T10:56:39.208082Z","steps":["trace[423354846] 'agreement among raft nodes before linearized reading' (duration: 390.397133ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:39.207983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.671573Z","time spent":"536.368361ms","remote":"127.0.0.1:50662","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1633,"response count":0,"response size":42,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-10T10:56:39.208159Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:38.817503Z","time spent":"390.63925ms","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":1,"response size":32,"request content":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/\" range_end:\"/registry/nfd.k8s-sigs.io/nodefeatures0\" count_only:true "} {"level":"info","ts":"2026-06-10T10:56:46.889725Z","caller":"traceutil/trace.go:171","msg":"trace[672782378] linearizableReadLoop","detail":"{readStateIndex:25905; appliedIndex:25904; }","duration":"191.543316ms","start":"2026-06-10T10:56:46.698148Z","end":"2026-06-10T10:56:46.889691Z","steps":["trace[672782378] 'read index received' (duration: 188.548953ms)","trace[672782378] 'applied index is now lower than readState.Index' (duration: 2.993303ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:46.889858Z","caller":"traceutil/trace.go:171","msg":"trace[42301082] transaction","detail":"{read_only:false; response_revision:25090; number_of_response:1; }","duration":"200.303067ms","start":"2026-06-10T10:56:46.689541Z","end":"2026-06-10T10:56:46.889844Z","steps":["trace[42301082] 'process raft request' (duration: 197.14294ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:46.889987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.824063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-10T10:56:46.890018Z","caller":"traceutil/trace.go:171","msg":"trace[990411853] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25090; }","duration":"191.897615ms","start":"2026-06-10T10:56:46.698111Z","end":"2026-06-10T10:56:46.890009Z","steps":["trace[990411853] 'agreement among raft nodes before linearized reading' (duration: 191.760542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:47.214699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.484188ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:56:47.214841Z","caller":"traceutil/trace.go:171","msg":"trace[2141771325] linearizableReadLoop","detail":"{readStateIndex:25906; appliedIndex:25905; }","duration":"319.872877ms","start":"2026-06-10T10:56:46.894943Z","end":"2026-06-10T10:56:47.214816Z","steps":["trace[2141771325] 'read index received' (duration: 138.148512ms)","trace[2141771325] 'applied index is now lower than readState.Index' (duration: 181.722825ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:47.214872Z","caller":"traceutil/trace.go:171","msg":"trace[163144610] transaction","detail":"{read_only:false; response_revision:25091; number_of_response:1; }","duration":"321.103861ms","start":"2026-06-10T10:56:46.89372Z","end":"2026-06-10T10:56:47.214824Z","steps":["trace[163144610] 'process raft request' (duration: 139.358196ms)","trace[163144610] 'compare' (duration: 181.1911ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:47.214934Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.996921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:47.214979Z","caller":"traceutil/trace.go:171","msg":"trace[1237852143] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25091; }","duration":"320.079223ms","start":"2026-06-10T10:56:46.894887Z","end":"2026-06-10T10:56:47.214967Z","steps":["trace[1237852143] 'agreement among raft nodes before linearized reading' (duration: 319.98774ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:47.215016Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:46.894871Z","time spent":"320.135924ms","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-06-10T10:56:47.215067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:46.893693Z","time spent":"321.280086ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:47.351176Z","caller":"traceutil/trace.go:171","msg":"trace[472003998] transaction","detail":"{read_only:false; response_revision:25092; number_of_response:1; }","duration":"127.54223ms","start":"2026-06-10T10:56:47.223609Z","end":"2026-06-10T10:56:47.351151Z","steps":["trace[472003998] 'process raft request' (duration: 109.624735ms)","trace[472003998] 'compare' (duration: 17.810612ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:47.376102Z","caller":"traceutil/trace.go:171","msg":"trace[1147946782] linearizableReadLoop","detail":"{readStateIndex:25910; appliedIndex:25906; }","duration":"149.317221ms","start":"2026-06-10T10:56:47.22676Z","end":"2026-06-10T10:56:47.376077Z","steps":["trace[1147946782] 'read index received' (duration: 106.490939ms)","trace[1147946782] 'applied index is now lower than readState.Index' (duration: 42.825022ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:47.37623Z","caller":"traceutil/trace.go:171","msg":"trace[49471050] transaction","detail":"{read_only:false; response_revision:25093; number_of_response:1; }","duration":"151.956084ms","start":"2026-06-10T10:56:47.224259Z","end":"2026-06-10T10:56:47.376215Z","steps":["trace[49471050] 'process raft request' (duration: 151.544962ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:47.376371Z","caller":"traceutil/trace.go:171","msg":"trace[759001303] transaction","detail":"{read_only:false; response_revision:25094; number_of_response:1; }","duration":"151.874992ms","start":"2026-06-10T10:56:47.224482Z","end":"2026-06-10T10:56:47.376357Z","steps":["trace[759001303] 'process raft request' (duration: 151.4448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:47.376506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.741362ms","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-10T10:56:47.376611Z","caller":"traceutil/trace.go:171","msg":"trace[183487145] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25096; }","duration":"149.909547ms","start":"2026-06-10T10:56:47.22669Z","end":"2026-06-10T10:56:47.3766Z","steps":["trace[183487145] 'agreement among raft nodes before linearized reading' (duration: 149.766013ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:47.376702Z","caller":"traceutil/trace.go:171","msg":"trace[1433436778] transaction","detail":"{read_only:false; response_revision:25095; number_of_response:1; }","duration":"152.082707ms","start":"2026-06-10T10:56:47.224605Z","end":"2026-06-10T10:56:47.376687Z","steps":["trace[1433436778] 'process raft request' (duration: 151.365547ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:47.376704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.825851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T10:56:47.376752Z","caller":"traceutil/trace.go:171","msg":"trace[146187444] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25096; }","duration":"130.905322ms","start":"2026-06-10T10:56:47.245833Z","end":"2026-06-10T10:56:47.376738Z","steps":["trace[146187444] 'agreement among raft nodes before linearized reading' (duration: 130.767488ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:47.376849Z","caller":"traceutil/trace.go:171","msg":"trace[1675351553] transaction","detail":"{read_only:false; response_revision:25096; number_of_response:1; }","duration":"148.454037ms","start":"2026-06-10T10:56:47.228386Z","end":"2026-06-10T10:56:47.37684Z","steps":["trace[1675351553] 'process raft request' (duration: 147.644735ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:47.37697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.349617ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-10T10:56:47.376998Z","caller":"traceutil/trace.go:171","msg":"trace[1484253225] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25096; }","duration":"130.379408ms","start":"2026-06-10T10:56:47.246612Z","end":"2026-06-10T10:56:47.376991Z","steps":["trace[1484253225] 'agreement among raft nodes before linearized reading' (duration: 130.303896ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:47.376984Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.054597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-10T10:56:47.377056Z","caller":"traceutil/trace.go:171","msg":"trace[63920544] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25096; }","duration":"131.15381ms","start":"2026-06-10T10:56:47.245893Z","end":"2026-06-10T10:56:47.377047Z","steps":["trace[63920544] 'agreement among raft nodes before linearized reading' (duration: 131.048407ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:55.590599Z","caller":"traceutil/trace.go:171","msg":"trace[1503795552] transaction","detail":"{read_only:false; response_revision:25161; number_of_response:1; }","duration":"213.735368ms","start":"2026-06-10T10:56:55.376843Z","end":"2026-06-10T10:56:55.590578Z","steps":["trace[1503795552] 'process raft request' (duration: 213.572284ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:55.73098Z","caller":"traceutil/trace.go:171","msg":"trace[1188620844] transaction","detail":"{read_only:false; response_revision:25162; number_of_response:1; }","duration":"330.730056ms","start":"2026-06-10T10:56:55.400227Z","end":"2026-06-10T10:56:55.730957Z","steps":["trace[1188620844] 'process raft request' (duration: 295.808492ms)","trace[1188620844] 'compare' (duration: 34.75471ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:56:55.731122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:55.4002Z","time spent":"330.84923ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:55.731318Z","caller":"traceutil/trace.go:171","msg":"trace[1902523497] transaction","detail":"{read_only:false; response_revision:25163; number_of_response:1; }","duration":"330.86126ms","start":"2026-06-10T10:56:55.400448Z","end":"2026-06-10T10:56:55.731309Z","steps":["trace[1902523497] 'process raft request' (duration: 330.472229ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:55.731367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:55.400438Z","time spent":"330.902661ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:56:55.731375Z","caller":"traceutil/trace.go:171","msg":"trace[1806800861] linearizableReadLoop","detail":"{readStateIndex:25982; appliedIndex:25977; }","duration":"322.242282ms","start":"2026-06-10T10:56:55.409109Z","end":"2026-06-10T10:56:55.731352Z","steps":["trace[1806800861] 'read index received' (duration: 181.372105ms)","trace[1806800861] 'applied index is now lower than readState.Index' (duration: 140.868997ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:55.731468Z","caller":"traceutil/trace.go:171","msg":"trace[7698463] transaction","detail":"{read_only:false; response_revision:25165; number_of_response:1; }","duration":"327.080346ms","start":"2026-06-10T10:56:55.404376Z","end":"2026-06-10T10:56:55.731457Z","steps":["trace[7698463] 'process raft request' (duration: 326.927522ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:55.731476Z","caller":"traceutil/trace.go:171","msg":"trace[967021981] transaction","detail":"{read_only:false; response_revision:25164; number_of_response:1; }","duration":"328.893746ms","start":"2026-06-10T10:56:55.402558Z","end":"2026-06-10T10:56:55.731452Z","steps":["trace[967021981] 'process raft request' (duration: 328.625389ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:55.73153Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:55.40435Z","time spent":"327.148748ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:55.731614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:55.402523Z","time spent":"329.019079ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T10:56:55.731623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.49821ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:56:55.731737Z","caller":"traceutil/trace.go:171","msg":"trace[1759209026] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25165; }","duration":"322.662624ms","start":"2026-06-10T10:56:55.409062Z","end":"2026-06-10T10:56:55.731725Z","steps":["trace[1759209026] 'agreement among raft nodes before linearized reading' (duration: 322.431187ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:55.731779Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:55.409045Z","time spent":"322.724656ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T10:56:55.731794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.598002ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-10T10:56:55.731852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.599365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T10:56:55.731876Z","caller":"traceutil/trace.go:171","msg":"trace[373722671] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25165; }","duration":"318.722325ms","start":"2026-06-10T10:56:55.413136Z","end":"2026-06-10T10:56:55.731858Z","steps":["trace[373722671] 'agreement among raft nodes before linearized reading' (duration: 318.509729ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:55.7319Z","caller":"traceutil/trace.go:171","msg":"trace[16599635] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25165; }","duration":"317.670966ms","start":"2026-06-10T10:56:55.414218Z","end":"2026-06-10T10:56:55.731889Z","steps":["trace[16599635] 'agreement among raft nodes before linearized reading' (duration: 317.504231ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:55.731916Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:55.413122Z","time spent":"318.785588ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T10:56:55.731935Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:56:55.414209Z","time spent":"317.717468ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-10T10:56:55.993869Z","caller":"traceutil/trace.go:171","msg":"trace[1717568226] transaction","detail":"{read_only:false; response_revision:25166; number_of_response:1; }","duration":"258.672608ms","start":"2026-06-10T10:56:55.735146Z","end":"2026-06-10T10:56:55.993819Z","steps":["trace[1717568226] 'process raft request' (duration: 222.281604ms)","trace[1717568226] 'compare' (duration: 36.225149ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:55.994697Z","caller":"traceutil/trace.go:171","msg":"trace[508374509] linearizableReadLoop","detail":"{readStateIndex:25985; appliedIndex:25982; }","duration":"184.377358ms","start":"2026-06-10T10:56:55.810305Z","end":"2026-06-10T10:56:55.994682Z","steps":["trace[508374509] 'read index received' (duration: 147.179021ms)","trace[508374509] 'applied index is now lower than readState.Index' (duration: 37.195657ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:56:55.994775Z","caller":"traceutil/trace.go:171","msg":"trace[608383002] transaction","detail":"{read_only:false; response_revision:25168; number_of_response:1; }","duration":"259.338067ms","start":"2026-06-10T10:56:55.735422Z","end":"2026-06-10T10:56:55.99476Z","steps":["trace[608383002] 'process raft request' (duration: 259.198563ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:55.994773Z","caller":"traceutil/trace.go:171","msg":"trace[1372879188] transaction","detail":"{read_only:false; response_revision:25169; number_of_response:1; }","duration":"172.302625ms","start":"2026-06-10T10:56:55.822465Z","end":"2026-06-10T10:56:55.994768Z","steps":["trace[1372879188] 'process raft request' (duration: 172.174712ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:55.994899Z","caller":"traceutil/trace.go:171","msg":"trace[462879778] transaction","detail":"{read_only:false; response_revision:25167; number_of_response:1; }","duration":"259.671486ms","start":"2026-06-10T10:56:55.735221Z","end":"2026-06-10T10:56:55.994893Z","steps":["trace[462879778] 'process raft request' (duration: 259.318036ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:55.994942Z","caller":"traceutil/trace.go:171","msg":"trace[2082179305] transaction","detail":"{read_only:false; response_revision:25170; number_of_response:1; }","duration":"130.014998ms","start":"2026-06-10T10:56:55.864914Z","end":"2026-06-10T10:56:55.994929Z","steps":["trace[2082179305] 'process raft request' (duration: 129.7454ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:55.994881Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.561073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:55.995031Z","caller":"traceutil/trace.go:171","msg":"trace[1778055743] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:25170; }","duration":"184.737018ms","start":"2026-06-10T10:56:55.810267Z","end":"2026-06-10T10:56:55.995004Z","steps":["trace[1778055743] 'agreement among raft nodes before linearized reading' (duration: 184.542652ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:55.995079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.547989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418304"} {"level":"info","ts":"2026-06-10T10:56:55.995127Z","caller":"traceutil/trace.go:171","msg":"trace[1847908496] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:25170; }","duration":"177.638612ms","start":"2026-06-10T10:56:55.817475Z","end":"2026-06-10T10:56:55.995114Z","steps":["trace[1847908496] 'agreement among raft nodes before linearized reading' (duration: 177.369034ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:56:56.208005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.52621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:56:56.208086Z","caller":"traceutil/trace.go:171","msg":"trace[2137817972] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:25170; }","duration":"110.654673ms","start":"2026-06-10T10:56:56.097413Z","end":"2026-06-10T10:56:56.208067Z","steps":["trace[2137817972] 'count revisions from in-memory index tree' (duration: 110.456978ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:56:56.621345Z","caller":"traceutil/trace.go:171","msg":"trace[233380853] transaction","detail":"{read_only:false; response_revision:25171; number_of_response:1; }","duration":"224.560097ms","start":"2026-06-10T10:56:56.396741Z","end":"2026-06-10T10:56:56.621301Z","steps":["trace[233380853] 'process raft request' (duration: 223.999671ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:03.892411Z","caller":"traceutil/trace.go:171","msg":"trace[1150549421] transaction","detail":"{read_only:false; response_revision:25220; number_of_response:1; }","duration":"196.453381ms","start":"2026-06-10T10:57:03.695929Z","end":"2026-06-10T10:57:03.892383Z","steps":["trace[1150549421] 'process raft request' (duration: 145.222117ms)","trace[1150549421] 'compare' (duration: 51.051549ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:03.924425Z","caller":"traceutil/trace.go:171","msg":"trace[161678673] transaction","detail":"{read_only:false; response_revision:25222; number_of_response:1; }","duration":"166.147675ms","start":"2026-06-10T10:57:03.758254Z","end":"2026-06-10T10:57:03.924402Z","steps":["trace[161678673] 'process raft request' (duration: 166.075843ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:03.924768Z","caller":"traceutil/trace.go:171","msg":"trace[50160393] transaction","detail":"{read_only:false; response_revision:25224; number_of_response:1; }","duration":"164.889791ms","start":"2026-06-10T10:57:03.75987Z","end":"2026-06-10T10:57:03.92476Z","steps":["trace[50160393] 'process raft request' (duration: 164.717206ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:03.924763Z","caller":"traceutil/trace.go:171","msg":"trace[545591279] transaction","detail":"{read_only:false; response_revision:25223; number_of_response:1; }","duration":"164.935351ms","start":"2026-06-10T10:57:03.759803Z","end":"2026-06-10T10:57:03.924738Z","steps":["trace[545591279] 'process raft request' (duration: 164.564811ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:03.924448Z","caller":"traceutil/trace.go:171","msg":"trace[1745039368] transaction","detail":"{read_only:false; response_revision:25221; number_of_response:1; }","duration":"166.264099ms","start":"2026-06-10T10:57:03.758156Z","end":"2026-06-10T10:57:03.924421Z","steps":["trace[1745039368] 'process raft request' (duration: 166.044403ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.146893Z","caller":"traceutil/trace.go:171","msg":"trace[1212218586] transaction","detail":"{read_only:false; response_revision:25225; number_of_response:1; }","duration":"126.382098ms","start":"2026-06-10T10:57:04.020488Z","end":"2026-06-10T10:57:04.14687Z","steps":["trace[1212218586] 'process raft request' (duration: 126.226254ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.238885Z","caller":"traceutil/trace.go:171","msg":"trace[1327787643] linearizableReadLoop","detail":"{readStateIndex:26044; appliedIndex:26042; }","duration":"213.717557ms","start":"2026-06-10T10:57:04.025145Z","end":"2026-06-10T10:57:04.238862Z","steps":["trace[1327787643] 'read index received' (duration: 121.517023ms)","trace[1327787643] 'applied index is now lower than readState.Index' (duration: 92.199564ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:04.23923Z","caller":"traceutil/trace.go:171","msg":"trace[1384068783] transaction","detail":"{read_only:false; response_revision:25226; number_of_response:1; }","duration":"217.397859ms","start":"2026-06-10T10:57:04.021818Z","end":"2026-06-10T10:57:04.239216Z","steps":["trace[1384068783] 'process raft request' (duration: 216.910866ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.239545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.378735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-10T10:57:04.23959Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.544335ms","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-10T10:57:04.239598Z","caller":"traceutil/trace.go:171","msg":"trace[1046471958] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25226; }","duration":"214.477678ms","start":"2026-06-10T10:57:04.025106Z","end":"2026-06-10T10:57:04.239583Z","steps":["trace[1046471958] 'agreement among raft nodes before linearized reading' (duration: 214.311994ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.239662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.611874ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-10T10:57:04.239686Z","caller":"traceutil/trace.go:171","msg":"trace[1056165326] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25226; }","duration":"213.667436ms","start":"2026-06-10T10:57:04.026014Z","end":"2026-06-10T10:57:04.239681Z","steps":["trace[1056165326] 'agreement among raft nodes before linearized reading' (duration: 213.608874ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.23955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.600394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-10T10:57:04.239739Z","caller":"traceutil/trace.go:171","msg":"trace[960008866] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25226; }","duration":"213.81576ms","start":"2026-06-10T10:57:04.025917Z","end":"2026-06-10T10:57:04.239733Z","steps":["trace[960008866] 'agreement among raft nodes before linearized reading' (duration: 213.581614ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.239612Z","caller":"traceutil/trace.go:171","msg":"trace[638086220] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:25226; }","duration":"191.588987ms","start":"2026-06-10T10:57:04.048015Z","end":"2026-06-10T10:57:04.239604Z","steps":["trace[638086220] 'agreement among raft nodes before linearized reading' (duration: 191.555096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.370067Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.38408ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-10T10:57:04.370179Z","caller":"traceutil/trace.go:171","msg":"trace[1350535716] transaction","detail":"{read_only:false; response_revision:25227; number_of_response:1; }","duration":"126.550683ms","start":"2026-06-10T10:57:04.243609Z","end":"2026-06-10T10:57:04.370159Z","steps":["trace[1350535716] 'process raft request' (duration: 25.803943ms)","trace[1350535716] 'compare' (duration: 99.886746ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:04.380362Z","caller":"traceutil/trace.go:171","msg":"trace[794955797] linearizableReadLoop","detail":"{readStateIndex:26047; appliedIndex:26044; }","duration":"115.151317ms","start":"2026-06-10T10:57:04.265193Z","end":"2026-06-10T10:57:04.380344Z","steps":["trace[794955797] 'read index received' (duration: 4.234147ms)","trace[794955797] 'applied index is now lower than readState.Index' (duration: 110.91649ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:04.380426Z","caller":"traceutil/trace.go:171","msg":"trace[1186204142] transaction","detail":"{read_only:false; response_revision:25228; number_of_response:1; }","duration":"136.245479ms","start":"2026-06-10T10:57:04.244148Z","end":"2026-06-10T10:57:04.380393Z","steps":["trace[1186204142] 'process raft request' (duration: 136.072564ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.380571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.364753ms","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-10T10:57:04.380605Z","caller":"traceutil/trace.go:171","msg":"trace[450184550] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25229; }","duration":"115.438535ms","start":"2026-06-10T10:57:04.265155Z","end":"2026-06-10T10:57:04.380594Z","steps":["trace[450184550] 'agreement among raft nodes before linearized reading' (duration: 115.290941ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.380649Z","caller":"traceutil/trace.go:171","msg":"trace[1142820143] transaction","detail":"{read_only:false; response_revision:25229; number_of_response:1; }","duration":"136.28151ms","start":"2026-06-10T10:57:04.244223Z","end":"2026-06-10T10:57:04.380504Z","steps":["trace[1142820143] 'process raft request' (duration: 136.092475ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.750838Z","caller":"traceutil/trace.go:171","msg":"trace[2147216041] transaction","detail":"{read_only:false; response_revision:25230; number_of_response:1; }","duration":"111.665741ms","start":"2026-06-10T10:57:04.63915Z","end":"2026-06-10T10:57:04.750816Z","steps":["trace[2147216041] 'process raft request' (duration: 111.329742ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.861807Z","caller":"traceutil/trace.go:171","msg":"trace[2087039169] linearizableReadLoop","detail":"{readStateIndex:26050; appliedIndex:26049; }","duration":"111.156857ms","start":"2026-06-10T10:57:04.750622Z","end":"2026-06-10T10:57:04.861779Z","steps":["trace[2087039169] 'read index received' (duration: 111.059064ms)","trace[2087039169] 'applied index is now lower than readState.Index' (duration: 96.763µs)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:04.861869Z","caller":"traceutil/trace.go:171","msg":"trace[1326326795] transaction","detail":"{read_only:false; response_revision:25231; number_of_response:1; }","duration":"141.826344ms","start":"2026-06-10T10:57:04.720005Z","end":"2026-06-10T10:57:04.861832Z","steps":["trace[1326326795] 'process raft request' (duration: 141.620818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.86197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.311236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-10T10:57:04.862011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.118658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-10T10:57:04.862043Z","caller":"traceutil/trace.go:171","msg":"trace[1945293315] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25231; }","duration":"134.410919ms","start":"2026-06-10T10:57:04.727614Z","end":"2026-06-10T10:57:04.862025Z","steps":["trace[1945293315] 'agreement among raft nodes before linearized reading' (duration: 134.173702ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.862061Z","caller":"traceutil/trace.go:171","msg":"trace[977616110] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25231; }","duration":"135.18749ms","start":"2026-06-10T10:57:04.726857Z","end":"2026-06-10T10:57:04.862044Z","steps":["trace[977616110] 'agreement among raft nodes before linearized reading' (duration: 134.987865ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.862031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.350221ms","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-10T10:57:04.86214Z","caller":"traceutil/trace.go:171","msg":"trace[1474047958] range","detail":"{range_begin:/registry/prioritylevelconfigurations/; range_end:/registry/prioritylevelconfigurations0; response_count:0; response_revision:25231; }","duration":"145.524966ms","start":"2026-06-10T10:57:04.716599Z","end":"2026-06-10T10:57:04.862124Z","steps":["trace[1474047958] 'agreement among raft nodes before linearized reading' (duration: 145.33426ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:04.862236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.510711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10853"} {"level":"info","ts":"2026-06-10T10:57:04.862274Z","caller":"traceutil/trace.go:171","msg":"trace[674182796] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25231; }","duration":"155.570843ms","start":"2026-06-10T10:57:04.706692Z","end":"2026-06-10T10:57:04.862263Z","steps":["trace[674182796] 'agreement among raft nodes before linearized reading' (duration: 155.423219ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:04.862751Z","caller":"traceutil/trace.go:171","msg":"trace[1501293783] transaction","detail":"{read_only:false; response_revision:25232; number_of_response:1; }","duration":"108.427592ms","start":"2026-06-10T10:57:04.754308Z","end":"2026-06-10T10:57:04.862735Z","steps":["trace[1501293783] 'process raft request' (duration: 108.32981ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:12.063338Z","caller":"traceutil/trace.go:171","msg":"trace[1835351598] transaction","detail":"{read_only:false; response_revision:25294; number_of_response:1; }","duration":"113.255866ms","start":"2026-06-10T10:57:11.950056Z","end":"2026-06-10T10:57:12.063312Z","steps":["trace[1835351598] 'process raft request' (duration: 113.06176ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:12.063703Z","caller":"traceutil/trace.go:171","msg":"trace[122884733] transaction","detail":"{read_only:false; response_revision:25295; number_of_response:1; }","duration":"110.682424ms","start":"2026-06-10T10:57:11.953003Z","end":"2026-06-10T10:57:12.063686Z","steps":["trace[122884733] 'process raft request' (duration: 110.264922ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:12.063761Z","caller":"traceutil/trace.go:171","msg":"trace[1836932163] transaction","detail":"{read_only:false; response_revision:25296; number_of_response:1; }","duration":"110.670694ms","start":"2026-06-10T10:57:11.953059Z","end":"2026-06-10T10:57:12.063729Z","steps":["trace[1836932163] 'process raft request' (duration: 110.500449ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:17.322421Z","caller":"traceutil/trace.go:171","msg":"trace[45424971] transaction","detail":"{read_only:false; response_revision:25333; number_of_response:1; }","duration":"300.816511ms","start":"2026-06-10T10:57:17.021573Z","end":"2026-06-10T10:57:17.322389Z","steps":["trace[45424971] 'process raft request' (duration: 256.619252ms)","trace[45424971] 'compare' (duration: 44.092267ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:57:17.322589Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:57:17.021538Z","time spent":"300.972156ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:57:19.621419Z","caller":"traceutil/trace.go:171","msg":"trace[109738480] transaction","detail":"{read_only:false; response_revision:25351; number_of_response:1; }","duration":"111.883407ms","start":"2026-06-10T10:57:19.509512Z","end":"2026-06-10T10:57:19.621395Z","steps":["trace[109738480] 'process raft request' (duration: 111.739083ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:20.132212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.242915ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-10T10:57:20.132521Z","caller":"traceutil/trace.go:171","msg":"trace[1670887443] transaction","detail":"{read_only:false; response_revision:25352; number_of_response:1; }","duration":"360.262742ms","start":"2026-06-10T10:57:19.772246Z","end":"2026-06-10T10:57:20.132509Z","steps":["trace[1670887443] 'process raft request' (duration: 360.033925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:20.132603Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T10:57:19.772228Z","time spent":"360.331614ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T10:57:20.246958Z","caller":"traceutil/trace.go:171","msg":"trace[2091956777] linearizableReadLoop","detail":"{readStateIndex:26175; appliedIndex:26174; }","duration":"187.288118ms","start":"2026-06-10T10:57:20.059639Z","end":"2026-06-10T10:57:20.246928Z","steps":["trace[2091956777] 'read index received' (duration: 94.154398ms)","trace[2091956777] 'applied index is now lower than readState.Index' (duration: 93.13263ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:20.247019Z","caller":"traceutil/trace.go:171","msg":"trace[970558959] transaction","detail":"{read_only:false; response_revision:25353; number_of_response:1; }","duration":"235.270133ms","start":"2026-06-10T10:57:20.011715Z","end":"2026-06-10T10:57:20.246985Z","steps":["trace[970558959] 'process raft request' (duration: 141.994559ms)","trace[970558959] 'compare' (duration: 93.000866ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:57:20.247109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.448713ms","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-10T10:57:20.247161Z","caller":"traceutil/trace.go:171","msg":"trace[91823229] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:25353; }","duration":"187.518245ms","start":"2026-06-10T10:57:20.059626Z","end":"2026-06-10T10:57:20.247145Z","steps":["trace[91823229] 'agreement among raft nodes before linearized reading' (duration: 187.415652ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:20.289556Z","caller":"traceutil/trace.go:171","msg":"trace[1464936745] transaction","detail":"{read_only:false; response_revision:25355; number_of_response:1; }","duration":"196.710398ms","start":"2026-06-10T10:57:20.092822Z","end":"2026-06-10T10:57:20.289532Z","steps":["trace[1464936745] 'process raft request' (duration: 196.618115ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:20.289574Z","caller":"traceutil/trace.go:171","msg":"trace[900623966] transaction","detail":"{read_only:false; response_revision:25354; number_of_response:1; }","duration":"196.802281ms","start":"2026-06-10T10:57:20.092736Z","end":"2026-06-10T10:57:20.289538Z","steps":["trace[900623966] 'process raft request' (duration: 196.565914ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:20.289698Z","caller":"traceutil/trace.go:171","msg":"trace[448830900] transaction","detail":"{read_only:false; response_revision:25356; number_of_response:1; }","duration":"195.271009ms","start":"2026-06-10T10:57:20.094409Z","end":"2026-06-10T10:57:20.28968Z","steps":["trace[448830900] 'process raft request' (duration: 195.088354ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:20.394397Z","caller":"traceutil/trace.go:171","msg":"trace[326460648] transaction","detail":"{read_only:false; response_revision:25358; number_of_response:1; }","duration":"101.45833ms","start":"2026-06-10T10:57:20.292916Z","end":"2026-06-10T10:57:20.394375Z","steps":["trace[326460648] 'process raft request' (duration: 91.601088ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:22.295414Z","caller":"traceutil/trace.go:171","msg":"trace[1837273247] transaction","detail":"{read_only:false; response_revision:25366; number_of_response:1; }","duration":"158.0327ms","start":"2026-06-10T10:57:22.137361Z","end":"2026-06-10T10:57:22.295394Z","steps":["trace[1837273247] 'process raft request' (duration: 157.565537ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:22.361942Z","caller":"traceutil/trace.go:171","msg":"trace[1467802563] transaction","detail":"{read_only:false; response_revision:25367; number_of_response:1; }","duration":"110.857498ms","start":"2026-06-10T10:57:22.251064Z","end":"2026-06-10T10:57:22.361922Z","steps":["trace[1467802563] 'process raft request' (duration: 110.680373ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:22.534514Z","caller":"traceutil/trace.go:171","msg":"trace[1640260534] transaction","detail":"{read_only:false; response_revision:25372; number_of_response:1; }","duration":"136.020544ms","start":"2026-06-10T10:57:22.398469Z","end":"2026-06-10T10:57:22.534489Z","steps":["trace[1640260534] 'process raft request' (duration: 135.968813ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:22.534777Z","caller":"traceutil/trace.go:171","msg":"trace[1631688251] transaction","detail":"{read_only:false; response_revision:25370; number_of_response:1; }","duration":"239.021286ms","start":"2026-06-10T10:57:22.295729Z","end":"2026-06-10T10:57:22.53475Z","steps":["trace[1631688251] 'process raft request' (duration: 224.540337ms)","trace[1631688251] 'compare' (duration: 13.925884ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:22.534896Z","caller":"traceutil/trace.go:171","msg":"trace[844904063] transaction","detail":"{read_only:false; response_revision:25371; number_of_response:1; }","duration":"222.174741ms","start":"2026-06-10T10:57:22.312707Z","end":"2026-06-10T10:57:22.534882Z","steps":["trace[844904063] 'process raft request' (duration: 221.656147ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:22.534998Z","caller":"traceutil/trace.go:171","msg":"trace[1903855322] linearizableReadLoop","detail":"{readStateIndex:26192; appliedIndex:26188; }","duration":"232.347052ms","start":"2026-06-10T10:57:22.302642Z","end":"2026-06-10T10:57:22.534989Z","steps":["trace[1903855322] 'read index received' (duration: 59.087921ms)","trace[1903855322] 'applied index is now lower than readState.Index' (duration: 173.257921ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:57:22.53525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.596878ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"info","ts":"2026-06-10T10:57:22.535298Z","caller":"traceutil/trace.go:171","msg":"trace[1065709577] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:25372; }","duration":"232.671841ms","start":"2026-06-10T10:57:22.302612Z","end":"2026-06-10T10:57:22.535284Z","steps":["trace[1065709577] 'agreement among raft nodes before linearized reading' (duration: 232.517577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T10:57:22.535446Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.368362ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T10:57:22.535495Z","caller":"traceutil/trace.go:171","msg":"trace[439671057] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25372; }","duration":"170.453564ms","start":"2026-06-10T10:57:22.365033Z","end":"2026-06-10T10:57:22.535487Z","steps":["trace[439671057] 'agreement among raft nodes before linearized reading' (duration: 170.373921ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:22.653374Z","caller":"traceutil/trace.go:171","msg":"trace[155614801] transaction","detail":"{read_only:false; response_revision:25374; number_of_response:1; }","duration":"112.385361ms","start":"2026-06-10T10:57:22.540964Z","end":"2026-06-10T10:57:22.653349Z","steps":["trace[155614801] 'process raft request' (duration: 111.163527ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:22.65359Z","caller":"traceutil/trace.go:171","msg":"trace[669489015] transaction","detail":"{read_only:false; response_revision:25375; number_of_response:1; }","duration":"112.239837ms","start":"2026-06-10T10:57:22.541309Z","end":"2026-06-10T10:57:22.653549Z","steps":["trace[669489015] 'process raft request' (duration: 112.003461ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:57:25.205868Z","caller":"traceutil/trace.go:171","msg":"trace[184668236] transaction","detail":"{read_only:false; response_revision:25392; number_of_response:1; }","duration":"176.263184ms","start":"2026-06-10T10:57:25.029571Z","end":"2026-06-10T10:57:25.205834Z","steps":["trace[184668236] 'process raft request' (duration: 100.983626ms)","trace[184668236] 'compare' (duration: 74.967899ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:30.747887Z","caller":"traceutil/trace.go:171","msg":"trace[1947756586] linearizableReadLoop","detail":"{readStateIndex:26255; appliedIndex:26254; }","duration":"104.108342ms","start":"2026-06-10T10:57:30.643751Z","end":"2026-06-10T10:57:30.74786Z","steps":["trace[1947756586] 'read index received' (duration: 18.411448ms)","trace[1947756586] 'applied index is now lower than readState.Index' (duration: 85.695954ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T10:57:30.747939Z","caller":"traceutil/trace.go:171","msg":"trace[2061386728] transaction","detail":"{read_only:false; response_revision:25431; number_of_response:1; }","duration":"125.165244ms","start":"2026-06-10T10:57:30.622756Z","end":"2026-06-10T10:57:30.747921Z","steps":["trace[2061386728] 'process raft request' (duration: 39.409978ms)","trace[2061386728] 'compare' (duration: 84.751218ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T10:57:30.748193Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.424272ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-10T10:57:30.748277Z","caller":"traceutil/trace.go:171","msg":"trace[1557127461] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25431; }","duration":"104.558055ms","start":"2026-06-10T10:57:30.643697Z","end":"2026-06-10T10:57:30.748255Z","steps":["trace[1557127461] 'agreement among raft nodes before linearized reading' (duration: 104.273428ms)"],"step_count":1} {"level":"info","ts":"2026-06-10T10:58:41.605581Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23206} {"level":"info","ts":"2026-06-10T10:58:41.732983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23206,"took":"124.560967ms","hash":3695532481,"current-db-size-bytes":59965440,"current-db-size":"60 MB","current-db-size-in-use-bytes":35962880,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-10T10:58:41.733065Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3695532481,"revision":23206,"compact-revision":20175} {"level":"info","ts":"2026-06-10T10:58:56.227813Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a08.wal"} {"level":"info","ts":"2026-06-10T11:00:29.857647Z","caller":"traceutil/trace.go:171","msg":"trace[60531015] transaction","detail":"{read_only:false; response_revision:27325; number_of_response:1; }","duration":"545.731494ms","start":"2026-06-10T11:00:29.311894Z","end":"2026-06-10T11:00:29.857625Z","steps":["trace[60531015] 'process raft request' (duration: 543.651527ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.857765Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.311875Z","time spent":"545.829128ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":626,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:29.857899Z","caller":"traceutil/trace.go:171","msg":"trace[2137590157] linearizableReadLoop","detail":"{readStateIndex:28194; appliedIndex:28193; }","duration":"545.441216ms","start":"2026-06-10T11:00:29.312436Z","end":"2026-06-10T11:00:29.857878Z","steps":["trace[2137590157] 'read index received' (duration: 543.0464ms)","trace[2137590157] 'applied index is now lower than readState.Index' (duration: 2.393436ms)"],"step_count":2} {"level":"warn","ts":"2026-06-10T11:00:29.857985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"545.54741ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:29.858011Z","caller":"traceutil/trace.go:171","msg":"trace[182004080] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:27325; }","duration":"545.599751ms","start":"2026-06-10T11:00:29.312404Z","end":"2026-06-10T11:00:29.858003Z","steps":["trace[182004080] 'agreement among raft nodes before linearized reading' (duration: 545.55688ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.858031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.312391Z","time spent":"545.635282ms","remote":"127.0.0.1:49980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":30,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-06-10T11:00:29.858191Z","caller":"traceutil/trace.go:171","msg":"trace[527432500] transaction","detail":"{read_only:false; response_revision:27327; number_of_response:1; }","duration":"515.242095ms","start":"2026-06-10T11:00:29.342941Z","end":"2026-06-10T11:00:29.858183Z","steps":["trace[527432500] 'process raft request' (duration: 515.0639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.858229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.342918Z","time spent":"515.288486ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:29.858314Z","caller":"traceutil/trace.go:171","msg":"trace[1498909957] transaction","detail":"{read_only:false; response_revision:27326; number_of_response:1; }","duration":"531.237566ms","start":"2026-06-10T11:00:29.327066Z","end":"2026-06-10T11:00:29.858304Z","steps":["trace[1498909957] 'process raft request' (duration: 530.766303ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.858352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.32704Z","time spent":"531.292687ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:29.858516Z","caller":"traceutil/trace.go:171","msg":"trace[2062652000] transaction","detail":"{read_only:false; response_revision:27328; number_of_response:1; }","duration":"480.378395ms","start":"2026-06-10T11:00:29.37813Z","end":"2026-06-10T11:00:29.858508Z","steps":["trace[2062652000] 'process raft request' (duration: 479.919712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.858558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.378102Z","time spent":"480.429826ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:29.858691Z","caller":"traceutil/trace.go:171","msg":"trace[957643113] transaction","detail":"{read_only:false; response_revision:27329; number_of_response:1; }","duration":"468.917229ms","start":"2026-06-10T11:00:29.389768Z","end":"2026-06-10T11:00:29.858685Z","steps":["trace[957643113] 'process raft request' (duration: 468.310892ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.858727Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.389744Z","time spent":"468.96388ms","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:29.86602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"443.89853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/horizon-db-init-2cc5n\" ","response":"range_response_count:1 size:6321"} {"level":"info","ts":"2026-06-10T11:00:29.86609Z","caller":"traceutil/trace.go:171","msg":"trace[996710183] range","detail":"{range_begin:/registry/pods/openstack/horizon-db-init-2cc5n; range_end:; response_count:1; response_revision:27329; }","duration":"444.016473ms","start":"2026-06-10T11:00:29.422059Z","end":"2026-06-10T11:00:29.866075Z","steps":["trace[996710183] 'agreement among raft nodes before linearized reading' (duration: 443.881899ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.866115Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.42204Z","time spent":"444.068554ms","remote":"127.0.0.1:49918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":1,"response size":6345,"request content":"key:\"/registry/pods/openstack/horizon-db-init-2cc5n\" "} {"level":"warn","ts":"2026-06-10T11:00:29.866248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"504.788917ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:29.866273Z","caller":"traceutil/trace.go:171","msg":"trace[1956510186] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27329; }","duration":"504.844798ms","start":"2026-06-10T11:00:29.361422Z","end":"2026-06-10T11:00:29.866267Z","steps":["trace[1956510186] 'agreement among raft nodes before linearized reading' (duration: 504.804517ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:29.866292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:29.361409Z","time spent":"504.879969ms","remote":"127.0.0.1:46092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T11:00:31.862842Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813707398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T11:00:32.36362Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813707398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T11:00:32.864283Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813707398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T11:00:33.362011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.000180938s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"","error":"context deadline exceeded"} {"level":"info","ts":"2026-06-10T11:00:33.362164Z","caller":"traceutil/trace.go:171","msg":"trace[559474952] range","detail":"{range_begin:/registry/health; range_end:; }","duration":"2.000404295s","start":"2026-06-10T11:00:31.361739Z","end":"2026-06-10T11:00:33.362144Z","steps":["trace[559474952] 'agreement among raft nodes before linearized reading' (duration: 2.00022187s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:33.362218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.361715Z","time spent":"2.000489687s","remote":"127.0.0.1:46076","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":0,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T11:00:33.364917Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813707398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T11:00:34.196656Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813707398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T11:00:34.697696Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":17576316453813707398,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-06-10T11:00:34.772933Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"3.583730381s","expected-duration":"1s"} {"level":"info","ts":"2026-06-10T11:00:34.773576Z","caller":"traceutil/trace.go:171","msg":"trace[1025289627] transaction","detail":"{read_only:false; response_revision:27338; number_of_response:1; }","duration":"3.740790417s","start":"2026-06-10T11:00:31.032751Z","end":"2026-06-10T11:00:34.773541Z","steps":["trace[1025289627] 'process raft request' (duration: 3.740546921s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.773886Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.032725Z","time spent":"3.740978703s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.779548Z","caller":"traceutil/trace.go:171","msg":"trace[1580169554] linearizableReadLoop","detail":"{readStateIndex:28216; appliedIndex:28207; }","duration":"3.417730388s","start":"2026-06-10T11:00:31.361793Z","end":"2026-06-10T11:00:34.779523Z","steps":["trace[1580169554] 'read index received' (duration: 3.411514367s)","trace[1580169554] 'applied index is now lower than readState.Index' (duration: 6.211641ms)"],"step_count":2} {"level":"info","ts":"2026-06-10T11:00:34.779859Z","caller":"traceutil/trace.go:171","msg":"trace[1687723278] transaction","detail":"{read_only:false; response_revision:27343; number_of_response:1; }","duration":"2.910025793s","start":"2026-06-10T11:00:31.869779Z","end":"2026-06-10T11:00:34.779805Z","steps":["trace[1687723278] 'process raft request' (duration: 2.909602561s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.779944Z","caller":"traceutil/trace.go:171","msg":"trace[1693567162] transaction","detail":"{read_only:false; response_revision:27345; number_of_response:1; }","duration":"2.613854605s","start":"2026-06-10T11:00:32.166082Z","end":"2026-06-10T11:00:34.779937Z","steps":["trace[1693567162] 'process raft request' (duration: 2.613369121s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.780048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.166067Z","time spent":"2.613904527s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-10T11:00:34.780227Z","caller":"traceutil/trace.go:171","msg":"trace[1397594950] transaction","detail":"{read_only:false; response_revision:27346; number_of_response:1; }","duration":"1.243875145s","start":"2026-06-10T11:00:33.536341Z","end":"2026-06-10T11:00:34.780217Z","steps":["trace[1397594950] 'process raft request' (duration: 1.243139345s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.779906Z","caller":"traceutil/trace.go:171","msg":"trace[2047596869] transaction","detail":"{read_only:false; response_revision:27340; number_of_response:1; }","duration":"3.615517367s","start":"2026-06-10T11:00:31.164352Z","end":"2026-06-10T11:00:34.77987Z","steps":["trace[2047596869] 'process raft request' (duration: 3.61491418s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.780285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:33.536315Z","time spent":"1.243938287s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.780288Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.869768Z","time spent":"2.910247249s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.780383Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.164331Z","time spent":"3.615964349s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.780439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.914768093s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:34.780477Z","caller":"traceutil/trace.go:171","msg":"trace[1624849333] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:0; response_revision:27346; }","duration":"2.914834675s","start":"2026-06-10T11:00:31.865634Z","end":"2026-06-10T11:00:34.780469Z","steps":["trace[1624849333] 'agreement among raft nodes before linearized reading' (duration: 2.914772683s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.780507Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.865621Z","time spent":"2.914880176s","remote":"127.0.0.1:49980","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":0,"response size":30,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-06-10T11:00:34.780659Z","caller":"traceutil/trace.go:171","msg":"trace[1698255612] transaction","detail":"{read_only:false; response_revision:27342; number_of_response:1; }","duration":"2.916755648s","start":"2026-06-10T11:00:31.863862Z","end":"2026-06-10T11:00:34.780618Z","steps":["trace[1698255612] 'process raft request' (duration: 2.915478103s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.780719Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.666694813s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:34.780755Z","caller":"traceutil/trace.go:171","msg":"trace[1126730771] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/subnets/; range_end:/registry/openstack.k-orc.cloud/subnets0; response_count:0; response_revision:27346; }","duration":"1.666768245s","start":"2026-06-10T11:00:33.113974Z","end":"2026-06-10T11:00:34.780743Z","steps":["trace[1126730771] 'agreement among raft nodes before linearized reading' (duration: 1.666700413s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.780785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:33.113953Z","time spent":"1.666825807s","remote":"127.0.0.1:59890","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":30,"request content":"key:\"/registry/openstack.k-orc.cloud/subnets/\" range_end:\"/registry/openstack.k-orc.cloud/subnets0\" count_only:true "} {"level":"warn","ts":"2026-06-10T11:00:34.780808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.93047771s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"info","ts":"2026-06-10T11:00:34.780841Z","caller":"traceutil/trace.go:171","msg":"trace[1139333634] transaction","detail":"{read_only:false; response_revision:27341; number_of_response:1; }","duration":"3.540076169s","start":"2026-06-10T11:00:31.240757Z","end":"2026-06-10T11:00:34.780833Z","steps":["trace[1139333634] 'process raft request' (duration: 3.538546117s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.780845Z","caller":"traceutil/trace.go:171","msg":"trace[1201075995] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:27346; }","duration":"1.930568072s","start":"2026-06-10T11:00:32.850268Z","end":"2026-06-10T11:00:34.780836Z","steps":["trace[1201075995] 'agreement among raft nodes before linearized reading' (duration: 1.930430989s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.780876Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.850249Z","time spent":"1.930621003s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":557,"request content":"key:\"/registry/leases/cert-manager/cert-manager-controller\" "} {"level":"warn","ts":"2026-06-10T11:00:34.780877Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.240731Z","time spent":"3.54012764s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.78099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.106495458s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-10T11:00:34.781018Z","caller":"traceutil/trace.go:171","msg":"trace[126456956] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:27346; }","duration":"2.106655783s","start":"2026-06-10T11:00:32.674355Z","end":"2026-06-10T11:00:34.781011Z","steps":["trace[126456956] 'agreement among raft nodes before linearized reading' (duration: 2.106580871s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781041Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.674336Z","time spent":"2.106700074s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-10T11:00:34.781151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.903894304s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-10T11:00:34.781162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.892095598s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-10T11:00:34.781184Z","caller":"traceutil/trace.go:171","msg":"trace[231994634] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:27346; }","duration":"2.903958425s","start":"2026-06-10T11:00:31.877217Z","end":"2026-06-10T11:00:34.781176Z","steps":["trace[231994634] 'agreement among raft nodes before linearized reading' (duration: 2.903876052s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.781192Z","caller":"traceutil/trace.go:171","msg":"trace[448420972] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:27346; }","duration":"2.892128579s","start":"2026-06-10T11:00:31.889055Z","end":"2026-06-10T11:00:34.781184Z","steps":["trace[448420972] 'agreement among raft nodes before linearized reading' (duration: 2.891988365s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781213Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.88903Z","time spent":"2.892178541s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-10T11:00:34.78121Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.877206Z","time spent":"2.903996686s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-10T11:00:34.78131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.058796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.95\" ","response":"range_response_count:1 size:137"} {"level":"warn","ts":"2026-06-10T11:00:34.781335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.906440444s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-10T11:00:34.781346Z","caller":"traceutil/trace.go:171","msg":"trace[1843572578] range","detail":"{range_begin:/registry/masterleases/199.204.45.95; range_end:; response_count:1; response_revision:27346; }","duration":"149.137079ms","start":"2026-06-10T11:00:34.632197Z","end":"2026-06-10T11:00:34.781334Z","steps":["trace[1843572578] 'agreement among raft nodes before linearized reading' (duration: 149.028336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.229838986s","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-10T11:00:34.781368Z","caller":"traceutil/trace.go:171","msg":"trace[312972325] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27346; }","duration":"2.906513536s","start":"2026-06-10T11:00:31.874842Z","end":"2026-06-10T11:00:34.781355Z","steps":["trace[312972325] 'agreement among raft nodes before linearized reading' (duration: 2.906433353s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.781377Z","caller":"traceutil/trace.go:171","msg":"trace[881988991] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:27346; }","duration":"2.229893938s","start":"2026-06-10T11:00:32.551473Z","end":"2026-06-10T11:00:34.781367Z","steps":["trace[881988991] 'agreement among raft nodes before linearized reading' (duration: 2.229813776s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.874817Z","time spent":"2.906571898s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-10T11:00:34.781442Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.327351383s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:34.781461Z","caller":"traceutil/trace.go:171","msg":"trace[1270800055] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:27346; }","duration":"2.327420344s","start":"2026-06-10T11:00:32.454034Z","end":"2026-06-10T11:00:34.781455Z","steps":["trace[1270800055] 'agreement among raft nodes before linearized reading' (duration: 2.327381753s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.454014Z","time spent":"2.327457746s","remote":"127.0.0.1:60388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":30,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-10T11:00:34.780807Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.863845Z","time spent":"2.916889161s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.781398Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.551457Z","time spent":"2.229937019s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":586,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"warn","ts":"2026-06-10T11:00:34.781656Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.602860712s","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-10T11:00:34.781678Z","caller":"traceutil/trace.go:171","msg":"trace[60624680] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:27346; }","duration":"2.602929044s","start":"2026-06-10T11:00:32.178742Z","end":"2026-06-10T11:00:34.781671Z","steps":["trace[60624680] 'agreement among raft nodes before linearized reading' (duration: 2.602863933s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781705Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.17872Z","time spent":"2.602979465s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":518,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-10T11:00:34.781764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.637536ms","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:6"} {"level":"info","ts":"2026-06-10T11:00:34.779911Z","caller":"traceutil/trace.go:171","msg":"trace[811438812] transaction","detail":"{read_only:false; response_revision:27344; number_of_response:1; }","duration":"2.909398185s","start":"2026-06-10T11:00:31.8705Z","end":"2026-06-10T11:00:34.779898Z","steps":["trace[811438812] 'process raft request' (duration: 2.908916142s)"],"step_count":1} {"level":"info","ts":"2026-06-10T11:00:34.781796Z","caller":"traceutil/trace.go:171","msg":"trace[950046974] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:27346; }","duration":"168.676097ms","start":"2026-06-10T11:00:34.613113Z","end":"2026-06-10T11:00:34.781789Z","steps":["trace[950046974] 'agreement among raft nodes before linearized reading' (duration: 168.621585ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.618147533s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/manila-api-7d7b976d57-7pqkp.18b7b331581a70d5\" ","response":"range_response_count:1 size:1179"} {"level":"warn","ts":"2026-06-10T11:00:34.781834Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.870475Z","time spent":"2.911324529s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.781883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"2.653948919s","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-10T11:00:34.78191Z","caller":"traceutil/trace.go:171","msg":"trace[1025394962] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:27346; }","duration":"2.654074863s","start":"2026-06-10T11:00:32.127827Z","end":"2026-06-10T11:00:34.781901Z","steps":["trace[1025394962] 'agreement among raft nodes before linearized reading' (duration: 2.654032001s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.127789Z","time spent":"2.654135794s","remote":"127.0.0.1:56042","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":1,"response size":32,"request content":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true "} {"level":"info","ts":"2026-06-10T11:00:34.781846Z","caller":"traceutil/trace.go:171","msg":"trace[152663949] range","detail":"{range_begin:/registry/events/openstack/manila-api-7d7b976d57-7pqkp.18b7b331581a70d5; range_end:; response_count:1; response_revision:27346; }","duration":"2.618210985s","start":"2026-06-10T11:00:32.16362Z","end":"2026-06-10T11:00:34.781831Z","steps":["trace[152663949] 'agreement among raft nodes before linearized reading' (duration: 2.618132263s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.781996Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:32.163602Z","time spent":"2.61838098s","remote":"127.0.0.1:49816","response type":"/etcdserverpb.KV/Range","request count":0,"request size":73,"response count":1,"response size":1203,"request content":"key:\"/registry/events/openstack/manila-api-7d7b976d57-7pqkp.18b7b331581a70d5\" "} {"level":"info","ts":"2026-06-10T11:00:34.781375Z","caller":"traceutil/trace.go:171","msg":"trace[1281030812] transaction","detail":"{read_only:false; response_revision:27339; number_of_response:1; }","duration":"3.683294124s","start":"2026-06-10T11:00:31.098028Z","end":"2026-06-10T11:00:34.781322Z","steps":["trace[1281030812] 'process raft request' (duration: 3.681027771s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.782103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.883301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-10T11:00:34.782143Z","caller":"traceutil/trace.go:171","msg":"trace[359223246] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:27346; }","duration":"189.954823ms","start":"2026-06-10T11:00:34.592173Z","end":"2026-06-10T11:00:34.782128Z","steps":["trace[359223246] 'agreement among raft nodes before linearized reading' (duration: 189.763998ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.782201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:31.098009Z","time spent":"3.684112797s","remote":"127.0.0.1:50016","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-10T11:00:34.782263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"468.123795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:34.782289Z","caller":"traceutil/trace.go:171","msg":"trace[1117690108] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheusagents/; range_end:/registry/monitoring.coreos.com/prometheusagents0; response_count:0; response_revision:27346; }","duration":"468.151796ms","start":"2026-06-10T11:00:34.314128Z","end":"2026-06-10T11:00:34.78228Z","steps":["trace[1117690108] 'agreement among raft nodes before linearized reading' (duration: 468.106235ms)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.782307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:34.314109Z","time spent":"468.193318ms","remote":"127.0.0.1:56048","response type":"/etcdserverpb.KV/Range","request count":0,"request size":104,"response count":0,"response size":30,"request content":"key:\"/registry/monitoring.coreos.com/prometheusagents/\" range_end:\"/registry/monitoring.coreos.com/prometheusagents0\" count_only:true "} {"level":"warn","ts":"2026-06-10T11:00:34.782425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.412447329s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:34.782456Z","caller":"traceutil/trace.go:171","msg":"trace[417369626] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27346; }","duration":"1.412542852s","start":"2026-06-10T11:00:33.369907Z","end":"2026-06-10T11:00:34.78245Z","steps":["trace[417369626] 'agreement among raft nodes before linearized reading' (duration: 1.41249536s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.78248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:33.369876Z","time spent":"1.412599413s","remote":"127.0.0.1:46092","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-10T11:00:34.782535Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.394382582s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" ","response":"range_response_count:1 size:1989"} {"level":"info","ts":"2026-06-10T11:00:34.782619Z","caller":"traceutil/trace.go:171","msg":"trace[286336411] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:27346; }","duration":"1.394485275s","start":"2026-06-10T11:00:33.388108Z","end":"2026-06-10T11:00:34.782594Z","steps":["trace[286336411] 'agreement among raft nodes before linearized reading' (duration: 1.394208617s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.78266Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:33.388018Z","time spent":"1.394633318s","remote":"127.0.0.1:49934","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2013,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"warn","ts":"2026-06-10T11:00:34.782711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.277839221s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-10T11:00:34.782752Z","caller":"traceutil/trace.go:171","msg":"trace[2141249751] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackmachines/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackmachines0; response_count:0; response_revision:27346; }","duration":"1.277931044s","start":"2026-06-10T11:00:33.504807Z","end":"2026-06-10T11:00:34.782738Z","steps":["trace[2141249751] 'agreement among raft nodes before linearized reading' (duration: 1.277848861s)"],"step_count":1} {"level":"warn","ts":"2026-06-10T11:00:34.782774Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-10T11:00:33.504785Z","time spent":"1.277982635s","remote":"127.0.0.1:60520","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":30,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackmachines0\" count_only:true "} {"level":"info","ts":"2026-06-10T11:03:41.611801Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26162} {"level":"info","ts":"2026-06-10T11:03:41.757807Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26162,"took":"140.844298ms","hash":633742257,"current-db-size-bytes":59965440,"current-db-size":"60 MB","current-db-size-in-use-bytes":34652160,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-06-10T11:03:41.75791Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":633742257,"revision":26162,"compact-revision":23206} {"level":"info","ts":"2026-06-10T11:04:09.875527Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T11:04:09.879916Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-10T11:04:09.880013Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-10T11:08:41.620443Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28871} {"level":"info","ts":"2026-06-10T11:08:41.779896Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28871,"took":"155.004992ms","hash":3322042887,"current-db-size-bytes":59965440,"current-db-size":"60 MB","current-db-size-in-use-bytes":30826496,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T11:08:41.779964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3322042887,"revision":28871,"compact-revision":26162} {"level":"info","ts":"2026-06-10T11:13:41.626978Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31123} {"level":"info","ts":"2026-06-10T11:13:41.752021Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31123,"took":"120.679296ms","hash":3534919240,"current-db-size-bytes":59965440,"current-db-size":"60 MB","current-db-size-in-use-bytes":30371840,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-10T11:13:41.752089Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3534919240,"revision":31123,"compact-revision":28871} {"level":"info","ts":"2026-06-10T11:18:41.633532Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33389} {"level":"info","ts":"2026-06-10T11:18:41.77313Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33389,"took":"135.489468ms","hash":1309601585,"current-db-size-bytes":61005824,"current-db-size":"61 MB","current-db-size-in-use-bytes":32092160,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T11:18:41.773183Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1309601585,"revision":33389,"compact-revision":31123} {"level":"info","ts":"2026-06-10T11:23:41.638983Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35679} {"level":"info","ts":"2026-06-10T11:23:41.784167Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35679,"took":"141.973087ms","hash":2357582912,"current-db-size-bytes":61476864,"current-db-size":"62 MB","current-db-size-in-use-bytes":31571968,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-10T11:23:41.784286Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2357582912,"revision":35679,"compact-revision":33389} {"level":"info","ts":"2026-06-10T11:25:32.020779Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-10T11:25:32.025454Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-10T11:25:32.025552Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-10T11:28:41.64433Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37907} {"level":"info","ts":"2026-06-10T11:28:41.7618Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37907,"took":"114.201762ms","hash":2048371675,"current-db-size-bytes":61476864,"current-db-size":"62 MB","current-db-size-in-use-bytes":31031296,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-10T11:28:41.761875Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2048371675,"revision":37907,"compact-revision":35679}