{"level":"warn","ts":"2026-04-22T13:55:18.366721Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T13:55:18.366814Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.10:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.10:2380","--initial-cluster=instance=https://199.19.213.10:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.10:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.10: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-04-22T13:55:18.366879Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-22T13:55:18.366894Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.10:2380"]} {"level":"info","ts":"2026-04-22T13:55:18.366916Z","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-04-22T13:55:18.367556Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.10:2379"]} {"level":"info","ts":"2026-04-22T13:55:18.367667Z","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.19.213.10:2380"],"listen-peer-urls":["https://199.19.213.10:2380"],"advertise-client-urls":["https://199.19.213.10:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.10:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.10: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-04-22T13:55:18.371925Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.044667ms"} {"level":"info","ts":"2026-04-22T13:55:18.379476Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"93eaf76b69bfff2c","cluster-id":"800615b58ad8280"} {"level":"info","ts":"2026-04-22T13:55:18.379557Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c switched to configuration voters=()"} {"level":"info","ts":"2026-04-22T13:55:18.379587Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c became follower at term 0"} {"level":"info","ts":"2026-04-22T13:55:18.379606Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 93eaf76b69bfff2c [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-22T13:55:18.379621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c became follower at term 1"} {"level":"info","ts":"2026-04-22T13:55:18.379662Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c switched to configuration voters=(10658603508833451820)"} {"level":"warn","ts":"2026-04-22T13:55:18.385056Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-22T13:55:18.387041Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-22T13:55:18.388168Z","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-04-22T13:55:18.390592Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"93eaf76b69bfff2c","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-22T13:55:18.39125Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"93eaf76b69bfff2c","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-22T13:55:18.393083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c switched to configuration voters=(10658603508833451820)"} {"level":"info","ts":"2026-04-22T13:55:18.391262Z","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-04-22T13:55:18.393363Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"800615b58ad8280","local-member-id":"93eaf76b69bfff2c","added-peer-id":"93eaf76b69bfff2c","added-peer-peer-urls":["https://199.19.213.10:2380"]} {"level":"info","ts":"2026-04-22T13:55:18.393409Z","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-04-22T13:55:18.393447Z","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-04-22T13:55:18.396544Z","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-04-22T13:55:18.396831Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"93eaf76b69bfff2c","initial-advertise-peer-urls":["https://199.19.213.10:2380"],"listen-peer-urls":["https://199.19.213.10:2380"],"advertise-client-urls":["https://199.19.213.10:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.10:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-22T13:55:18.396836Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.10:2380"} {"level":"info","ts":"2026-04-22T13:55:18.396893Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-22T13:55:18.3969Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.10:2380"} {"level":"info","ts":"2026-04-22T13:55:18.479952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c is starting a new election at term 1"} {"level":"info","ts":"2026-04-22T13:55:18.480025Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c became pre-candidate at term 1"} {"level":"info","ts":"2026-04-22T13:55:18.48006Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c received MsgPreVoteResp from 93eaf76b69bfff2c at term 1"} {"level":"info","ts":"2026-04-22T13:55:18.48008Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c became candidate at term 2"} {"level":"info","ts":"2026-04-22T13:55:18.480133Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c received MsgVoteResp from 93eaf76b69bfff2c at term 2"} {"level":"info","ts":"2026-04-22T13:55:18.480169Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"93eaf76b69bfff2c became leader at term 2"} {"level":"info","ts":"2026-04-22T13:55:18.480184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 93eaf76b69bfff2c elected leader 93eaf76b69bfff2c at term 2"} {"level":"info","ts":"2026-04-22T13:55:18.481207Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"93eaf76b69bfff2c","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.10:2379]}","request-path":"/0/members/93eaf76b69bfff2c/attributes","cluster-id":"800615b58ad8280","publish-timeout":"7s"} {"level":"info","ts":"2026-04-22T13:55:18.481462Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:55:18.481523Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-22T13:55:18.481532Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:55:18.481771Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-22T13:55:18.481846Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-22T13:55:18.482412Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"800615b58ad8280","local-member-id":"93eaf76b69bfff2c","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:55:18.482655Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:55:18.482698Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-22T13:55:18.484818Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.10:2379"} {"level":"info","ts":"2026-04-22T13:55:18.48529Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-22T13:55:53.994427Z","caller":"traceutil/trace.go:171","msg":"trace[1783476487] linearizableReadLoop","detail":"{readStateIndex:636; appliedIndex:635; }","duration":"214.264337ms","start":"2026-04-22T13:55:53.780136Z","end":"2026-04-22T13:55:53.9944Z","steps":["trace[1783476487] 'read index received' (duration: 213.474763ms)","trace[1783476487] 'applied index is now lower than readState.Index' (duration: 788.684µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:55:53.994526Z","caller":"traceutil/trace.go:171","msg":"trace[1364913675] transaction","detail":"{read_only:false; response_revision:612; number_of_response:1; }","duration":"244.408685ms","start":"2026-04-22T13:55:53.75008Z","end":"2026-04-22T13:55:53.994489Z","steps":["trace[1364913675] 'process raft request' (duration: 243.779933ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:55:53.994712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.234091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-fkxpq\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-04-22T13:55:53.994775Z","caller":"traceutil/trace.go:171","msg":"trace[143389005] range","detail":"{range_begin:/registry/pods/kube-system/cilium-fkxpq; range_end:; response_count:1; response_revision:612; }","duration":"167.353533ms","start":"2026-04-22T13:55:53.827408Z","end":"2026-04-22T13:55:53.994762Z","steps":["trace[143389005] 'agreement among raft nodes before linearized reading' (duration: 167.169989ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:55:53.994659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.487701ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:55:53.99488Z","caller":"traceutil/trace.go:171","msg":"trace[1507704382] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:612; }","duration":"214.771456ms","start":"2026-04-22T13:55:53.780073Z","end":"2026-04-22T13:55:53.994844Z","steps":["trace[1507704382] 'agreement among raft nodes before linearized reading' (duration: 214.465141ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:55:54.16086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.768732ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:55:54.160975Z","caller":"traceutil/trace.go:171","msg":"trace[1664076067] transaction","detail":"{read_only:false; response_revision:613; number_of_response:1; }","duration":"161.761237ms","start":"2026-04-22T13:55:53.999196Z","end":"2026-04-22T13:55:54.160957Z","steps":["trace[1664076067] 'process raft request' (duration: 28.346474ms)","trace[1664076067] 'compare' (duration: 132.646878ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:55:54.352577Z","caller":"traceutil/trace.go:171","msg":"trace[1890313668] transaction","detail":"{read_only:false; response_revision:614; number_of_response:1; }","duration":"342.137246ms","start":"2026-04-22T13:55:54.010417Z","end":"2026-04-22T13:55:54.352554Z","steps":["trace[1890313668] 'process raft request' (duration: 285.912196ms)","trace[1890313668] 'compare' (duration: 56.123368ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:55:54.352704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:55:54.010387Z","time spent":"342.251997ms","remote":"127.0.0.1:51254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T13:55:54.361649Z","caller":"traceutil/trace.go:171","msg":"trace[827204942] transaction","detail":"{read_only:false; response_revision:617; number_of_response:1; }","duration":"238.444482ms","start":"2026-04-22T13:55:54.12318Z","end":"2026-04-22T13:55:54.361624Z","steps":["trace[827204942] 'process raft request' (duration: 238.402142ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:55:54.361712Z","caller":"traceutil/trace.go:171","msg":"trace[1446454971] transaction","detail":"{read_only:false; response_revision:615; number_of_response:1; }","duration":"310.560332ms","start":"2026-04-22T13:55:54.051126Z","end":"2026-04-22T13:55:54.361686Z","steps":["trace[1446454971] 'process raft request' (duration: 310.273296ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:55:54.362326Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:55:54.051096Z","time spent":"311.163032ms","remote":"127.0.0.1:51606","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-22T13:55:54.361743Z","caller":"traceutil/trace.go:171","msg":"trace[1806313379] transaction","detail":"{read_only:false; response_revision:616; number_of_response:1; }","duration":"250.804936ms","start":"2026-04-22T13:55:54.110905Z","end":"2026-04-22T13:55:54.36171Z","steps":["trace[1806313379] 'process raft request' (duration: 250.623403ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:55:54.648858Z","caller":"traceutil/trace.go:171","msg":"trace[712735408] linearizableReadLoop","detail":"{readStateIndex:642; appliedIndex:641; }","duration":"100.548274ms","start":"2026-04-22T13:55:54.548291Z","end":"2026-04-22T13:55:54.64884Z","steps":["trace[712735408] 'read index received' (duration: 95.853506ms)","trace[712735408] 'applied index is now lower than readState.Index' (duration: 4.694068ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:55:54.64894Z","caller":"traceutil/trace.go:171","msg":"trace[1916343724] transaction","detail":"{read_only:false; response_revision:618; number_of_response:1; }","duration":"261.71806ms","start":"2026-04-22T13:55:54.387187Z","end":"2026-04-22T13:55:54.648905Z","steps":["trace[1916343724] 'process raft request' (duration: 257.053203ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:55:54.649008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.697838ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:55:54.649033Z","caller":"traceutil/trace.go:171","msg":"trace[2093952042] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:618; }","duration":"100.776839ms","start":"2026-04-22T13:55:54.54825Z","end":"2026-04-22T13:55:54.649026Z","steps":["trace[2093952042] 'agreement among raft nodes before linearized reading' (duration: 100.660275ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:55:54.820955Z","caller":"traceutil/trace.go:171","msg":"trace[1373887828] transaction","detail":"{read_only:false; response_revision:619; number_of_response:1; }","duration":"167.601497ms","start":"2026-04-22T13:55:54.653301Z","end":"2026-04-22T13:55:54.820903Z","steps":["trace[1373887828] 'process raft request' (duration: 167.001246ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:55:56.042992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.765879ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:55:56.043116Z","caller":"traceutil/trace.go:171","msg":"trace[348529285] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:0; response_revision:634; }","duration":"100.929652ms","start":"2026-04-22T13:55:55.942162Z","end":"2026-04-22T13:55:56.043092Z","steps":["trace[348529285] 'range keys from in-memory index tree' (duration: 100.669577ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:56:12.940697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.442285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-22T13:56:12.940785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.162785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T13:56:12.940848Z","caller":"traceutil/trace.go:171","msg":"trace[1807042045] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:786; }","duration":"161.636388ms","start":"2026-04-22T13:56:12.779187Z","end":"2026-04-22T13:56:12.940823Z","steps":["trace[1807042045] 'range keys from in-memory index tree' (duration: 161.333172ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:56:12.940874Z","caller":"traceutil/trace.go:171","msg":"trace[371164067] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:786; }","duration":"204.285726ms","start":"2026-04-22T13:56:12.736564Z","end":"2026-04-22T13:56:12.94085Z","steps":["trace[371164067] 'range keys from in-memory index tree' (duration: 203.997481ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:56:39.945291Z","caller":"traceutil/trace.go:171","msg":"trace[1916827822] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"129.875712ms","start":"2026-04-22T13:56:39.815387Z","end":"2026-04-22T13:56:39.945262Z","steps":["trace[1916827822] 'process raft request' (duration: 129.622348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:57:01.354932Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.545298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:57:01.355017Z","caller":"traceutil/trace.go:171","msg":"trace[526285569] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:1428; }","duration":"104.714231ms","start":"2026-04-22T13:57:01.250288Z","end":"2026-04-22T13:57:01.355002Z","steps":["trace[526285569] 'count revisions from in-memory index tree' (duration: 104.464127ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:23.667624Z","caller":"traceutil/trace.go:171","msg":"trace[637660656] linearizableReadLoop","detail":"{readStateIndex:1904; appliedIndex:1903; }","duration":"356.174181ms","start":"2026-04-22T13:57:23.311426Z","end":"2026-04-22T13:57:23.6676Z","steps":["trace[637660656] 'read index received' (duration: 356.107309ms)","trace[637660656] 'applied index is now lower than readState.Index' (duration: 66.132µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:57:23.667806Z","caller":"traceutil/trace.go:171","msg":"trace[161104118] transaction","detail":"{read_only:false; response_revision:1833; number_of_response:1; }","duration":"374.788791ms","start":"2026-04-22T13:57:23.292997Z","end":"2026-04-22T13:57:23.667786Z","steps":["trace[161104118] 'process raft request' (duration: 374.447355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:57:23.667876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"356.433505ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-22T13:57:23.667914Z","caller":"traceutil/trace.go:171","msg":"trace[1627041762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1833; }","duration":"356.544008ms","start":"2026-04-22T13:57:23.31136Z","end":"2026-04-22T13:57:23.667904Z","steps":["trace[1627041762] 'agreement among raft nodes before linearized reading' (duration: 356.367244ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:57:23.667933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:57:23.29295Z","time spent":"374.913705ms","remote":"127.0.0.1:51254","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10969,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T13:57:23.667949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:57:23.311318Z","time spent":"356.62386ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-04-22T13:57:23.674111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.011875ms","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:5"} {"level":"info","ts":"2026-04-22T13:57:23.674218Z","caller":"traceutil/trace.go:171","msg":"trace[2042874041] range","detail":"{range_begin:/registry/cilium.io/ciliumexternalworkloads/; range_end:/registry/cilium.io/ciliumexternalworkloads0; response_count:0; response_revision:1834; }","duration":"290.139068ms","start":"2026-04-22T13:57:23.384056Z","end":"2026-04-22T13:57:23.674195Z","steps":["trace[2042874041] 'agreement among raft nodes before linearized reading' (duration: 289.922314ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:57:23.674241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.307635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9928b399-6716-4098-b833-150b095f293b\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-04-22T13:57:23.674547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.445104ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-04-22T13:57:23.674612Z","caller":"traceutil/trace.go:171","msg":"trace[831686504] transaction","detail":"{read_only:false; response_revision:1834; number_of_response:1; }","duration":"296.64962ms","start":"2026-04-22T13:57:23.377944Z","end":"2026-04-22T13:57:23.674594Z","steps":["trace[831686504] 'process raft request' (duration: 295.851015ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:23.674627Z","caller":"traceutil/trace.go:171","msg":"trace[1756758245] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1834; }","duration":"359.80286ms","start":"2026-04-22T13:57:23.314807Z","end":"2026-04-22T13:57:23.674609Z","steps":["trace[1756758245] 'agreement among raft nodes before linearized reading' (duration: 359.388113ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:23.674636Z","caller":"traceutil/trace.go:171","msg":"trace[2037322715] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9928b399-6716-4098-b833-150b095f293b; range_end:; response_count:1; response_revision:1834; }","duration":"329.740083ms","start":"2026-04-22T13:57:23.344848Z","end":"2026-04-22T13:57:23.674588Z","steps":["trace[2037322715] 'agreement among raft nodes before linearized reading' (duration: 329.138112ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:57:23.674808Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:57:23.344824Z","time spent":"329.929417ms","remote":"127.0.0.1:51254","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9928b399-6716-4098-b833-150b095f293b\" "} {"level":"warn","ts":"2026-04-22T13:57:23.674679Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T13:57:23.314783Z","time spent":"359.882401ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":501,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-04-22T13:57:23.796808Z","caller":"traceutil/trace.go:171","msg":"trace[731341795] transaction","detail":"{read_only:false; response_revision:1835; number_of_response:1; }","duration":"123.992607ms","start":"2026-04-22T13:57:23.672776Z","end":"2026-04-22T13:57:23.796769Z","steps":["trace[731341795] 'process raft request' (duration: 49.089966ms)","trace[731341795] 'compare' (duration: 74.623135ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:57:23.797476Z","caller":"traceutil/trace.go:171","msg":"trace[1834359452] transaction","detail":"{read_only:false; response_revision:1836; number_of_response:1; }","duration":"124.499237ms","start":"2026-04-22T13:57:23.672946Z","end":"2026-04-22T13:57:23.797445Z","steps":["trace[1834359452] 'process raft request' (duration: 123.738582ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:23.79751Z","caller":"traceutil/trace.go:171","msg":"trace[1215743648] transaction","detail":"{read_only:false; response_revision:1837; number_of_response:1; }","duration":"124.087509ms","start":"2026-04-22T13:57:23.673403Z","end":"2026-04-22T13:57:23.797491Z","steps":["trace[1215743648] 'process raft request' (duration: 123.921826ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:23.797666Z","caller":"traceutil/trace.go:171","msg":"trace[499938441] transaction","detail":"{read_only:false; response_revision:1838; number_of_response:1; }","duration":"124.1905ms","start":"2026-04-22T13:57:23.673453Z","end":"2026-04-22T13:57:23.797644Z","steps":["trace[499938441] 'process raft request' (duration: 123.941426ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:23.797949Z","caller":"traceutil/trace.go:171","msg":"trace[1522587593] linearizableReadLoop","detail":"{readStateIndex:1910; appliedIndex:1905; }","duration":"123.976286ms","start":"2026-04-22T13:57:23.673955Z","end":"2026-04-22T13:57:23.797931Z","steps":["trace[1522587593] 'read index received' (duration: 47.929843ms)","trace[1522587593] 'applied index is now lower than readState.Index' (duration: 76.045303ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:57:23.797991Z","caller":"traceutil/trace.go:171","msg":"trace[1429498380] transaction","detail":"{read_only:false; response_revision:1839; number_of_response:1; }","duration":"124.372543ms","start":"2026-04-22T13:57:23.673597Z","end":"2026-04-22T13:57:23.797969Z","steps":["trace[1429498380] 'process raft request' (duration: 124.265951ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:57:23.798222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.31288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-9928b399-6716-4098-b833-150b095f293b\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-22T13:57:23.798287Z","caller":"traceutil/trace.go:171","msg":"trace[1257294319] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-9928b399-6716-4098-b833-150b095f293b; range_end:; response_count:1; response_revision:1839; }","duration":"126.429322ms","start":"2026-04-22T13:57:23.671839Z","end":"2026-04-22T13:57:23.798268Z","steps":["trace[1257294319] 'agreement among raft nodes before linearized reading' (duration: 126.215058ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:23.88398Z","caller":"traceutil/trace.go:171","msg":"trace[2124984506] transaction","detail":"{read_only:false; response_revision:1840; number_of_response:1; }","duration":"206.091574ms","start":"2026-04-22T13:57:23.677861Z","end":"2026-04-22T13:57:23.883952Z","steps":["trace[2124984506] 'process raft request' (duration: 205.935171ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:57:24.042525Z","caller":"traceutil/trace.go:171","msg":"trace[1482616630] transaction","detail":"{read_only:false; response_revision:1841; number_of_response:1; }","duration":"235.07083ms","start":"2026-04-22T13:57:23.807424Z","end":"2026-04-22T13:57:24.042495Z","steps":["trace[1482616630] 'process raft request' (duration: 232.43176ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:58:07.425245Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.220327ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12382"} {"level":"info","ts":"2026-04-22T13:58:07.425309Z","caller":"traceutil/trace.go:171","msg":"trace[1018202905] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2127; }","duration":"127.34669ms","start":"2026-04-22T13:58:07.29795Z","end":"2026-04-22T13:58:07.425296Z","steps":["trace[1018202905] 'range keys from in-memory index tree' (duration: 127.004584ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:58:13.084919Z","caller":"traceutil/trace.go:171","msg":"trace[1651000400] transaction","detail":"{read_only:false; response_revision:2157; number_of_response:1; }","duration":"104.952208ms","start":"2026-04-22T13:58:12.979941Z","end":"2026-04-22T13:58:13.084893Z","steps":["trace[1651000400] 'process raft request' (duration: 104.792065ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:58:13.691188Z","caller":"traceutil/trace.go:171","msg":"trace[292861098] transaction","detail":"{read_only:false; response_revision:2159; number_of_response:1; }","duration":"203.521004ms","start":"2026-04-22T13:58:13.487633Z","end":"2026-04-22T13:58:13.691154Z","steps":["trace[292861098] 'process raft request' (duration: 138.983208ms)","trace[292861098] 'compare' (duration: 64.431614ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:06.739443Z","caller":"traceutil/trace.go:171","msg":"trace[2125895288] linearizableReadLoop","detail":"{readStateIndex:2717; appliedIndex:2716; }","duration":"106.513734ms","start":"2026-04-22T13:59:06.632903Z","end":"2026-04-22T13:59:06.739416Z","steps":["trace[2125895288] 'read index received' (duration: 106.28531ms)","trace[2125895288] 'applied index is now lower than readState.Index' (duration: 227.344µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:06.739497Z","caller":"traceutil/trace.go:171","msg":"trace[2066395357] transaction","detail":"{read_only:false; response_revision:2618; number_of_response:1; }","duration":"161.092066ms","start":"2026-04-22T13:59:06.578375Z","end":"2026-04-22T13:59:06.739467Z","steps":["trace[2066395357] 'process raft request' (duration: 160.837411ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:06.739721Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.807189ms","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-04-22T13:59:06.739765Z","caller":"traceutil/trace.go:171","msg":"trace[1058496830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2618; }","duration":"106.902291ms","start":"2026-04-22T13:59:06.632851Z","end":"2026-04-22T13:59:06.739754Z","steps":["trace[1058496830] 'agreement among raft nodes before linearized reading' (duration: 106.721158ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T13:59:40.379023Z","caller":"traceutil/trace.go:171","msg":"trace[1985627349] linearizableReadLoop","detail":"{readStateIndex:2927; appliedIndex:2926; }","duration":"103.295879ms","start":"2026-04-22T13:59:40.275688Z","end":"2026-04-22T13:59:40.378984Z","steps":["trace[1985627349] 'read index received' (duration: 103.056505ms)","trace[1985627349] 'applied index is now lower than readState.Index' (duration: 237.864µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:40.379095Z","caller":"traceutil/trace.go:171","msg":"trace[517555743] transaction","detail":"{read_only:false; response_revision:2820; number_of_response:1; }","duration":"117.804043ms","start":"2026-04-22T13:59:40.261224Z","end":"2026-04-22T13:59:40.379028Z","steps":["trace[517555743] 'process raft request' (duration: 117.521518ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:40.379527Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.766789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csistoragecapacities/\" range_end:\"/registry/csistoragecapacities0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T13:59:40.379642Z","caller":"traceutil/trace.go:171","msg":"trace[1289377508] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:2820; }","duration":"103.989432ms","start":"2026-04-22T13:59:40.275629Z","end":"2026-04-22T13:59:40.379618Z","steps":["trace[1289377508] 'agreement among raft nodes before linearized reading' (duration: 103.472612ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T13:59:40.62346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.467083ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T13:59:40.623584Z","caller":"traceutil/trace.go:171","msg":"trace[1338819692] linearizableReadLoop","detail":"{readStateIndex:2928; appliedIndex:2927; }","duration":"143.130631ms","start":"2026-04-22T13:59:40.480431Z","end":"2026-04-22T13:59:40.623562Z","steps":["trace[1338819692] 'read index received' (duration: 31.365982ms)","trace[1338819692] 'applied index is now lower than readState.Index' (duration: 111.762859ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T13:59:40.623689Z","caller":"traceutil/trace.go:171","msg":"trace[752367183] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"163.597679ms","start":"2026-04-22T13:59:40.46005Z","end":"2026-04-22T13:59:40.623648Z","steps":["trace[752367183] 'process raft request' (duration: 51.829509ms)","trace[752367183] 'compare' (duration: 111.31496ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T13:59:40.623808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.348496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-22T13:59:40.623866Z","caller":"traceutil/trace.go:171","msg":"trace[1779823663] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:2821; }","duration":"143.472498ms","start":"2026-04-22T13:59:40.480378Z","end":"2026-04-22T13:59:40.62385Z","steps":["trace[1779823663] 'agreement among raft nodes before linearized reading' (duration: 143.263115ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:03:33.495815Z","caller":"traceutil/trace.go:171","msg":"trace[1893436225] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"168.389956ms","start":"2026-04-22T14:03:33.327386Z","end":"2026-04-22T14:03:33.495776Z","steps":["trace[1893436225] 'process raft request' (duration: 78.843728ms)","trace[1893436225] 'compare' (duration: 89.371945ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:03:33.687586Z","caller":"traceutil/trace.go:171","msg":"trace[359728509] transaction","detail":"{read_only:false; response_revision:5027; number_of_response:1; }","duration":"180.092967ms","start":"2026-04-22T14:03:33.507451Z","end":"2026-04-22T14:03:33.687544Z","steps":["trace[359728509] 'process raft request' (duration: 157.083882ms)","trace[359728509] 'compare' (duration: 22.445464ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:03:33.687766Z","caller":"traceutil/trace.go:171","msg":"trace[474898558] linearizableReadLoop","detail":"{readStateIndex:5217; appliedIndex:5216; }","duration":"132.0006ms","start":"2026-04-22T14:03:33.555731Z","end":"2026-04-22T14:03:33.687732Z","steps":["trace[474898558] 'read index received' (duration: 108.704171ms)","trace[474898558] 'applied index is now lower than readState.Index' (duration: 23.294319ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:03:33.688159Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.410658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-814c6737-d420-42b0-881d-b57da61d2cf0\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-04-22T14:03:33.688218Z","caller":"traceutil/trace.go:171","msg":"trace[1409241750] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-814c6737-d420-42b0-881d-b57da61d2cf0; range_end:; response_count:1; response_revision:5027; }","duration":"132.575411ms","start":"2026-04-22T14:03:33.555626Z","end":"2026-04-22T14:03:33.688201Z","steps":["trace[1409241750] 'agreement among raft nodes before linearized reading' (duration: 132.234724ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:03:43.294075Z","caller":"traceutil/trace.go:171","msg":"trace[1558189137] linearizableReadLoop","detail":"{readStateIndex:5411; appliedIndex:5410; }","duration":"141.363736ms","start":"2026-04-22T14:03:43.152683Z","end":"2026-04-22T14:03:43.294047Z","steps":["trace[1558189137] 'read index received' (duration: 141.05969ms)","trace[1558189137] 'applied index is now lower than readState.Index' (duration: 302.786µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:03:43.294114Z","caller":"traceutil/trace.go:171","msg":"trace[2137572671] transaction","detail":"{read_only:false; response_revision:5215; number_of_response:1; }","duration":"191.021865ms","start":"2026-04-22T14:03:43.103064Z","end":"2026-04-22T14:03:43.294086Z","steps":["trace[2137572671] 'process raft request' (duration: 190.74803ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:03:43.294241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.533409ms","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":"info","ts":"2026-04-22T14:03:43.294282Z","caller":"traceutil/trace.go:171","msg":"trace[1610023972] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5215; }","duration":"141.624491ms","start":"2026-04-22T14:03:43.152644Z","end":"2026-04-22T14:03:43.294269Z","steps":["trace[1610023972] 'agreement among raft nodes before linearized reading' (duration: 141.519229ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:03:51.437472Z","caller":"traceutil/trace.go:171","msg":"trace[1153576063] transaction","detail":"{read_only:false; response_revision:5395; number_of_response:1; }","duration":"112.23462ms","start":"2026-04-22T14:03:51.325206Z","end":"2026-04-22T14:03:51.437441Z","steps":["trace[1153576063] 'process raft request' (duration: 111.964785ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:03:53.709369Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.943284ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0\" ","response":"range_response_count:1 size:1342"} {"level":"info","ts":"2026-04-22T14:03:53.709454Z","caller":"traceutil/trace.go:171","msg":"trace[504968623] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-tls-assets-0; range_end:; response_count:1; response_revision:5450; }","duration":"128.085246ms","start":"2026-04-22T14:03:53.581348Z","end":"2026-04-22T14:03:53.709433Z","steps":["trace[504968623] 'range keys from in-memory index tree' (duration: 127.774951ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:05:18.890887Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3031} {"level":"info","ts":"2026-04-22T14:05:18.974767Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3031,"took":"81.810802ms","hash":891427993,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":32018432,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-22T14:05:18.97484Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":891427993,"revision":3031,"compact-revision":-1} {"level":"info","ts":"2026-04-22T14:10:01.23991Z","caller":"traceutil/trace.go:171","msg":"trace[1427322971] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"133.385156ms","start":"2026-04-22T14:10:01.106503Z","end":"2026-04-22T14:10:01.239888Z","steps":["trace[1427322971] 'process raft request' (duration: 133.238814ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:10:12.615207Z","caller":"traceutil/trace.go:171","msg":"trace[2077952029] linearizableReadLoop","detail":"{readStateIndex:8613; appliedIndex:8612; }","duration":"139.724391ms","start":"2026-04-22T14:10:12.475462Z","end":"2026-04-22T14:10:12.615186Z","steps":["trace[2077952029] 'read index received' (duration: 139.594788ms)","trace[2077952029] 'applied index is now lower than readState.Index' (duration: 128.883µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:10:12.615248Z","caller":"traceutil/trace.go:171","msg":"trace[1058692720] transaction","detail":"{read_only:false; response_revision:8320; number_of_response:1; }","duration":"142.286889ms","start":"2026-04-22T14:10:12.472939Z","end":"2026-04-22T14:10:12.615226Z","steps":["trace[1058692720] 'process raft request' (duration: 142.115355ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:10:12.615412Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.925304ms","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-04-22T14:10:12.61545Z","caller":"traceutil/trace.go:171","msg":"trace[612665527] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8320; }","duration":"139.992126ms","start":"2026-04-22T14:10:12.475448Z","end":"2026-04-22T14:10:12.61544Z","steps":["trace[612665527] 'agreement among raft nodes before linearized reading' (duration: 139.832413ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:10:13.393733Z","caller":"traceutil/trace.go:171","msg":"trace[922883696] transaction","detail":"{read_only:false; response_revision:8325; number_of_response:1; }","duration":"118.155824ms","start":"2026-04-22T14:10:13.275547Z","end":"2026-04-22T14:10:13.393703Z","steps":["trace[922883696] 'process raft request' (duration: 117.94345ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:10:18.898079Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6188} {"level":"info","ts":"2026-04-22T14:10:18.994704Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6188,"took":"94.453377ms","hash":4273447770,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":23339008,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-22T14:10:18.994785Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4273447770,"revision":6188,"compact-revision":3031} {"level":"info","ts":"2026-04-22T14:10:41.341946Z","caller":"traceutil/trace.go:171","msg":"trace[590066154] transaction","detail":"{read_only:false; response_revision:8528; number_of_response:1; }","duration":"425.575731ms","start":"2026-04-22T14:10:40.916351Z","end":"2026-04-22T14:10:41.341927Z","steps":["trace[590066154] 'process raft request' (duration: 425.474019ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:10:41.342067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:10:40.916329Z","time spent":"425.679623ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:10:44.883889Z","caller":"traceutil/trace.go:171","msg":"trace[577415717] transaction","detail":"{read_only:false; response_revision:8547; number_of_response:1; }","duration":"102.129863ms","start":"2026-04-22T14:10:44.781729Z","end":"2026-04-22T14:10:44.883858Z","steps":["trace[577415717] 'process raft request' (duration: 101.95712ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:10:54.037704Z","caller":"traceutil/trace.go:171","msg":"trace[677677229] transaction","detail":"{read_only:false; response_revision:8635; number_of_response:1; }","duration":"101.140085ms","start":"2026-04-22T14:10:53.936538Z","end":"2026-04-22T14:10:54.037678Z","steps":["trace[677677229] 'process raft request' (duration: 100.979332ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:10:54.06864Z","caller":"traceutil/trace.go:171","msg":"trace[1053649671] transaction","detail":"{read_only:false; response_revision:8636; number_of_response:1; }","duration":"123.769321ms","start":"2026-04-22T14:10:53.944844Z","end":"2026-04-22T14:10:54.068614Z","steps":["trace[1053649671] 'process raft request' (duration: 123.552157ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:10:54.06889Z","caller":"traceutil/trace.go:171","msg":"trace[613999398] transaction","detail":"{read_only:false; response_revision:8637; number_of_response:1; }","duration":"115.872701ms","start":"2026-04-22T14:10:53.95298Z","end":"2026-04-22T14:10:54.068852Z","steps":["trace[613999398] 'process raft request' (duration: 115.569125ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:11:26.464062Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000243e.wal"} {"level":"info","ts":"2026-04-22T14:12:47.011628Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"93eaf76b69bfff2c","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T14:12:47.017809Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-22T14:12:47.017911Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-22T14:15:18.904907Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8362} {"level":"info","ts":"2026-04-22T14:15:18.985396Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8362,"took":"78.017613ms","hash":1280823734,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":25485312,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-04-22T14:15:18.985477Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1280823734,"revision":8362,"compact-revision":6188} {"level":"warn","ts":"2026-04-22T14:15:56.991784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.899483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T14:15:56.991895Z","caller":"traceutil/trace.go:171","msg":"trace[404584519] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11251; }","duration":"212.098586ms","start":"2026-04-22T14:15:56.779774Z","end":"2026-04-22T14:15:56.991873Z","steps":["trace[404584519] 'range keys from in-memory index tree' (duration: 211.801631ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:15:56.992123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.036562ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-04-22T14:15:56.992198Z","caller":"traceutil/trace.go:171","msg":"trace[1280675028] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11251; }","duration":"158.153625ms","start":"2026-04-22T14:15:56.834027Z","end":"2026-04-22T14:15:56.99218Z","steps":["trace[1280675028] 'range keys from in-memory index tree' (duration: 157.464492ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:15:57.745888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.40728ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-04-22T14:15:57.745985Z","caller":"traceutil/trace.go:171","msg":"trace[689750624] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:11253; }","duration":"141.561213ms","start":"2026-04-22T14:15:57.604403Z","end":"2026-04-22T14:15:57.745965Z","steps":["trace[689750624] 'range keys from in-memory index tree' (duration: 141.169446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:15:57.746009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.403458ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-22T14:15:57.746097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.831365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-04-22T14:15:57.746169Z","caller":"traceutil/trace.go:171","msg":"trace[345361822] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:11253; }","duration":"215.605102ms","start":"2026-04-22T14:15:57.53052Z","end":"2026-04-22T14:15:57.746125Z","steps":["trace[345361822] 'count revisions from in-memory index tree' (duration: 215.295657ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:15:57.746186Z","caller":"traceutil/trace.go:171","msg":"trace[1898759693] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:11253; }","duration":"183.958388ms","start":"2026-04-22T14:15:57.562209Z","end":"2026-04-22T14:15:57.746167Z","steps":["trace[1898759693] 'range keys from in-memory index tree' (duration: 183.641092ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:20:18.911543Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10852} {"level":"info","ts":"2026-04-22T14:20:18.992318Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10852,"took":"78.540798ms","hash":2801456915,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":28061696,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-04-22T14:20:18.992374Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2801456915,"revision":10852,"compact-revision":8362} {"level":"info","ts":"2026-04-22T14:21:50.383842Z","caller":"traceutil/trace.go:171","msg":"trace[2145399677] transaction","detail":"{read_only:false; response_revision:13660; number_of_response:1; }","duration":"119.258679ms","start":"2026-04-22T14:21:50.264559Z","end":"2026-04-22T14:21:50.383818Z","steps":["trace[2145399677] 'process raft request' (duration: 118.77853ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:22:24.99063Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.905764ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T14:22:24.990839Z","caller":"traceutil/trace.go:171","msg":"trace[584097952] transaction","detail":"{read_only:false; response_revision:13861; number_of_response:1; }","duration":"322.764782ms","start":"2026-04-22T14:22:24.668044Z","end":"2026-04-22T14:22:24.990809Z","steps":["trace[584097952] 'process raft request' (duration: 76.592173ms)","trace[584097952] 'compare' (duration: 245.542466ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:22:24.990908Z","caller":"traceutil/trace.go:171","msg":"trace[2297271] linearizableReadLoop","detail":"{readStateIndex:14336; appliedIndex:14335; }","duration":"211.204454ms","start":"2026-04-22T14:22:24.779693Z","end":"2026-04-22T14:22:24.990897Z","steps":["trace[2297271] 'read index received' (duration: 48.07µs)","trace[2297271] 'applied index is now lower than readState.Index' (duration: 211.155644ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:22:24.990996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.300817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-22T14:22:24.991027Z","caller":"traceutil/trace.go:171","msg":"trace[369950872] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13862; }","duration":"211.371287ms","start":"2026-04-22T14:22:24.779648Z","end":"2026-04-22T14:22:24.991019Z","steps":["trace[369950872] 'agreement among raft nodes before linearized reading' (duration: 211.293716ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:22:24.991012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:22:24.668017Z","time spent":"322.898095ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:22:24.990867Z","caller":"traceutil/trace.go:171","msg":"trace[895801747] transaction","detail":"{read_only:false; response_revision:13862; number_of_response:1; }","duration":"180.108151ms","start":"2026-04-22T14:22:24.810741Z","end":"2026-04-22T14:22:24.990849Z","steps":["trace[895801747] 'process raft request' (duration: 180.01336ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:22:34.372281Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.000958ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-22T14:22:34.372402Z","caller":"traceutil/trace.go:171","msg":"trace[809122019] linearizableReadLoop","detail":"{readStateIndex:14507; appliedIndex:14505; }","duration":"275.937918ms","start":"2026-04-22T14:22:34.096443Z","end":"2026-04-22T14:22:34.372381Z","steps":["trace[809122019] 'read index received' (duration: 26.836556ms)","trace[809122019] 'applied index is now lower than readState.Index' (duration: 249.099522ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:22:34.372682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.239864ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-wpxz4\" ","response":"range_response_count:1 size:6441"} {"level":"info","ts":"2026-04-22T14:22:34.372728Z","caller":"traceutil/trace.go:171","msg":"trace[262731764] range","detail":"{range_begin:/registry/pods/openstack/keepalived-wpxz4; range_end:; response_count:1; response_revision:14029; }","duration":"276.329515ms","start":"2026-04-22T14:22:34.096385Z","end":"2026-04-22T14:22:34.372715Z","steps":["trace[262731764] 'agreement among raft nodes before linearized reading' (duration: 276.075591ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:22:34.372974Z","caller":"traceutil/trace.go:171","msg":"trace[836086578] transaction","detail":"{read_only:false; response_revision:14029; number_of_response:1; }","duration":"296.166301ms","start":"2026-04-22T14:22:34.076733Z","end":"2026-04-22T14:22:34.3729Z","steps":["trace[836086578] 'process raft request' (duration: 153.442309ms)","trace[836086578] 'compare' (duration: 141.534329ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:24:14.388988Z","caller":"traceutil/trace.go:171","msg":"trace[1617285189] transaction","detail":"{read_only:false; response_revision:15111; number_of_response:1; }","duration":"140.284101ms","start":"2026-04-22T14:24:14.24868Z","end":"2026-04-22T14:24:14.388964Z","steps":["trace[1617285189] 'process raft request' (duration: 136.224735ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:25:18.917931Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":13049} {"level":"info","ts":"2026-04-22T14:25:19.004261Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":13049,"took":"82.892325ms","hash":1618473454,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":31047680,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-22T14:25:19.004324Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1618473454,"revision":13049,"compact-revision":10852} {"level":"info","ts":"2026-04-22T14:29:59.239672Z","caller":"traceutil/trace.go:171","msg":"trace[2002073577] linearizableReadLoop","detail":"{readStateIndex:18352; appliedIndex:18351; }","duration":"105.293324ms","start":"2026-04-22T14:29:59.134359Z","end":"2026-04-22T14:29:59.239652Z","steps":["trace[2002073577] 'read index received' (duration: 105.075289ms)","trace[2002073577] 'applied index is now lower than readState.Index' (duration: 217.265µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:29:59.239874Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.505658ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:3299"} {"level":"info","ts":"2026-04-22T14:29:59.239906Z","caller":"traceutil/trace.go:171","msg":"trace[1956546238] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:17755; }","duration":"105.5898ms","start":"2026-04-22T14:29:59.134307Z","end":"2026-04-22T14:29:59.239896Z","steps":["trace[1956546238] 'agreement among raft nodes before linearized reading' (duration: 105.440527ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:29:59.240057Z","caller":"traceutil/trace.go:171","msg":"trace[377993179] transaction","detail":"{read_only:false; response_revision:17755; number_of_response:1; }","duration":"164.839654ms","start":"2026-04-22T14:29:59.075196Z","end":"2026-04-22T14:29:59.240036Z","steps":["trace[377993179] 'process raft request' (duration: 164.298193ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:29:59.926397Z","caller":"traceutil/trace.go:171","msg":"trace[297195306] linearizableReadLoop","detail":"{readStateIndex:18353; appliedIndex:18352; }","duration":"148.064242ms","start":"2026-04-22T14:29:59.778308Z","end":"2026-04-22T14:29:59.926372Z","steps":["trace[297195306] 'read index received' (duration: 147.871978ms)","trace[297195306] 'applied index is now lower than readState.Index' (duration: 190.564µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:29:59.926436Z","caller":"traceutil/trace.go:171","msg":"trace[641856318] transaction","detail":"{read_only:false; response_revision:17756; number_of_response:1; }","duration":"176.001672ms","start":"2026-04-22T14:29:59.750408Z","end":"2026-04-22T14:29:59.92641Z","steps":["trace[641856318] 'process raft request' (duration: 175.786168ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:29:59.926587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.268635ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:29:59.92667Z","caller":"traceutil/trace.go:171","msg":"trace[177005932] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17756; }","duration":"148.391338ms","start":"2026-04-22T14:29:59.778262Z","end":"2026-04-22T14:29:59.926653Z","steps":["trace[177005932] 'agreement among raft nodes before linearized reading' (duration: 148.257775ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:30:18.924715Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15538} {"level":"info","ts":"2026-04-22T14:30:19.018383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15538,"took":"89.881557ms","hash":3601647470,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":32841728,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-04-22T14:30:19.018478Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3601647470,"revision":15538,"compact-revision":13049} {"level":"info","ts":"2026-04-22T14:33:18.680339Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"93eaf76b69bfff2c","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T14:33:18.686652Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-04-22T14:33:18.686812Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-04-22T14:35:01.178901Z","caller":"traceutil/trace.go:171","msg":"trace[1036505694] transaction","detail":"{read_only:false; response_revision:20094; number_of_response:1; }","duration":"128.383569ms","start":"2026-04-22T14:35:01.050489Z","end":"2026-04-22T14:35:01.178872Z","steps":["trace[1036505694] 'process raft request' (duration: 128.289457ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:35:01.179004Z","caller":"traceutil/trace.go:171","msg":"trace[837023700] linearizableReadLoop","detail":"{readStateIndex:20768; appliedIndex:20767; }","duration":"140.821101ms","start":"2026-04-22T14:35:01.038161Z","end":"2026-04-22T14:35:01.178982Z","steps":["trace[837023700] 'read index received' (duration: 95.601969ms)","trace[837023700] 'applied index is now lower than readState.Index' (duration: 45.217612ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:35:01.179336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.152227ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-user\" ","response":"range_response_count:1 size:11092"} {"level":"info","ts":"2026-04-22T14:35:01.179407Z","caller":"traceutil/trace.go:171","msg":"trace[1657826321] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-user; range_end:; response_count:1; response_revision:20094; }","duration":"141.262859ms","start":"2026-04-22T14:35:01.038127Z","end":"2026-04-22T14:35:01.17939Z","steps":["trace[1657826321] 'agreement among raft nodes before linearized reading' (duration: 140.988464ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:35:01.179392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.238621ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-db-sync\" ","response":"range_response_count:1 size:5054"} {"level":"warn","ts":"2026-04-22T14:35:01.179405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.074896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-domain-ks-user\" ","response":"range_response_count:1 size:7489"} {"level":"warn","ts":"2026-04-22T14:35:01.179427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.548197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/keystone-api\" ","response":"range_response_count:1 size:675"} {"level":"warn","ts":"2026-04-22T14:35:01.179427Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.182578ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/percona-xtradb-haproxy\" ","response":"range_response_count:1 size:1149"} {"level":"info","ts":"2026-04-22T14:35:01.179476Z","caller":"traceutil/trace.go:171","msg":"trace[1826779862] range","detail":"{range_begin:/registry/jobs/openstack/heat-db-sync; range_end:; response_count:1; response_revision:20094; }","duration":"139.368604ms","start":"2026-04-22T14:35:01.040085Z","end":"2026-04-22T14:35:01.179454Z","steps":["trace[1826779862] 'agreement among raft nodes before linearized reading' (duration: 139.135429ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:35:01.179481Z","caller":"traceutil/trace.go:171","msg":"trace[901594818] range","detail":"{range_begin:/registry/jobs/openstack/heat-domain-ks-user; range_end:; response_count:1; response_revision:20094; }","duration":"140.170668ms","start":"2026-04-22T14:35:01.039293Z","end":"2026-04-22T14:35:01.179464Z","steps":["trace[901594818] 'agreement among raft nodes before linearized reading' (duration: 139.916903ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:35:01.179507Z","caller":"traceutil/trace.go:171","msg":"trace[274189780] range","detail":"{range_begin:/registry/services/endpoints/openstack/keystone-api; range_end:; response_count:1; response_revision:20094; }","duration":"139.637268ms","start":"2026-04-22T14:35:01.039847Z","end":"2026-04-22T14:35:01.179485Z","steps":["trace[274189780] 'agreement among raft nodes before linearized reading' (duration: 139.399634ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:35:01.1794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.603418ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/rabbitmq-heat\" ","response":"range_response_count:1 size:894"} {"level":"info","ts":"2026-04-22T14:35:01.179517Z","caller":"traceutil/trace.go:171","msg":"trace[1739306840] range","detail":"{range_begin:/registry/services/endpoints/openstack/percona-xtradb-haproxy; range_end:; response_count:1; response_revision:20094; }","duration":"140.28897ms","start":"2026-04-22T14:35:01.039206Z","end":"2026-04-22T14:35:01.179495Z","steps":["trace[1739306840] 'agreement among raft nodes before linearized reading' (duration: 140.055846ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:35:01.179458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.26209ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/heat-ks-endpoints\" ","response":"range_response_count:1 size:21474"} {"level":"info","ts":"2026-04-22T14:35:01.179582Z","caller":"traceutil/trace.go:171","msg":"trace[1673928914] range","detail":"{range_begin:/registry/services/endpoints/openstack/rabbitmq-heat; range_end:; response_count:1; response_revision:20094; }","duration":"139.77342ms","start":"2026-04-22T14:35:01.039773Z","end":"2026-04-22T14:35:01.179547Z","steps":["trace[1673928914] 'agreement among raft nodes before linearized reading' (duration: 139.431964ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:35:01.178934Z","caller":"traceutil/trace.go:171","msg":"trace[709131193] transaction","detail":"{read_only:false; response_revision:20093; number_of_response:1; }","duration":"161.977643ms","start":"2026-04-22T14:35:01.016912Z","end":"2026-04-22T14:35:01.178889Z","steps":["trace[709131193] 'process raft request' (duration: 116.841213ms)","trace[709131193] 'compare' (duration: 44.813474ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:35:01.179677Z","caller":"traceutil/trace.go:171","msg":"trace[259561968] range","detail":"{range_begin:/registry/jobs/openstack/heat-ks-endpoints; range_end:; response_count:1; response_revision:20094; }","duration":"140.452383ms","start":"2026-04-22T14:35:01.039119Z","end":"2026-04-22T14:35:01.179572Z","steps":["trace[259561968] 'agreement among raft nodes before linearized reading' (duration: 140.070256ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:35:18.930687Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":18096} {"level":"info","ts":"2026-04-22T14:35:19.044082Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":18096,"took":"110.276812ms","hash":3030544992,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":30330880,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-22T14:35:19.044138Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3030544992,"revision":18096,"compact-revision":15538} {"level":"info","ts":"2026-04-22T14:35:25.504978Z","caller":"traceutil/trace.go:171","msg":"trace[1267764305] transaction","detail":"{read_only:false; response_revision:20238; number_of_response:1; }","duration":"219.257779ms","start":"2026-04-22T14:35:25.28569Z","end":"2026-04-22T14:35:25.504947Z","steps":["trace[1267764305] 'process raft request' (duration: 218.633877ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:35:25.76521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.286843ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:35:25.765309Z","caller":"traceutil/trace.go:171","msg":"trace[253097791] transaction","detail":"{read_only:false; response_revision:20239; number_of_response:1; }","duration":"205.046844ms","start":"2026-04-22T14:35:25.560243Z","end":"2026-04-22T14:35:25.76529Z","steps":["trace[253097791] 'process raft request' (duration: 59.606878ms)","trace[253097791] 'compare' (duration: 144.951657ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:35:25.95483Z","caller":"traceutil/trace.go:171","msg":"trace[20600497] transaction","detail":"{read_only:false; response_revision:20240; number_of_response:1; }","duration":"118.441263ms","start":"2026-04-22T14:35:25.836364Z","end":"2026-04-22T14:35:25.954805Z","steps":["trace[20600497] 'process raft request' (duration: 52.14949ms)","trace[20600497] 'compare' (duration: 65.656692ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:35:25.954927Z","caller":"traceutil/trace.go:171","msg":"trace[633008898] transaction","detail":"{read_only:false; response_revision:20241; number_of_response:1; }","duration":"106.621014ms","start":"2026-04-22T14:35:25.848277Z","end":"2026-04-22T14:35:25.954898Z","steps":["trace[633008898] 'process raft request' (duration: 106.028623ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:35:26.40808Z","caller":"traceutil/trace.go:171","msg":"trace[490217009] transaction","detail":"{read_only:false; response_revision:20243; number_of_response:1; }","duration":"448.217369ms","start":"2026-04-22T14:35:25.959833Z","end":"2026-04-22T14:35:26.40805Z","steps":["trace[490217009] 'process raft request' (duration: 448.060916ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:35:26.408255Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:35:25.959816Z","time spent":"448.359721ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:39:13.333965Z","caller":"traceutil/trace.go:171","msg":"trace[2073332723] transaction","detail":"{read_only:false; response_revision:22593; number_of_response:1; }","duration":"154.671437ms","start":"2026-04-22T14:39:13.179258Z","end":"2026-04-22T14:39:13.33393Z","steps":["trace[2073332723] 'process raft request' (duration: 154.377102ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:39:13.49441Z","caller":"traceutil/trace.go:171","msg":"trace[758417751] transaction","detail":"{read_only:false; response_revision:22594; number_of_response:1; }","duration":"110.759721ms","start":"2026-04-22T14:39:13.383556Z","end":"2026-04-22T14:39:13.494315Z","steps":["trace[758417751] 'process raft request' (duration: 109.862904ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:40:18.937842Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20202} {"level":"info","ts":"2026-04-22T14:40:19.039463Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20202,"took":"98.420081ms","hash":566544378,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":41680896,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-04-22T14:40:19.039516Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":566544378,"revision":20202,"compact-revision":18096} {"level":"info","ts":"2026-04-22T14:42:41.065979Z","caller":"traceutil/trace.go:171","msg":"trace[778267893] transaction","detail":"{read_only:false; response_revision:24712; number_of_response:1; }","duration":"139.847708ms","start":"2026-04-22T14:42:40.926089Z","end":"2026-04-22T14:42:41.065937Z","steps":["trace[778267893] 'process raft request' (duration: 139.602034ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:42:41.335596Z","caller":"traceutil/trace.go:171","msg":"trace[1384231958] transaction","detail":"{read_only:false; response_revision:24713; number_of_response:1; }","duration":"403.502195ms","start":"2026-04-22T14:42:40.932059Z","end":"2026-04-22T14:42:41.335562Z","steps":["trace[1384231958] 'process raft request' (duration: 403.290871ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:42:41.335776Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:42:40.932041Z","time spent":"403.636417ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:42:41.505783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.889337ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:42:41.505994Z","caller":"traceutil/trace.go:171","msg":"trace[2125683434] linearizableReadLoop","detail":"{readStateIndex:25526; appliedIndex:25523; }","duration":"303.185053ms","start":"2026-04-22T14:42:41.20279Z","end":"2026-04-22T14:42:41.505975Z","steps":["trace[2125683434] 'read index received' (duration: 132.583802ms)","trace[2125683434] 'applied index is now lower than readState.Index' (duration: 170.597531ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:42:41.506292Z","caller":"traceutil/trace.go:171","msg":"trace[1224309713] transaction","detail":"{read_only:false; response_revision:24714; number_of_response:1; }","duration":"373.369813ms","start":"2026-04-22T14:42:41.132907Z","end":"2026-04-22T14:42:41.506277Z","steps":["trace[1224309713] 'process raft request' (duration: 260.885986ms)","trace[1224309713] 'compare' (duration: 111.663252ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:42:41.506367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:42:41.132868Z","time spent":"373.462454ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:42:41.507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.215534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-04-22T14:42:41.507047Z","caller":"traceutil/trace.go:171","msg":"trace[1286773663] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:24715; }","duration":"304.334636ms","start":"2026-04-22T14:42:41.202701Z","end":"2026-04-22T14:42:41.507036Z","steps":["trace[1286773663] 'agreement among raft nodes before linearized reading' (duration: 304.040639ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:42:41.507029Z","caller":"traceutil/trace.go:171","msg":"trace[267230772] transaction","detail":"{read_only:false; response_revision:24715; number_of_response:1; }","duration":"367.958363ms","start":"2026-04-22T14:42:41.139037Z","end":"2026-04-22T14:42:41.506995Z","steps":["trace[267230772] 'process raft request' (duration: 366.863672ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:42:41.507082Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:42:41.20268Z","time spent":"304.392467ms","remote":"127.0.0.1:51152","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":232,"response size":32,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-04-22T14:42:41.507246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:42:41.138998Z","time spent":"368.129245ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:42:41.722531Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.130914ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:42:41.722672Z","caller":"traceutil/trace.go:171","msg":"trace[1662574491] transaction","detail":"{read_only:false; response_revision:24716; number_of_response:1; }","duration":"184.43359ms","start":"2026-04-22T14:42:41.538223Z","end":"2026-04-22T14:42:41.722656Z","steps":["trace[1662574491] 'process raft request' (duration: 82.06487ms)","trace[1662574491] 'compare' (duration: 102.013382ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:42:41.723111Z","caller":"traceutil/trace.go:171","msg":"trace[1313522327] transaction","detail":"{read_only:false; response_revision:24717; number_of_response:1; }","duration":"180.818363ms","start":"2026-04-22T14:42:41.542267Z","end":"2026-04-22T14:42:41.723085Z","steps":["trace[1313522327] 'process raft request' (duration: 180.353944ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:02.430649Z","caller":"traceutil/trace.go:171","msg":"trace[1096865976] linearizableReadLoop","detail":"{readStateIndex:25686; appliedIndex:25685; }","duration":"385.325416ms","start":"2026-04-22T14:43:02.045303Z","end":"2026-04-22T14:43:02.430628Z","steps":["trace[1096865976] 'read index received' (duration: 385.211864ms)","trace[1096865976] 'applied index is now lower than readState.Index' (duration: 112.432µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:43:02.430754Z","caller":"traceutil/trace.go:171","msg":"trace[390430611] transaction","detail":"{read_only:false; response_revision:24871; number_of_response:1; }","duration":"422.246985ms","start":"2026-04-22T14:43:02.008451Z","end":"2026-04-22T14:43:02.430698Z","steps":["trace[390430611] 'process raft request' (duration: 422.053682ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:02.430883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"385.55975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.10\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-04-22T14:43:02.430979Z","caller":"traceutil/trace.go:171","msg":"trace[2097536972] range","detail":"{range_begin:/registry/masterleases/199.19.213.10; range_end:; response_count:1; response_revision:24871; }","duration":"385.664233ms","start":"2026-04-22T14:43:02.045298Z","end":"2026-04-22T14:43:02.430962Z","steps":["trace[2097536972] 'agreement among raft nodes before linearized reading' (duration: 385.460509ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:02.431018Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:43:02.045254Z","time spent":"385.755544ms","remote":"127.0.0.1:51084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/199.19.213.10\" "} {"level":"warn","ts":"2026-04-22T14:43:02.431059Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:43:02.008434Z","time spent":"422.454549ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:43:02.459088Z","caller":"traceutil/trace.go:171","msg":"trace[918151862] transaction","detail":"{read_only:false; response_revision:24872; number_of_response:1; }","duration":"261.359655ms","start":"2026-04-22T14:43:02.197705Z","end":"2026-04-22T14:43:02.459065Z","steps":["trace[918151862] 'process raft request' (duration: 261.233503ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:02.459334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.332983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T14:43:02.459471Z","caller":"traceutil/trace.go:171","msg":"trace[1110783021] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:24872; }","duration":"269.547787ms","start":"2026-04-22T14:43:02.189894Z","end":"2026-04-22T14:43:02.459442Z","steps":["trace[1110783021] 'agreement among raft nodes before linearized reading' (duration: 269.198511ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:02.459735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.574318ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T14:43:02.459769Z","caller":"traceutil/trace.go:171","msg":"trace[996865642] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:24872; }","duration":"135.66169ms","start":"2026-04-22T14:43:02.324099Z","end":"2026-04-22T14:43:02.45976Z","steps":["trace[996865642] 'agreement among raft nodes before linearized reading' (duration: 135.550078ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:02.664153Z","caller":"traceutil/trace.go:171","msg":"trace[1641589500] linearizableReadLoop","detail":"{readStateIndex:25688; appliedIndex:25687; }","duration":"152.165887ms","start":"2026-04-22T14:43:02.51196Z","end":"2026-04-22T14:43:02.664126Z","steps":["trace[1641589500] 'read index received' (duration: 96.333346ms)","trace[1641589500] 'applied index is now lower than readState.Index' (duration: 55.831031ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:43:02.664356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.379491ms","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-04-22T14:43:02.664397Z","caller":"traceutil/trace.go:171","msg":"trace[1968110675] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24872; }","duration":"152.470993ms","start":"2026-04-22T14:43:02.511914Z","end":"2026-04-22T14:43:02.664385Z","steps":["trace[1968110675] 'agreement among raft nodes before linearized reading' (duration: 152.30608ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:02.926523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.628455ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:43:02.926782Z","caller":"traceutil/trace.go:171","msg":"trace[1843492898] transaction","detail":"{read_only:false; response_revision:24874; number_of_response:1; }","duration":"260.973087ms","start":"2026-04-22T14:43:02.665756Z","end":"2026-04-22T14:43:02.926729Z","steps":["trace[1843492898] 'process raft request' (duration: 107.073396ms)","trace[1843492898] 'compare' (duration: 153.541434ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:43:02.926913Z","caller":"traceutil/trace.go:171","msg":"trace[78055412] linearizableReadLoop","detail":"{readStateIndex:25692; appliedIndex:25688; }","duration":"222.042121ms","start":"2026-04-22T14:43:02.70486Z","end":"2026-04-22T14:43:02.926902Z","steps":["trace[78055412] 'read index received' (duration: 10.877222ms)","trace[78055412] 'applied index is now lower than readState.Index' (duration: 211.163859ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:43:02.926941Z","caller":"traceutil/trace.go:171","msg":"trace[1447324424] transaction","detail":"{read_only:false; response_revision:24875; number_of_response:1; }","duration":"257.428391ms","start":"2026-04-22T14:43:02.669489Z","end":"2026-04-22T14:43:02.926917Z","steps":["trace[1447324424] 'process raft request' (duration: 257.102965ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:02.927022Z","caller":"traceutil/trace.go:171","msg":"trace[1636058315] transaction","detail":"{read_only:false; response_revision:24876; number_of_response:1; }","duration":"226.058356ms","start":"2026-04-22T14:43:02.700937Z","end":"2026-04-22T14:43:02.926995Z","steps":["trace[1636058315] 'process raft request' (duration: 225.899123ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:02.927132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.263245ms","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-04-22T14:43:02.927192Z","caller":"traceutil/trace.go:171","msg":"trace[800224885] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24876; }","duration":"222.348527ms","start":"2026-04-22T14:43:02.704827Z","end":"2026-04-22T14:43:02.927175Z","steps":["trace[800224885] 'agreement among raft nodes before linearized reading' (duration: 222.172223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:02.927319Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.015809ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/backendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:43:02.927303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.812281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificaterequests/\" range_end:\"/registry/cert-manager.io/certificaterequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-04-22T14:43:02.927368Z","caller":"traceutil/trace.go:171","msg":"trace[508586511] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backendtrafficpolicies/; range_end:/registry/gateway.envoyproxy.io/backendtrafficpolicies0; response_count:0; response_revision:24876; }","duration":"164.113281ms","start":"2026-04-22T14:43:02.763225Z","end":"2026-04-22T14:43:02.927339Z","steps":["trace[508586511] 'agreement among raft nodes before linearized reading' (duration: 163.914437ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:02.927367Z","caller":"traceutil/trace.go:171","msg":"trace[1211807703] range","detail":"{range_begin:/registry/cert-manager.io/certificaterequests/; range_end:/registry/cert-manager.io/certificaterequests0; response_count:0; response_revision:24876; }","duration":"106.891413ms","start":"2026-04-22T14:43:02.820459Z","end":"2026-04-22T14:43:02.927351Z","steps":["trace[1211807703] 'agreement among raft nodes before linearized reading' (duration: 106.74195ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:03.206188Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.656864ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:43:03.206439Z","caller":"traceutil/trace.go:171","msg":"trace[647231988] linearizableReadLoop","detail":"{readStateIndex:25694; appliedIndex:25692; }","duration":"275.367006ms","start":"2026-04-22T14:43:02.93105Z","end":"2026-04-22T14:43:03.206417Z","steps":["trace[647231988] 'read index received' (duration: 135.902386ms)","trace[647231988] 'applied index is now lower than readState.Index' (duration: 139.46321ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:43:03.206657Z","caller":"traceutil/trace.go:171","msg":"trace[682966113] transaction","detail":"{read_only:false; response_revision:24877; number_of_response:1; }","duration":"276.512837ms","start":"2026-04-22T14:43:02.930113Z","end":"2026-04-22T14:43:03.206626Z","steps":["trace[682966113] 'process raft request' (duration: 136.333823ms)","trace[682966113] 'compare' (duration: 139.44526ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:43:03.20682Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.753193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-04-22T14:43:03.206911Z","caller":"traceutil/trace.go:171","msg":"trace[1655344556] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:24878; }","duration":"275.859695ms","start":"2026-04-22T14:43:02.931033Z","end":"2026-04-22T14:43:03.206893Z","steps":["trace[1655344556] 'agreement among raft nodes before linearized reading' (duration: 275.634631ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:03.206814Z","caller":"traceutil/trace.go:171","msg":"trace[693915] transaction","detail":"{read_only:false; response_revision:24878; number_of_response:1; }","duration":"276.308803ms","start":"2026-04-22T14:43:02.930484Z","end":"2026-04-22T14:43:03.206793Z","steps":["trace[693915] 'process raft request' (duration: 275.826555ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:38.734177Z","caller":"traceutil/trace.go:171","msg":"trace[264227354] linearizableReadLoop","detail":"{readStateIndex:26076; appliedIndex:26075; }","duration":"135.805303ms","start":"2026-04-22T14:43:38.598346Z","end":"2026-04-22T14:43:38.734151Z","steps":["trace[264227354] 'read index received' (duration: 135.565249ms)","trace[264227354] 'applied index is now lower than readState.Index' (duration: 239.144µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:43:38.734559Z","caller":"traceutil/trace.go:171","msg":"trace[864637612] transaction","detail":"{read_only:false; response_revision:25251; number_of_response:1; }","duration":"152.018034ms","start":"2026-04-22T14:43:38.582519Z","end":"2026-04-22T14:43:38.734537Z","steps":["trace[864637612] 'process raft request' (duration: 151.490995ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:38.734711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.338173ms","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-04-22T14:43:38.734794Z","caller":"traceutil/trace.go:171","msg":"trace[1412022506] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25251; }","duration":"136.467785ms","start":"2026-04-22T14:43:38.598308Z","end":"2026-04-22T14:43:38.734776Z","steps":["trace[1412022506] 'agreement among raft nodes before linearized reading' (duration: 136.22931ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:38.839688Z","caller":"traceutil/trace.go:171","msg":"trace[519489655] transaction","detail":"{read_only:false; response_revision:25252; number_of_response:1; }","duration":"100.77837ms","start":"2026-04-22T14:43:38.738882Z","end":"2026-04-22T14:43:38.83966Z","steps":["trace[519489655] 'process raft request' (duration: 98.829133ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:53.633349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.243006ms","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-04-22T14:43:53.63346Z","caller":"traceutil/trace.go:171","msg":"trace[279434644] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25366; }","duration":"132.402898ms","start":"2026-04-22T14:43:53.501038Z","end":"2026-04-22T14:43:53.633441Z","steps":["trace[279434644] 'count revisions from in-memory index tree' (duration: 132.151915ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:43:59.078807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.464125ms","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-04-22T14:43:59.078903Z","caller":"traceutil/trace.go:171","msg":"trace[2131524751] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25400; }","duration":"150.603878ms","start":"2026-04-22T14:43:58.92828Z","end":"2026-04-22T14:43:59.078884Z","steps":["trace[2131524751] 'range keys from in-memory index tree' (duration: 150.012997ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:43:59.079569Z","caller":"traceutil/trace.go:171","msg":"trace[1413106159] transaction","detail":"{read_only:false; response_revision:25401; number_of_response:1; }","duration":"126.668463ms","start":"2026-04-22T14:43:58.95288Z","end":"2026-04-22T14:43:59.079548Z","steps":["trace[1413106159] 'process raft request' (duration: 113.735212ms)","trace[1413106159] 'compare' (duration: 12.658235ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:43:59.368371Z","caller":"traceutil/trace.go:171","msg":"trace[819775564] transaction","detail":"{read_only:false; response_revision:25403; number_of_response:1; }","duration":"156.619021ms","start":"2026-04-22T14:43:59.211697Z","end":"2026-04-22T14:43:59.368316Z","steps":["trace[819775564] 'process raft request' (duration: 100.848921ms)","trace[819775564] 'compare' (duration: 55.591937ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:44:00.179751Z","caller":"traceutil/trace.go:171","msg":"trace[998573244] transaction","detail":"{read_only:false; response_revision:25413; number_of_response:1; }","duration":"154.753285ms","start":"2026-04-22T14:44:00.024966Z","end":"2026-04-22T14:44:00.179719Z","steps":["trace[998573244] 'process raft request' (duration: 146.234527ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:44:14.814814Z","caller":"traceutil/trace.go:171","msg":"trace[1698977210] transaction","detail":"{read_only:false; response_revision:25659; number_of_response:1; }","duration":"119.823165ms","start":"2026-04-22T14:44:14.694957Z","end":"2026-04-22T14:44:14.81478Z","steps":["trace[1698977210] 'process raft request' (duration: 119.63189ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:44:15.070153Z","caller":"traceutil/trace.go:171","msg":"trace[461562800] transaction","detail":"{read_only:false; response_revision:25660; number_of_response:1; }","duration":"208.872356ms","start":"2026-04-22T14:44:14.861252Z","end":"2026-04-22T14:44:15.070124Z","steps":["trace[461562800] 'process raft request' (duration: 208.681352ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:44:33.251092Z","caller":"traceutil/trace.go:171","msg":"trace[266607707] transaction","detail":"{read_only:false; response_revision:25822; number_of_response:1; }","duration":"117.082193ms","start":"2026-04-22T14:44:33.133983Z","end":"2026-04-22T14:44:33.251065Z","steps":["trace[266607707] 'process raft request' (duration: 116.948581ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:44:33.406922Z","caller":"traceutil/trace.go:171","msg":"trace[1941921907] linearizableReadLoop","detail":"{readStateIndex:26660; appliedIndex:26659; }","duration":"146.692996ms","start":"2026-04-22T14:44:33.260204Z","end":"2026-04-22T14:44:33.406897Z","steps":["trace[1941921907] 'read index received' (duration: 146.488722ms)","trace[1941921907] 'applied index is now lower than readState.Index' (duration: 203.304µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:44:33.406974Z","caller":"traceutil/trace.go:171","msg":"trace[1288920266] transaction","detail":"{read_only:false; response_revision:25823; number_of_response:1; }","duration":"214.068552ms","start":"2026-04-22T14:44:33.192884Z","end":"2026-04-22T14:44:33.406953Z","steps":["trace[1288920266] 'process raft request' (duration: 213.871338ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:44:33.407222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.9914ms","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-04-22T14:44:33.407269Z","caller":"traceutil/trace.go:171","msg":"trace[1716744762] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25823; }","duration":"147.121873ms","start":"2026-04-22T14:44:33.260134Z","end":"2026-04-22T14:44:33.407256Z","steps":["trace[1716744762] 'agreement among raft nodes before linearized reading' (duration: 146.856268ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:03.459098Z","caller":"traceutil/trace.go:171","msg":"trace[1191745839] transaction","detail":"{read_only:false; response_revision:26059; number_of_response:1; }","duration":"109.160746ms","start":"2026-04-22T14:45:03.349901Z","end":"2026-04-22T14:45:03.459062Z","steps":["trace[1191745839] 'process raft request' (duration: 108.947642ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:03.739086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.665061ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:45:03.739223Z","caller":"traceutil/trace.go:171","msg":"trace[955340782] transaction","detail":"{read_only:false; response_revision:26061; number_of_response:1; }","duration":"153.655335ms","start":"2026-04-22T14:45:03.585557Z","end":"2026-04-22T14:45:03.739213Z","steps":["trace[955340782] 'process raft request' (duration: 153.609465ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:03.739227Z","caller":"traceutil/trace.go:171","msg":"trace[919475298] linearizableReadLoop","detail":"{readStateIndex:26904; appliedIndex:26903; }","duration":"186.452606ms","start":"2026-04-22T14:45:03.552755Z","end":"2026-04-22T14:45:03.739207Z","steps":["trace[919475298] 'read index received' (duration: 36.611512ms)","trace[919475298] 'applied index is now lower than readState.Index' (duration: 149.840074ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:03.739207Z","caller":"traceutil/trace.go:171","msg":"trace[1544209931] transaction","detail":"{read_only:false; response_revision:26060; number_of_response:1; }","duration":"234.780479ms","start":"2026-04-22T14:45:03.504384Z","end":"2026-04-22T14:45:03.739164Z","steps":["trace[1544209931] 'process raft request' (duration: 84.969185ms)","trace[1544209931] 'compare' (duration: 149.479968ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:03.739433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.680961ms","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-04-22T14:45:03.739483Z","caller":"traceutil/trace.go:171","msg":"trace[104316734] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26061; }","duration":"186.774093ms","start":"2026-04-22T14:45:03.552697Z","end":"2026-04-22T14:45:03.739471Z","steps":["trace[104316734] 'agreement among raft nodes before linearized reading' (duration: 186.61114ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.006288Z","caller":"traceutil/trace.go:171","msg":"trace[868465454] transaction","detail":"{read_only:false; response_revision:26062; number_of_response:1; }","duration":"262.952124ms","start":"2026-04-22T14:45:03.743315Z","end":"2026-04-22T14:45:04.006267Z","steps":["trace[868465454] 'process raft request' (duration: 262.838191ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.007989Z","caller":"traceutil/trace.go:171","msg":"trace[1228437942] linearizableReadLoop","detail":"{readStateIndex:26907; appliedIndex:26905; }","duration":"229.628783ms","start":"2026-04-22T14:45:03.778338Z","end":"2026-04-22T14:45:04.007967Z","steps":["trace[1228437942] 'read index received' (duration: 227.813868ms)","trace[1228437942] 'applied index is now lower than readState.Index' (duration: 1.813755ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:04.008275Z","caller":"traceutil/trace.go:171","msg":"trace[1754978419] transaction","detail":"{read_only:false; response_revision:26063; number_of_response:1; }","duration":"264.674496ms","start":"2026-04-22T14:45:03.743587Z","end":"2026-04-22T14:45:04.008261Z","steps":["trace[1754978419] 'process raft request' (duration: 264.221078ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.00846Z","caller":"traceutil/trace.go:171","msg":"trace[166769480] transaction","detail":"{read_only:false; response_revision:26064; number_of_response:1; }","duration":"108.800969ms","start":"2026-04-22T14:45:03.899646Z","end":"2026-04-22T14:45:04.008447Z","steps":["trace[166769480] 'process raft request' (duration: 108.27725ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.008575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.233553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.008625Z","caller":"traceutil/trace.go:171","msg":"trace[2002868570] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26064; }","duration":"230.324275ms","start":"2026-04-22T14:45:03.778287Z","end":"2026-04-22T14:45:04.008611Z","steps":["trace[2002868570] 'agreement among raft nodes before linearized reading' (duration: 230.233154ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.008808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.893051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-22T14:45:04.008836Z","caller":"traceutil/trace.go:171","msg":"trace[766000153] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26064; }","duration":"226.945542ms","start":"2026-04-22T14:45:03.781884Z","end":"2026-04-22T14:45:04.008829Z","steps":["trace[766000153] 'agreement among raft nodes before linearized reading' (duration: 226.854911ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.008962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.721205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-22T14:45:04.00899Z","caller":"traceutil/trace.go:171","msg":"trace[1074548126] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26064; }","duration":"221.784946ms","start":"2026-04-22T14:45:03.787195Z","end":"2026-04-22T14:45:04.00898Z","steps":["trace[1074548126] 'agreement among raft nodes before linearized reading' (duration: 221.721585ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.009131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.685803ms","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-04-22T14:45:04.009156Z","caller":"traceutil/trace.go:171","msg":"trace[771097293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26064; }","duration":"222.721713ms","start":"2026-04-22T14:45:03.786428Z","end":"2026-04-22T14:45:04.00915Z","steps":["trace[771097293] 'agreement among raft nodes before linearized reading' (duration: 222.656462ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.296088Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.96437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:45:04.296221Z","caller":"traceutil/trace.go:171","msg":"trace[1135457432] transaction","detail":"{read_only:false; response_revision:26065; number_of_response:1; }","duration":"283.265533ms","start":"2026-04-22T14:45:04.012936Z","end":"2026-04-22T14:45:04.296202Z","steps":["trace[1135457432] 'process raft request' (duration: 143.090369ms)","trace[1135457432] 'compare' (duration: 139.703495ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:04.573538Z","caller":"traceutil/trace.go:171","msg":"trace[290394361] transaction","detail":"{read_only:false; response_revision:26066; number_of_response:1; }","duration":"558.77106ms","start":"2026-04-22T14:45:04.014739Z","end":"2026-04-22T14:45:04.57351Z","steps":["trace[290394361] 'process raft request' (duration: 528.356033ms)","trace[290394361] 'compare' (duration: 29.48164ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:04.573692Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.014732Z","time spent":"558.879273ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:04.57385Z","caller":"traceutil/trace.go:171","msg":"trace[1796046233] transaction","detail":"{read_only:false; response_revision:26067; number_of_response:1; }","duration":"556.145182ms","start":"2026-04-22T14:45:04.017673Z","end":"2026-04-22T14:45:04.573818Z","steps":["trace[1796046233] 'process raft request' (duration: 555.780475ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.574007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.017667Z","time spent":"556.264004ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:04.574084Z","caller":"traceutil/trace.go:171","msg":"trace[1896013348] transaction","detail":"{read_only:false; response_revision:26068; number_of_response:1; }","duration":"546.91669ms","start":"2026-04-22T14:45:04.027153Z","end":"2026-04-22T14:45:04.574069Z","steps":["trace[1896013348] 'process raft request' (duration: 546.566193ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.574073Z","caller":"traceutil/trace.go:171","msg":"trace[1111315237] linearizableReadLoop","detail":"{readStateIndex:26911; appliedIndex:26908; }","duration":"555.721123ms","start":"2026-04-22T14:45:04.018331Z","end":"2026-04-22T14:45:04.574052Z","steps":["trace[1111315237] 'read index received' (duration: 137.711678ms)","trace[1111315237] 'applied index is now lower than readState.Index' (duration: 418.008285ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:04.574141Z","caller":"traceutil/trace.go:171","msg":"trace[1554829550] transaction","detail":"{read_only:false; response_revision:26069; number_of_response:1; }","duration":"461.939625ms","start":"2026-04-22T14:45:04.112189Z","end":"2026-04-22T14:45:04.574129Z","steps":["trace[1554829550] 'process raft request' (duration: 461.764181ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.574162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.027131Z","time spent":"546.993551ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:45:04.5742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.112166Z","time spent":"462.000736ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:45:04.57421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"555.855986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.574246Z","caller":"traceutil/trace.go:171","msg":"trace[1994936156] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26069; }","duration":"555.924847ms","start":"2026-04-22T14:45:04.018309Z","end":"2026-04-22T14:45:04.574234Z","steps":["trace[1994936156] 'agreement among raft nodes before linearized reading' (duration: 555.848735ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.574279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.018302Z","time spent":"555.968577ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"info","ts":"2026-04-22T14:45:04.608132Z","caller":"traceutil/trace.go:171","msg":"trace[1916793025] transaction","detail":"{read_only:false; response_revision:26070; number_of_response:1; }","duration":"313.68711ms","start":"2026-04-22T14:45:04.294424Z","end":"2026-04-22T14:45:04.608112Z","steps":["trace[1916793025] 'process raft request' (duration: 313.556708ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.627186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.608419Z","caller":"traceutil/trace.go:171","msg":"trace[1627997537] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26071; }","duration":"589.733688ms","start":"2026-04-22T14:45:04.018667Z","end":"2026-04-22T14:45:04.6084Z","steps":["trace[1627997537] 'agreement among raft nodes before linearized reading' (duration: 589.585855ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.820685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:04.608458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.615825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:04.608487Z","caller":"traceutil/trace.go:171","msg":"trace[958325157] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26071; }","duration":"370.880966ms","start":"2026-04-22T14:45:04.237597Z","end":"2026-04-22T14:45:04.608478Z","steps":["trace[958325157] 'agreement among raft nodes before linearized reading' (duration: 370.800015ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608512Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.237589Z","time spent":"370.918127ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"info","ts":"2026-04-22T14:45:04.608514Z","caller":"traceutil/trace.go:171","msg":"trace[1139854335] transaction","detail":"{read_only:false; response_revision:26071; number_of_response:1; }","duration":"193.885795ms","start":"2026-04-22T14:45:04.414608Z","end":"2026-04-22T14:45:04.608494Z","steps":["trace[1139854335] 'process raft request' (duration: 193.467788ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608563Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.771376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.608605Z","caller":"traceutil/trace.go:171","msg":"trace[63732384] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26071; }","duration":"220.816577ms","start":"2026-04-22T14:45:04.387772Z","end":"2026-04-22T14:45:04.608589Z","steps":["trace[63732384] 'agreement among raft nodes before linearized reading' (duration: 220.765836ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.506487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"warn","ts":"2026-04-22T14:45:04.608559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.101642ms","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-04-22T14:45:04.608642Z","caller":"traceutil/trace.go:171","msg":"trace[875703916] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26071; }","duration":"371.566069ms","start":"2026-04-22T14:45:04.237067Z","end":"2026-04-22T14:45:04.608633Z","steps":["trace[875703916] 'agreement among raft nodes before linearized reading' (duration: 371.462107ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.237047Z","time spent":"371.622549ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5030,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"info","ts":"2026-04-22T14:45:04.608688Z","caller":"traceutil/trace.go:171","msg":"trace[846778801] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26071; }","duration":"192.258815ms","start":"2026-04-22T14:45:04.416413Z","end":"2026-04-22T14:45:04.608671Z","steps":["trace[846778801] 'agreement among raft nodes before linearized reading' (duration: 191.938969ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608801Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.334988ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:04.608844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.617303ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.608848Z","caller":"traceutil/trace.go:171","msg":"trace[424808533] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26071; }","duration":"221.395689ms","start":"2026-04-22T14:45:04.38744Z","end":"2026-04-22T14:45:04.608835Z","steps":["trace[424808533] 'agreement among raft nodes before linearized reading' (duration: 221.342228ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.608869Z","caller":"traceutil/trace.go:171","msg":"trace[941187822] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26071; }","duration":"222.698454ms","start":"2026-04-22T14:45:04.386163Z","end":"2026-04-22T14:45:04.608861Z","steps":["trace[941187822] 'agreement among raft nodes before linearized reading' (duration: 222.663212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608887Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"590.161376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.608924Z","caller":"traceutil/trace.go:171","msg":"trace[1734835332] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26071; }","duration":"590.206327ms","start":"2026-04-22T14:45:04.018708Z","end":"2026-04-22T14:45:04.608915Z","steps":["trace[1734835332] 'agreement among raft nodes before linearized reading' (duration: 590.116144ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.917659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"warn","ts":"2026-04-22T14:45:04.60895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.018705Z","time spent":"590.240388ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"warn","ts":"2026-04-22T14:45:04.608957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.883372ms","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-04-22T14:45:04.608971Z","caller":"traceutil/trace.go:171","msg":"trace[589245486] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26071; }","duration":"221.978021ms","start":"2026-04-22T14:45:04.386981Z","end":"2026-04-22T14:45:04.608959Z","steps":["trace[589245486] 'agreement among raft nodes before linearized reading' (duration: 221.319368ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.60901Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.310255ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:04.608512Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"370.923307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.609035Z","caller":"traceutil/trace.go:171","msg":"trace[257168508] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26071; }","duration":"371.376686ms","start":"2026-04-22T14:45:04.237653Z","end":"2026-04-22T14:45:04.60903Z","steps":["trace[257168508] 'agreement among raft nodes before linearized reading' (duration: 371.341645ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.609042Z","caller":"traceutil/trace.go:171","msg":"trace[1495863171] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26071; }","duration":"371.499078ms","start":"2026-04-22T14:45:04.237536Z","end":"2026-04-22T14:45:04.609036Z","steps":["trace[1495863171] 'agreement among raft nodes before linearized reading' (duration: 370.952187ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.379197ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:04.609075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.237509Z","time spent":"371.55889ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"info","ts":"2026-04-22T14:45:04.609088Z","caller":"traceutil/trace.go:171","msg":"trace[8970170] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26071; }","duration":"222.681203ms","start":"2026-04-22T14:45:04.386395Z","end":"2026-04-22T14:45:04.609077Z","steps":["trace[8970170] 'agreement among raft nodes before linearized reading' (duration: 222.389277ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.608981Z","caller":"traceutil/trace.go:171","msg":"trace[82442024] range","detail":"{range_begin:/registry/services/specs/ingress-nginx/ingress-nginx-controller; range_end:; response_count:1; response_revision:26071; }","duration":"330.931622ms","start":"2026-04-22T14:45:04.278041Z","end":"2026-04-22T14:45:04.608972Z","steps":["trace[82442024] 'agreement among raft nodes before linearized reading' (duration: 330.880311ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.149903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:04.609151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.278027Z","time spent":"331.118246ms","remote":"127.0.0.1:51258","response type":"/etcdserverpb.KV/Range","request count":0,"request size":65,"response count":1,"response size":2012,"request content":"key:\"/registry/services/specs/ingress-nginx/ingress-nginx-controller\" "} {"level":"info","ts":"2026-04-22T14:45:04.60916Z","caller":"traceutil/trace.go:171","msg":"trace[606780808] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26071; }","duration":"221.646524ms","start":"2026-04-22T14:45:04.387506Z","end":"2026-04-22T14:45:04.609152Z","steps":["trace[606780808] 'agreement among raft nodes before linearized reading' (duration: 221.175965ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608285Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.294398Z","time spent":"313.797282ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:45:04.608437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.661139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.608515Z","caller":"traceutil/trace.go:171","msg":"trace[1065292186] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26071; }","duration":"219.690216ms","start":"2026-04-22T14:45:04.388814Z","end":"2026-04-22T14:45:04.608504Z","steps":["trace[1065292186] 'agreement among raft nodes before linearized reading' (duration: 219.508843ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:04.609324Z","caller":"traceutil/trace.go:171","msg":"trace[1758484469] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:26071; }","duration":"159.575646ms","start":"2026-04-22T14:45:04.449703Z","end":"2026-04-22T14:45:04.609278Z","steps":["trace[1758484469] 'agreement among raft nodes before linearized reading' (duration: 158.655658ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.210004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:04.609395Z","caller":"traceutil/trace.go:171","msg":"trace[1158537551] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26071; }","duration":"221.840527ms","start":"2026-04-22T14:45:04.387543Z","end":"2026-04-22T14:45:04.609384Z","steps":["trace[1158537551] 'agreement among raft nodes before linearized reading' (duration: 221.180173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"589.195738ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:04.609489Z","caller":"traceutil/trace.go:171","msg":"trace[1164982520] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26071; }","duration":"589.875131ms","start":"2026-04-22T14:45:04.019591Z","end":"2026-04-22T14:45:04.609466Z","steps":["trace[1164982520] 'agreement among raft nodes before linearized reading' (duration: 589.164257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:04.608461Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.018662Z","time spent":"589.790899ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"warn","ts":"2026-04-22T14:45:04.609055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.237632Z","time spent":"371.419006ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"warn","ts":"2026-04-22T14:45:04.609567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:04.019583Z","time spent":"589.963002ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5030,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"info","ts":"2026-04-22T14:45:04.730294Z","caller":"traceutil/trace.go:171","msg":"trace[1007513908] transaction","detail":"{read_only:false; response_revision:26072; number_of_response:1; }","duration":"113.852454ms","start":"2026-04-22T14:45:04.616406Z","end":"2026-04-22T14:45:04.730259Z","steps":["trace[1007513908] 'process raft request' (duration: 110.42174ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:18.944342Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23351} {"level":"info","ts":"2026-04-22T14:45:19.07983Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23351,"took":"132.194185ms","hash":211973963,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":36167680,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-04-22T14:45:19.079892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":211973963,"revision":23351,"compact-revision":20202} {"level":"info","ts":"2026-04-22T14:45:34.397897Z","caller":"traceutil/trace.go:171","msg":"trace[1903175659] transaction","detail":"{read_only:false; response_revision:26303; number_of_response:1; }","duration":"247.72857ms","start":"2026-04-22T14:45:34.150133Z","end":"2026-04-22T14:45:34.397862Z","steps":["trace[1903175659] 'process raft request' (duration: 228.403529ms)","trace[1903175659] 'compare' (duration: 19.153207ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:34.447816Z","caller":"traceutil/trace.go:171","msg":"trace[640345301] transaction","detail":"{read_only:false; response_revision:26304; number_of_response:1; }","duration":"295.320077ms","start":"2026-04-22T14:45:34.152474Z","end":"2026-04-22T14:45:34.447794Z","steps":["trace[640345301] 'process raft request' (duration: 294.808067ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.755706Z","caller":"traceutil/trace.go:171","msg":"trace[943953469] linearizableReadLoop","detail":"{readStateIndex:27156; appliedIndex:27155; }","duration":"105.808804ms","start":"2026-04-22T14:45:34.649869Z","end":"2026-04-22T14:45:34.755678Z","steps":["trace[943953469] 'read index received' (duration: 65.91776ms)","trace[943953469] 'applied index is now lower than readState.Index' (duration: 39.889464ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:34.755933Z","caller":"traceutil/trace.go:171","msg":"trace[729089569] transaction","detail":"{read_only:false; response_revision:26305; number_of_response:1; }","duration":"303.978459ms","start":"2026-04-22T14:45:34.451917Z","end":"2026-04-22T14:45:34.755896Z","steps":["trace[729089569] 'process raft request' (duration: 263.859301ms)","trace[729089569] 'compare' (duration: 39.679149ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:34.756038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.145859ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:34.756102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:34.451902Z","time spent":"304.106641ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:34.756136Z","caller":"traceutil/trace.go:171","msg":"trace[23108870] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26305; }","duration":"106.301523ms","start":"2026-04-22T14:45:34.649815Z","end":"2026-04-22T14:45:34.756116Z","steps":["trace[23108870] 'agreement among raft nodes before linearized reading' (duration: 106.096149ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.960417Z","caller":"traceutil/trace.go:171","msg":"trace[416449341] transaction","detail":"{read_only:false; response_revision:26306; number_of_response:1; }","duration":"278.053105ms","start":"2026-04-22T14:45:34.682332Z","end":"2026-04-22T14:45:34.960386Z","steps":["trace[416449341] 'process raft request' (duration: 246.960875ms)","trace[416449341] 'compare' (duration: 30.757894ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:34.96069Z","caller":"traceutil/trace.go:171","msg":"trace[1920749960] linearizableReadLoop","detail":"{readStateIndex:27160; appliedIndex:27156; }","duration":"204.882631ms","start":"2026-04-22T14:45:34.755779Z","end":"2026-04-22T14:45:34.960662Z","steps":["trace[1920749960] 'read index received' (duration: 173.543347ms)","trace[1920749960] 'applied index is now lower than readState.Index' (duration: 31.338344ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:34.960833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.606341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.960875Z","caller":"traceutil/trace.go:171","msg":"trace[154977168] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26309; }","duration":"281.688683ms","start":"2026-04-22T14:45:34.679175Z","end":"2026-04-22T14:45:34.960864Z","steps":["trace[154977168] 'agreement among raft nodes before linearized reading' (duration: 281.589841ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.960895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.708406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.960939Z","caller":"traceutil/trace.go:171","msg":"trace[1808143222] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26309; }","duration":"257.774937ms","start":"2026-04-22T14:45:34.703151Z","end":"2026-04-22T14:45:34.960926Z","steps":["trace[1808143222] 'agreement among raft nodes before linearized reading' (duration: 257.693645ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.960969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"266.606252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.961051Z","caller":"traceutil/trace.go:171","msg":"trace[1976953041] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26309; }","duration":"266.732084ms","start":"2026-04-22T14:45:34.694297Z","end":"2026-04-22T14:45:34.96103Z","steps":["trace[1976953041] 'agreement among raft nodes before linearized reading' (duration: 266.563651ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.482863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.961106Z","caller":"traceutil/trace.go:171","msg":"trace[437769230] transaction","detail":"{read_only:false; response_revision:26307; number_of_response:1; }","duration":"277.634757ms","start":"2026-04-22T14:45:34.683458Z","end":"2026-04-22T14:45:34.961093Z","steps":["trace[437769230] 'process raft request' (duration: 276.842832ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.96113Z","caller":"traceutil/trace.go:171","msg":"trace[26127661] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26309; }","duration":"270.597135ms","start":"2026-04-22T14:45:34.690513Z","end":"2026-04-22T14:45:34.96111Z","steps":["trace[26127661] 'agreement among raft nodes before linearized reading' (duration: 270.450713ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.716298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.961187Z","caller":"traceutil/trace.go:171","msg":"trace[2063004123] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26309; }","duration":"270.766748ms","start":"2026-04-22T14:45:34.690411Z","end":"2026-04-22T14:45:34.961178Z","steps":["trace[2063004123] 'agreement among raft nodes before linearized reading' (duration: 270.718358ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.208195ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.96124Z","caller":"traceutil/trace.go:171","msg":"trace[239255465] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26309; }","duration":"258.244335ms","start":"2026-04-22T14:45:34.702986Z","end":"2026-04-22T14:45:34.961231Z","steps":["trace[239255465] 'agreement among raft nodes before linearized reading' (duration: 258.192004ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.961279Z","caller":"traceutil/trace.go:171","msg":"trace[482424090] transaction","detail":"{read_only:false; response_revision:26308; number_of_response:1; }","duration":"250.099664ms","start":"2026-04-22T14:45:34.71117Z","end":"2026-04-22T14:45:34.961269Z","steps":["trace[482424090] 'process raft request' (duration: 249.395761ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961317Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"271.479103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.961344Z","caller":"traceutil/trace.go:171","msg":"trace[79971360] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26309; }","duration":"271.544094ms","start":"2026-04-22T14:45:34.689792Z","end":"2026-04-22T14:45:34.961336Z","steps":["trace[79971360] 'agreement among raft nodes before linearized reading' (duration: 271.503124ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961334Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.686672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:34.961384Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.853299ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:34.96142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"261.014708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:34.961421Z","caller":"traceutil/trace.go:171","msg":"trace[1713127901] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:26309; }","duration":"260.818903ms","start":"2026-04-22T14:45:34.700581Z","end":"2026-04-22T14:45:34.9614Z","steps":["trace[1713127901] 'agreement among raft nodes before linearized reading' (duration: 260.689491ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961445Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.292453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.961454Z","caller":"traceutil/trace.go:171","msg":"trace[1713037237] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26309; }","duration":"261.070618ms","start":"2026-04-22T14:45:34.700375Z","end":"2026-04-22T14:45:34.961446Z","steps":["trace[1713037237] 'agreement among raft nodes before linearized reading' (duration: 260.943116ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.961464Z","caller":"traceutil/trace.go:171","msg":"trace[1360886220] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26309; }","duration":"264.94373ms","start":"2026-04-22T14:45:34.696499Z","end":"2026-04-22T14:45:34.961443Z","steps":["trace[1360886220] 'agreement among raft nodes before linearized reading' (duration: 264.825538ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.961481Z","caller":"traceutil/trace.go:171","msg":"trace[1263766956] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26309; }","duration":"260.346954ms","start":"2026-04-22T14:45:34.701126Z","end":"2026-04-22T14:45:34.961473Z","steps":["trace[1263766956] 'agreement among raft nodes before linearized reading' (duration: 260.299223ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.654702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:533"} {"level":"warn","ts":"2026-04-22T14:45:34.961545Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.514756ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.961372Z","caller":"traceutil/trace.go:171","msg":"trace[1821521661] transaction","detail":"{read_only:false; response_revision:26309; number_of_response:1; }","duration":"247.365273ms","start":"2026-04-22T14:45:34.713997Z","end":"2026-04-22T14:45:34.961362Z","steps":["trace[1821521661] 'process raft request' (duration: 246.618989ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.961555Z","caller":"traceutil/trace.go:171","msg":"trace[786769838] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:26309; }","duration":"215.744813ms","start":"2026-04-22T14:45:34.745798Z","end":"2026-04-22T14:45:34.961543Z","steps":["trace[786769838] 'agreement among raft nodes before linearized reading' (duration: 215.59589ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.699028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:34.961608Z","caller":"traceutil/trace.go:171","msg":"trace[1831052465] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26309; }","duration":"269.594418ms","start":"2026-04-22T14:45:34.691994Z","end":"2026-04-22T14:45:34.961588Z","steps":["trace[1831052465] 'agreement among raft nodes before linearized reading' (duration: 269.516455ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.430483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:34.96166Z","caller":"traceutil/trace.go:171","msg":"trace[1178023837] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26309; }","duration":"248.751729ms","start":"2026-04-22T14:45:34.712901Z","end":"2026-04-22T14:45:34.961652Z","steps":["trace[1178023837] 'agreement among raft nodes before linearized reading' (duration: 248.673657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961729Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.121665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:34.961761Z","caller":"traceutil/trace.go:171","msg":"trace[570878547] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26309; }","duration":"249.187627ms","start":"2026-04-22T14:45:34.712565Z","end":"2026-04-22T14:45:34.961753Z","steps":["trace[570878547] 'agreement among raft nodes before linearized reading' (duration: 249.112626ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:34.961767Z","caller":"traceutil/trace.go:171","msg":"trace[1690629627] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26309; }","duration":"248.527395ms","start":"2026-04-22T14:45:34.71322Z","end":"2026-04-22T14:45:34.961748Z","steps":["trace[1690629627] 'agreement among raft nodes before linearized reading' (duration: 248.30467ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.861523ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:34.961864Z","caller":"traceutil/trace.go:171","msg":"trace[297385641] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26309; }","duration":"270.037187ms","start":"2026-04-22T14:45:34.691816Z","end":"2026-04-22T14:45:34.961853Z","steps":["trace[297385641] 'agreement among raft nodes before linearized reading' (duration: 269.883704ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.507649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-04-22T14:45:34.961934Z","caller":"traceutil/trace.go:171","msg":"trace[1504232948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26309; }","duration":"237.578841ms","start":"2026-04-22T14:45:34.724342Z","end":"2026-04-22T14:45:34.961921Z","steps":["trace[1504232948] 'agreement among raft nodes before linearized reading' (duration: 237.475149ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:34.961957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.394664ms","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-04-22T14:45:34.962038Z","caller":"traceutil/trace.go:171","msg":"trace[1891038524] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26309; }","duration":"239.487927ms","start":"2026-04-22T14:45:34.722519Z","end":"2026-04-22T14:45:34.962007Z","steps":["trace[1891038524] 'agreement among raft nodes before linearized reading' (duration: 239.308723ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:56.37608Z","caller":"traceutil/trace.go:171","msg":"trace[1521074560] transaction","detail":"{read_only:false; response_revision:26464; number_of_response:1; }","duration":"178.308786ms","start":"2026-04-22T14:45:56.19774Z","end":"2026-04-22T14:45:56.376049Z","steps":["trace[1521074560] 'process raft request' (duration: 178.022761ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:56.376027Z","caller":"traceutil/trace.go:171","msg":"trace[1641525773] linearizableReadLoop","detail":"{readStateIndex:27319; appliedIndex:27318; }","duration":"136.18956ms","start":"2026-04-22T14:45:56.239798Z","end":"2026-04-22T14:45:56.375988Z","steps":["trace[1641525773] 'read index received' (duration: 135.970066ms)","trace[1641525773] 'applied index is now lower than readState.Index' (duration: 217.904µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:56.376241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.411064ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:56.37635Z","caller":"traceutil/trace.go:171","msg":"trace[1636000424] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26464; }","duration":"136.567167ms","start":"2026-04-22T14:45:56.239745Z","end":"2026-04-22T14:45:56.376312Z","steps":["trace[1636000424] 'agreement among raft nodes before linearized reading' (duration: 136.390794ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:56.642058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.411243ms","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-04-22T14:45:56.642146Z","caller":"traceutil/trace.go:171","msg":"trace[1002391838] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26464; }","duration":"144.549886ms","start":"2026-04-22T14:45:56.497576Z","end":"2026-04-22T14:45:56.642125Z","steps":["trace[1002391838] 'range keys from in-memory index tree' (duration: 144.22125ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:56.766883Z","caller":"traceutil/trace.go:171","msg":"trace[1645942144] transaction","detail":"{read_only:false; response_revision:26465; number_of_response:1; }","duration":"121.223871ms","start":"2026-04-22T14:45:56.645636Z","end":"2026-04-22T14:45:56.76686Z","steps":["trace[1645942144] 'process raft request' (duration: 121.078348ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.066185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.004564ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:45:57.066279Z","caller":"traceutil/trace.go:171","msg":"trace[195574236] linearizableReadLoop","detail":"{readStateIndex:27321; appliedIndex:27320; }","duration":"287.296168ms","start":"2026-04-22T14:45:56.778968Z","end":"2026-04-22T14:45:57.066264Z","steps":["trace[195574236] 'read index received' (duration: 179.162622ms)","trace[195574236] 'applied index is now lower than readState.Index' (duration: 108.130045ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:57.066345Z","caller":"traceutil/trace.go:171","msg":"trace[2009358879] transaction","detail":"{read_only:false; response_revision:26466; number_of_response:1; }","duration":"419.958332ms","start":"2026-04-22T14:45:56.646375Z","end":"2026-04-22T14:45:57.066333Z","steps":["trace[2009358879] 'process raft request' (duration: 311.730274ms)","trace[2009358879] 'compare' (duration: 107.915002ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:57.066379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.415679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:57.066411Z","caller":"traceutil/trace.go:171","msg":"trace[1847221196] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26466; }","duration":"287.47859ms","start":"2026-04-22T14:45:56.778921Z","end":"2026-04-22T14:45:57.066399Z","steps":["trace[1847221196] 'agreement among raft nodes before linearized reading' (duration: 287.415389ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.066406Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:56.646351Z","time spent":"420.026714ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:57.13092Z","caller":"traceutil/trace.go:171","msg":"trace[734839870] transaction","detail":"{read_only:false; response_revision:26467; number_of_response:1; }","duration":"100.80624ms","start":"2026-04-22T14:45:57.03008Z","end":"2026-04-22T14:45:57.130886Z","steps":["trace[734839870] 'process raft request' (duration: 100.548545ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.301098Z","caller":"traceutil/trace.go:171","msg":"trace[1034348642] transaction","detail":"{read_only:false; response_revision:26468; number_of_response:1; }","duration":"270.76147ms","start":"2026-04-22T14:45:57.030285Z","end":"2026-04-22T14:45:57.301046Z","steps":["trace[1034348642] 'process raft request' (duration: 227.465073ms)","trace[1034348642] 'compare' (duration: 42.466172ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:57.301386Z","caller":"traceutil/trace.go:171","msg":"trace[1321375469] transaction","detail":"{read_only:false; response_revision:26469; number_of_response:1; }","duration":"260.196863ms","start":"2026-04-22T14:45:57.041154Z","end":"2026-04-22T14:45:57.301351Z","steps":["trace[1321375469] 'process raft request' (duration: 259.804015ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.301528Z","caller":"traceutil/trace.go:171","msg":"trace[2026493765] linearizableReadLoop","detail":"{readStateIndex:27325; appliedIndex:27321; }","duration":"235.180466ms","start":"2026-04-22T14:45:57.066304Z","end":"2026-04-22T14:45:57.301485Z","steps":["trace[2026493765] 'read index received' (duration: 64.437442ms)","trace[2026493765] 'applied index is now lower than readState.Index' (duration: 170.741864ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:57.301714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"471.946981ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/openstack/rabbitmq-cluster-operator\" ","response":"range_response_count:1 size:1083"} {"level":"info","ts":"2026-04-22T14:45:57.30176Z","caller":"traceutil/trace.go:171","msg":"trace[1069401938] range","detail":"{range_begin:/registry/serviceaccounts/openstack/rabbitmq-cluster-operator; range_end:; response_count:1; response_revision:26470; }","duration":"472.036443ms","start":"2026-04-22T14:45:56.829712Z","end":"2026-04-22T14:45:57.301748Z","steps":["trace[1069401938] 'agreement among raft nodes before linearized reading' (duration: 471.924071ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.301768Z","caller":"traceutil/trace.go:171","msg":"trace[351929338] transaction","detail":"{read_only:false; response_revision:26470; number_of_response:1; }","duration":"252.936817ms","start":"2026-04-22T14:45:57.048815Z","end":"2026-04-22T14:45:57.301752Z","steps":["trace[351929338] 'process raft request' (duration: 252.481219ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.301769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.852381ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.301745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.292791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.301803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:56.829699Z","time spent":"472.094894ms","remote":"127.0.0.1:51268","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":1106,"request content":"key:\"/registry/serviceaccounts/openstack/rabbitmq-cluster-operator\" "} {"level":"info","ts":"2026-04-22T14:45:57.301822Z","caller":"traceutil/trace.go:171","msg":"trace[331428380] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26470; }","duration":"285.926832ms","start":"2026-04-22T14:45:57.015881Z","end":"2026-04-22T14:45:57.301808Z","steps":["trace[331428380] 'agreement among raft nodes before linearized reading' (duration: 285.82158ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.301811Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.132454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.30184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.124184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:57.301854Z","caller":"traceutil/trace.go:171","msg":"trace[1095368017] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26470; }","duration":"284.425193ms","start":"2026-04-22T14:45:57.017404Z","end":"2026-04-22T14:45:57.301829Z","steps":["trace[1095368017] 'agreement among raft nodes before linearized reading' (duration: 284.26571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.301847Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.24555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:57.301905Z","caller":"traceutil/trace.go:171","msg":"trace[1764152784] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26470; }","duration":"280.220925ms","start":"2026-04-22T14:45:57.021668Z","end":"2026-04-22T14:45:57.301889Z","steps":["trace[1764152784] 'agreement among raft nodes before linearized reading' (duration: 280.030352ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.301906Z","caller":"traceutil/trace.go:171","msg":"trace[637381195] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26470; }","duration":"280.297297ms","start":"2026-04-22T14:45:57.02159Z","end":"2026-04-22T14:45:57.301887Z","steps":["trace[637381195] 'agreement among raft nodes before linearized reading' (duration: 280.069763ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.301919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.441638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:57.301934Z","caller":"traceutil/trace.go:171","msg":"trace[815183086] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26470; }","duration":"285.368902ms","start":"2026-04-22T14:45:57.016547Z","end":"2026-04-22T14:45:57.301916Z","steps":["trace[815183086] 'agreement among raft nodes before linearized reading' (duration: 285.194849ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.301953Z","caller":"traceutil/trace.go:171","msg":"trace[862974217] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26470; }","duration":"274.485558ms","start":"2026-04-22T14:45:57.027458Z","end":"2026-04-22T14:45:57.301943Z","steps":["trace[862974217] 'agreement among raft nodes before linearized reading' (duration: 274.402647ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.301939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.109549ms","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-04-22T14:45:57.301951Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.076295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:57.302033Z","caller":"traceutil/trace.go:171","msg":"trace[539632101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26470; }","duration":"239.230691ms","start":"2026-04-22T14:45:57.062777Z","end":"2026-04-22T14:45:57.302007Z","steps":["trace[539632101] 'agreement among raft nodes before linearized reading' (duration: 238.995426ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.302035Z","caller":"traceutil/trace.go:171","msg":"trace[834062243] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26470; }","duration":"286.190487ms","start":"2026-04-22T14:45:57.015827Z","end":"2026-04-22T14:45:57.302018Z","steps":["trace[834062243] 'agreement among raft nodes before linearized reading' (duration: 286.078005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.301866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"451.00594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-04-22T14:45:57.30208Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"501.237608ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.302074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.45006ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.302102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"238.06947ms","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-04-22T14:45:57.302112Z","caller":"traceutil/trace.go:171","msg":"trace[1553826712] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:26470; }","duration":"501.294278ms","start":"2026-04-22T14:45:56.80081Z","end":"2026-04-22T14:45:57.302105Z","steps":["trace[1553826712] 'agreement among raft nodes before linearized reading' (duration: 501.240257ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.302136Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:56.8008Z","time spent":"501.330649ms","remote":"127.0.0.1:51144","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":29,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"info","ts":"2026-04-22T14:45:57.302134Z","caller":"traceutil/trace.go:171","msg":"trace[352869537] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26470; }","duration":"280.526882ms","start":"2026-04-22T14:45:57.021592Z","end":"2026-04-22T14:45:57.302119Z","steps":["trace[352869537] 'agreement among raft nodes before linearized reading' (duration: 280.44618ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.302141Z","caller":"traceutil/trace.go:171","msg":"trace[1439733561] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26470; }","duration":"238.126961ms","start":"2026-04-22T14:45:57.063999Z","end":"2026-04-22T14:45:57.302125Z","steps":["trace[1439733561] 'agreement among raft nodes before linearized reading' (duration: 237.990038ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.302166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.084316ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-04-22T14:45:57.302085Z","caller":"traceutil/trace.go:171","msg":"trace[1549302432] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26470; }","duration":"451.276346ms","start":"2026-04-22T14:45:56.850799Z","end":"2026-04-22T14:45:57.302076Z","steps":["trace[1549302432] 'agreement among raft nodes before linearized reading' (duration: 450.826228ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.30221Z","caller":"traceutil/trace.go:171","msg":"trace[113035387] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26470; }","duration":"144.155918ms","start":"2026-04-22T14:45:57.158044Z","end":"2026-04-22T14:45:57.3022Z","steps":["trace[113035387] 'agreement among raft nodes before linearized reading' (duration: 144.033536ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.302233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.133886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.302237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"281.334877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:57.302277Z","caller":"traceutil/trace.go:171","msg":"trace[2100830277] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26470; }","duration":"286.198477ms","start":"2026-04-22T14:45:57.016068Z","end":"2026-04-22T14:45:57.302266Z","steps":["trace[2100830277] 'agreement among raft nodes before linearized reading' (duration: 286.137616ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.30228Z","caller":"traceutil/trace.go:171","msg":"trace[695629180] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26470; }","duration":"281.413787ms","start":"2026-04-22T14:45:57.020856Z","end":"2026-04-22T14:45:57.30227Z","steps":["trace[695629180] 'agreement among raft nodes before linearized reading' (duration: 281.355616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.30224Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:56.850786Z","time spent":"451.438239ms","remote":"127.0.0.1:51348","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-04-22T14:45:57.302337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.511995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:57.302388Z","caller":"traceutil/trace.go:171","msg":"trace[740446478] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26470; }","duration":"284.586096ms","start":"2026-04-22T14:45:57.017788Z","end":"2026-04-22T14:45:57.302374Z","steps":["trace[740446478] 'agreement among raft nodes before linearized reading' (duration: 284.444934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.30204Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"493.33507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:57.302495Z","caller":"traceutil/trace.go:171","msg":"trace[2142076333] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26470; }","duration":"493.807929ms","start":"2026-04-22T14:45:56.808677Z","end":"2026-04-22T14:45:57.302485Z","steps":["trace[2142076333] 'agreement among raft nodes before linearized reading' (duration: 493.320359ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.30253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:56.808667Z","time spent":"493.851831ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"warn","ts":"2026-04-22T14:45:57.301713Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.664686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:57.302595Z","caller":"traceutil/trace.go:171","msg":"trace[308125811] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26470; }","duration":"280.581683ms","start":"2026-04-22T14:45:57.022007Z","end":"2026-04-22T14:45:57.302589Z","steps":["trace[308125811] 'agreement among raft nodes before linearized reading' (duration: 279.566534ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.301693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.186369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.302704Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.751808ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:57.302716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.336091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:57.30298Z","caller":"traceutil/trace.go:171","msg":"trace[1534878407] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26470; }","duration":"285.2691ms","start":"2026-04-22T14:45:57.017441Z","end":"2026-04-22T14:45:57.30271Z","steps":["trace[1534878407] 'agreement among raft nodes before linearized reading' (duration: 284.097798ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.303039Z","caller":"traceutil/trace.go:171","msg":"trace[182242212] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26470; }","duration":"286.820239ms","start":"2026-04-22T14:45:57.015937Z","end":"2026-04-22T14:45:57.302757Z","steps":["trace[182242212] 'agreement among raft nodes before linearized reading' (duration: 285.654097ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.303064Z","caller":"traceutil/trace.go:171","msg":"trace[228963585] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26470; }","duration":"285.421763ms","start":"2026-04-22T14:45:57.017342Z","end":"2026-04-22T14:45:57.302764Z","steps":["trace[228963585] 'agreement among raft nodes before linearized reading' (duration: 284.260111ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.423737Z","caller":"traceutil/trace.go:171","msg":"trace[75941910] transaction","detail":"{read_only:false; response_revision:26471; number_of_response:1; }","duration":"116.017394ms","start":"2026-04-22T14:45:57.307691Z","end":"2026-04-22T14:45:57.423708Z","steps":["trace[75941910] 'process raft request' (duration: 115.088376ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.667764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.246221ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:45:57.667945Z","caller":"traceutil/trace.go:171","msg":"trace[523432485] transaction","detail":"{read_only:false; response_revision:26472; number_of_response:1; }","duration":"359.82964ms","start":"2026-04-22T14:45:57.308089Z","end":"2026-04-22T14:45:57.667918Z","steps":["trace[523432485] 'process raft request' (duration: 245.362835ms)","trace[523432485] 'compare' (duration: 113.842204ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:57.667997Z","caller":"traceutil/trace.go:171","msg":"trace[1433482126] transaction","detail":"{read_only:false; response_revision:26473; number_of_response:1; }","duration":"359.393752ms","start":"2026-04-22T14:45:57.308575Z","end":"2026-04-22T14:45:57.667969Z","steps":["trace[1433482126] 'process raft request' (duration: 359.262819ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:57.668055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.308077Z","time spent":"359.914851ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:57.668055Z","caller":"traceutil/trace.go:171","msg":"trace[449731554] linearizableReadLoop","detail":"{readStateIndex:27327; appliedIndex:27325; }","duration":"359.503114ms","start":"2026-04-22T14:45:57.30852Z","end":"2026-04-22T14:45:57.668023Z","steps":["trace[449731554] 'read index received' (duration: 114.253819ms)","trace[449731554] 'applied index is now lower than readState.Index' (duration: 245.248215ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:57.668132Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.308567Z","time spent":"359.493253ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:45:57.849711Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.76048ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-04-22T14:45:57.850046Z","caller":"traceutil/trace.go:171","msg":"trace[965446769] linearizableReadLoop","detail":"{readStateIndex:27330; appliedIndex:27328; }","duration":"181.933083ms","start":"2026-04-22T14:45:57.668083Z","end":"2026-04-22T14:45:57.850017Z","steps":["trace[965446769] 'read index received' (duration: 142.890445ms)","trace[965446769] 'applied index is now lower than readState.Index' (duration: 39.040568ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:57.850104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"541.537248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18745"} {"level":"info","ts":"2026-04-22T14:45:57.850139Z","caller":"traceutil/trace.go:171","msg":"trace[1733995177] transaction","detail":"{read_only:false; response_revision:26474; number_of_response:1; }","duration":"191.766796ms","start":"2026-04-22T14:45:57.658304Z","end":"2026-04-22T14:45:57.85007Z","steps":["trace[1733995177] 'process raft request' (duration: 191.524571ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:57.850192Z","caller":"traceutil/trace.go:171","msg":"trace[1941607435] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26473; }","duration":"541.66322ms","start":"2026-04-22T14:45:57.308505Z","end":"2026-04-22T14:45:57.850168Z","steps":["trace[1941607435] 'agreement among raft nodes before linearized reading' (duration: 359.598175ms)","trace[1941607435] 'range keys from in-memory index tree' (duration: 181.565626ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:57.850259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.308496Z","time spent":"541.749633ms","remote":"127.0.0.1:51250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18768,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-04-22T14:45:58.118313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"522.051367ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:58.1184Z","caller":"traceutil/trace.go:171","msg":"trace[1535789883] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:26474; }","duration":"522.185189ms","start":"2026-04-22T14:45:57.596194Z","end":"2026-04-22T14:45:58.118379Z","steps":["trace[1535789883] 'agreement among raft nodes before linearized reading' (duration: 253.956296ms)","trace[1535789883] 'count revisions from in-memory index tree' (duration: 268.08168ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:58.118443Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.596176Z","time spent":"522.25669ms","remote":"127.0.0.1:51284","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":29,"request content":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true "} {"level":"warn","ts":"2026-04-22T14:45:58.118423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.727437ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:45:58.118643Z","caller":"traceutil/trace.go:171","msg":"trace[1686204582] transaction","detail":"{read_only:false; response_revision:26475; number_of_response:1; }","duration":"314.430084ms","start":"2026-04-22T14:45:57.804174Z","end":"2026-04-22T14:45:58.118604Z","steps":["trace[1686204582] 'process raft request' (duration: 56.433683ms)","trace[1686204582] 'compare' (duration: 257.588443ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:58.118688Z","caller":"traceutil/trace.go:171","msg":"trace[1485495290] transaction","detail":"{read_only:false; response_revision:26476; number_of_response:1; }","duration":"196.22904ms","start":"2026-04-22T14:45:57.922439Z","end":"2026-04-22T14:45:58.118668Z","steps":["trace[1485495290] 'process raft request' (duration: 196.106398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:58.118838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.424949ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:58.118816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.804146Z","time spent":"314.579226ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:58.118874Z","caller":"traceutil/trace.go:171","msg":"trace[188229793] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26476; }","duration":"340.4888ms","start":"2026-04-22T14:45:57.778373Z","end":"2026-04-22T14:45:58.118862Z","steps":["trace[188229793] 'agreement among raft nodes before linearized reading' (duration: 340.423529ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:58.118902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.778356Z","time spent":"340.540921ms","remote":"127.0.0.1:51054","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-04-22T14:45:58.119292Z","caller":"traceutil/trace.go:171","msg":"trace[701889562] linearizableReadLoop","detail":"{readStateIndex:27331; appliedIndex:27330; }","duration":"268.536038ms","start":"2026-04-22T14:45:57.85012Z","end":"2026-04-22T14:45:58.118656Z","steps":["trace[701889562] 'read index received' (duration: 10.432185ms)","trace[701889562] 'applied index is now lower than readState.Index' (duration: 258.099743ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:58.33134Z","caller":"traceutil/trace.go:171","msg":"trace[659538873] linearizableReadLoop","detail":"{readStateIndex:27333; appliedIndex:27332; }","duration":"211.939483ms","start":"2026-04-22T14:45:58.119375Z","end":"2026-04-22T14:45:58.331314Z","steps":["trace[659538873] 'read index received' (duration: 211.716849ms)","trace[659538873] 'applied index is now lower than readState.Index' (duration: 221.604µs)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:58.33143Z","caller":"traceutil/trace.go:171","msg":"trace[794533314] transaction","detail":"{read_only:false; response_revision:26477; number_of_response:1; }","duration":"408.512828ms","start":"2026-04-22T14:45:57.922895Z","end":"2026-04-22T14:45:58.331408Z","steps":["trace[794533314] 'process raft request' (duration: 408.202343ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:58.33151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"382.996773ms","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-04-22T14:45:58.33155Z","caller":"traceutil/trace.go:171","msg":"trace[238787028] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26477; }","duration":"383.080105ms","start":"2026-04-22T14:45:57.94846Z","end":"2026-04-22T14:45:58.33154Z","steps":["trace[238787028] 'agreement among raft nodes before linearized reading' (duration: 382.987953ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:58.331558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.922888Z","time spent":"408.59131ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:45:58.331582Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:57.948446Z","time spent":"383.128435ms","remote":"127.0.0.1:51550","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":29,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-04-22T14:45:58.331694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.331682ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:58.331815Z","caller":"traceutil/trace.go:171","msg":"trace[403949217] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26477; }","duration":"211.504455ms","start":"2026-04-22T14:45:58.12028Z","end":"2026-04-22T14:45:58.331784Z","steps":["trace[403949217] 'agreement among raft nodes before linearized reading' (duration: 211.291561ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:58.522868Z","caller":"traceutil/trace.go:171","msg":"trace[854640168] transaction","detail":"{read_only:false; response_revision:26478; number_of_response:1; }","duration":"142.000709ms","start":"2026-04-22T14:45:58.380832Z","end":"2026-04-22T14:45:58.522833Z","steps":["trace[854640168] 'process raft request' (duration: 42.963372ms)","trace[854640168] 'compare' (duration: 98.632489ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:45:58.931361Z","caller":"traceutil/trace.go:171","msg":"trace[1803238121] linearizableReadLoop","detail":"{readStateIndex:27335; appliedIndex:27334; }","duration":"119.914006ms","start":"2026-04-22T14:45:58.811422Z","end":"2026-04-22T14:45:58.931336Z","steps":["trace[1803238121] 'read index received' (duration: 119.693262ms)","trace[1803238121] 'applied index is now lower than readState.Index' (duration: 219.964µs)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:58.931489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.050149ms","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-04-22T14:45:58.931504Z","caller":"traceutil/trace.go:171","msg":"trace[962568677] transaction","detail":"{read_only:false; response_revision:26479; number_of_response:1; }","duration":"120.62358ms","start":"2026-04-22T14:45:58.81084Z","end":"2026-04-22T14:45:58.931463Z","steps":["trace[962568677] 'process raft request' (duration: 120.348615ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:58.931532Z","caller":"traceutil/trace.go:171","msg":"trace[1129743616] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26479; }","duration":"120.130941ms","start":"2026-04-22T14:45:58.811387Z","end":"2026-04-22T14:45:58.931518Z","steps":["trace[1129743616] 'agreement among raft nodes before linearized reading' (duration: 120.047169ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.337943Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.016512ms","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-04-22T14:45:59.338023Z","caller":"traceutil/trace.go:171","msg":"trace[1510256998] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:26479; }","duration":"280.140894ms","start":"2026-04-22T14:45:59.057863Z","end":"2026-04-22T14:45:59.338004Z","steps":["trace[1510256998] 'count revisions from in-memory index tree' (duration: 279.93295ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.338316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.420266ms","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-04-22T14:45:59.338353Z","caller":"traceutil/trace.go:171","msg":"trace[428328011] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26479; }","duration":"268.496627ms","start":"2026-04-22T14:45:59.069847Z","end":"2026-04-22T14:45:59.338344Z","steps":["trace[428328011] 'range keys from in-memory index tree' (duration: 268.275483ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.338597Z","caller":"traceutil/trace.go:171","msg":"trace[1435857609] transaction","detail":"{read_only:false; response_revision:26480; number_of_response:1; }","duration":"197.800658ms","start":"2026-04-22T14:45:59.140779Z","end":"2026-04-22T14:45:59.33858Z","steps":["trace[1435857609] 'process raft request' (duration: 179.07982ms)","trace[1435857609] 'compare' (duration: 17.811422ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:59.698158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"233.23507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-04-22T14:45:59.698444Z","caller":"traceutil/trace.go:171","msg":"trace[818728229] transaction","detail":"{read_only:false; response_revision:26484; number_of_response:1; }","duration":"354.649514ms","start":"2026-04-22T14:45:59.343776Z","end":"2026-04-22T14:45:59.698426Z","steps":["trace[818728229] 'process raft request' (duration: 354.614633ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.698567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.343761Z","time spent":"354.763167ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:59.698637Z","caller":"traceutil/trace.go:171","msg":"trace[799608561] transaction","detail":"{read_only:false; response_revision:26482; number_of_response:1; }","duration":"390.944541ms","start":"2026-04-22T14:45:59.30767Z","end":"2026-04-22T14:45:59.698614Z","steps":["trace[799608561] 'process raft request' (duration: 390.602775ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.698668Z","caller":"traceutil/trace.go:171","msg":"trace[2072251111] transaction","detail":"{read_only:false; response_revision:26483; number_of_response:1; }","duration":"388.749551ms","start":"2026-04-22T14:45:59.309884Z","end":"2026-04-22T14:45:59.698633Z","steps":["trace[2072251111] 'process raft request' (duration: 388.465206ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.698706Z","caller":"traceutil/trace.go:171","msg":"trace[1511229471] linearizableReadLoop","detail":"{readStateIndex:27339; appliedIndex:27336; }","duration":"360.161617ms","start":"2026-04-22T14:45:59.338502Z","end":"2026-04-22T14:45:59.698663Z","steps":["trace[1511229471] 'read index received' (duration: 126.337846ms)","trace[1511229471] 'applied index is now lower than readState.Index' (duration: 233.820171ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:59.698849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.309857Z","time spent":"388.899823ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:45:59.698923Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.101205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:59.69896Z","caller":"traceutil/trace.go:171","msg":"trace[1539668229] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26484; }","duration":"383.166265ms","start":"2026-04-22T14:45:59.315782Z","end":"2026-04-22T14:45:59.698949Z","steps":["trace[1539668229] 'agreement among raft nodes before linearized reading' (duration: 383.037703ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.825059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.315775Z","time spent":"383.210337ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"warn","ts":"2026-04-22T14:45:59.698985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.763978ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.69902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.264388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:59.699039Z","caller":"traceutil/trace.go:171","msg":"trace[458663503] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26484; }","duration":"390.86945ms","start":"2026-04-22T14:45:59.308154Z","end":"2026-04-22T14:45:59.699023Z","steps":["trace[458663503] 'agreement among raft nodes before linearized reading' (duration: 390.815419ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.699063Z","caller":"traceutil/trace.go:171","msg":"trace[75882042] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26484; }","duration":"390.314929ms","start":"2026-04-22T14:45:59.308734Z","end":"2026-04-22T14:45:59.699049Z","steps":["trace[75882042] 'agreement among raft nodes before linearized reading' (duration: 390.149226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.69907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.308148Z","time spent":"390.915661ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.235027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"warn","ts":"2026-04-22T14:45:59.699097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.30873Z","time spent":"390.3598ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5030,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"info","ts":"2026-04-22T14:45:59.699117Z","caller":"traceutil/trace.go:171","msg":"trace[1257686286] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26484; }","duration":"391.285697ms","start":"2026-04-22T14:45:59.30782Z","end":"2026-04-22T14:45:59.699106Z","steps":["trace[1257686286] 'agreement among raft nodes before linearized reading' (duration: 391.091964ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.89644ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.652597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-04-22T14:45:59.699148Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.307815Z","time spent":"391.322668ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5030,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"info","ts":"2026-04-22T14:45:59.699155Z","caller":"traceutil/trace.go:171","msg":"trace[254116108] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26484; }","duration":"390.944491ms","start":"2026-04-22T14:45:59.308203Z","end":"2026-04-22T14:45:59.699147Z","steps":["trace[254116108] 'agreement among raft nodes before linearized reading' (duration: 390.89879ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.819958ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:59.699167Z","caller":"traceutil/trace.go:171","msg":"trace[1653513330] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26484; }","duration":"270.728359ms","start":"2026-04-22T14:45:59.428427Z","end":"2026-04-22T14:45:59.699156Z","steps":["trace[1653513330] 'agreement among raft nodes before linearized reading' (duration: 270.566336ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.69912Z","caller":"traceutil/trace.go:171","msg":"trace[462058230] transaction","detail":"{read_only:false; response_revision:26481; number_of_response:1; }","duration":"391.537863ms","start":"2026-04-22T14:45:59.307528Z","end":"2026-04-22T14:45:59.699066Z","steps":["trace[462058230] 'process raft request' (duration: 157.307214ms)","trace[462058230] 'compare' (duration: 233.089148ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:45:59.699191Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.308198Z","time spent":"390.985522ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"info","ts":"2026-04-22T14:45:59.699199Z","caller":"traceutil/trace.go:171","msg":"trace[907289041] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26484; }","duration":"390.886679ms","start":"2026-04-22T14:45:59.308298Z","end":"2026-04-22T14:45:59.699185Z","steps":["trace[907289041] 'agreement among raft nodes before linearized reading' (duration: 390.795477ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.647245ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"388.505685ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.308293Z","time spent":"390.936571ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"info","ts":"2026-04-22T14:45:59.699244Z","caller":"traceutil/trace.go:171","msg":"trace[3378579] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26484; }","duration":"383.692186ms","start":"2026-04-22T14:45:59.315542Z","end":"2026-04-22T14:45:59.699234Z","steps":["trace[3378579] 'agreement among raft nodes before linearized reading' (duration: 383.653005ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.699249Z","caller":"traceutil/trace.go:171","msg":"trace[145008655] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26484; }","duration":"388.588808ms","start":"2026-04-22T14:45:59.310651Z","end":"2026-04-22T14:45:59.69924Z","steps":["trace[145008655] 'agreement among raft nodes before linearized reading' (duration: 388.528807ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.315535Z","time spent":"383.730116ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"info","ts":"2026-04-22T14:45:59.699069Z","caller":"traceutil/trace.go:171","msg":"trace[1587354065] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26484; }","duration":"390.852679ms","start":"2026-04-22T14:45:59.308193Z","end":"2026-04-22T14:45:59.699046Z","steps":["trace[1587354065] 'agreement among raft nodes before linearized reading' (duration: 390.698226ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.6993Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.822467ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.697708ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.308179Z","time spent":"391.136735ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"info","ts":"2026-04-22T14:45:59.699337Z","caller":"traceutil/trace.go:171","msg":"trace[1656838838] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26484; }","duration":"389.732498ms","start":"2026-04-22T14:45:59.309597Z","end":"2026-04-22T14:45:59.699329Z","steps":["trace[1656838838] 'agreement among raft nodes before linearized reading' (duration: 389.696848ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.69933Z","caller":"traceutil/trace.go:171","msg":"trace[1643995542] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:26484; }","duration":"199.893387ms","start":"2026-04-22T14:45:59.499427Z","end":"2026-04-22T14:45:59.69932Z","steps":["trace[1643995542] 'agreement among raft nodes before linearized reading' (duration: 199.836806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699341Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.722647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.309592Z","time spent":"389.765119ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"383.804818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.307518Z","time spent":"391.711106ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:59.699376Z","caller":"traceutil/trace.go:171","msg":"trace[1227589834] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26484; }","duration":"390.765757ms","start":"2026-04-22T14:45:59.308602Z","end":"2026-04-22T14:45:59.699367Z","steps":["trace[1227589834] 'agreement among raft nodes before linearized reading' (duration: 390.711726ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.699398Z","caller":"traceutil/trace.go:171","msg":"trace[17631325] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26484; }","duration":"383.865008ms","start":"2026-04-22T14:45:59.315524Z","end":"2026-04-22T14:45:59.699389Z","steps":["trace[17631325] 'agreement among raft nodes before linearized reading' (duration: 383.813558ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699174Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"387.771351ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:45:59.699415Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.308597Z","time spent":"390.811088ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699425Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.315518Z","time spent":"383.900769ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"390.276338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:45:59.699449Z","caller":"traceutil/trace.go:171","msg":"trace[779293055] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26484; }","duration":"388.064546ms","start":"2026-04-22T14:45:59.311373Z","end":"2026-04-22T14:45:59.699438Z","steps":["trace[779293055] 'agreement among raft nodes before linearized reading' (duration: 387.773301ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.699455Z","caller":"traceutil/trace.go:171","msg":"trace[1927777549] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26484; }","duration":"390.311219ms","start":"2026-04-22T14:45:59.309135Z","end":"2026-04-22T14:45:59.699446Z","steps":["trace[1927777549] 'agreement among raft nodes before linearized reading' (duration: 390.266398ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699276Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.310635Z","time spent":"388.635728ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-rabbit-init\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699487Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.31136Z","time spent":"388.117148ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699486Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.30913Z","time spent":"390.350219ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":0,"response size":29,"request content":"key:\"/registry/jobs/openstack/manila-ks-user\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699521Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.226246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:45:59.699565Z","caller":"traceutil/trace.go:171","msg":"trace[855822417] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26484; }","duration":"384.291206ms","start":"2026-04-22T14:45:59.315261Z","end":"2026-04-22T14:45:59.699553Z","steps":["trace[855822417] 'agreement among raft nodes before linearized reading' (duration: 384.192225ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:45:59.699594Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.315251Z","time spent":"384.336467ms","remote":"127.0.0.1:51314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":41,"response count":1,"response size":5030,"request content":"key:\"/registry/jobs/openstack/manila-db-sync\" "} {"level":"warn","ts":"2026-04-22T14:45:59.699723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:45:59.307655Z","time spent":"391.031693ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:45:59.837027Z","caller":"traceutil/trace.go:171","msg":"trace[1118608402] transaction","detail":"{read_only:false; response_revision:26486; number_of_response:1; }","duration":"131.836278ms","start":"2026-04-22T14:45:59.705164Z","end":"2026-04-22T14:45:59.837Z","steps":["trace[1118608402] 'process raft request' (duration: 130.128437ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:45:59.83748Z","caller":"traceutil/trace.go:171","msg":"trace[993015900] transaction","detail":"{read_only:false; response_revision:26487; number_of_response:1; }","duration":"131.028122ms","start":"2026-04-22T14:45:59.706411Z","end":"2026-04-22T14:45:59.837439Z","steps":["trace[993015900] 'process raft request' (duration: 130.537844ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:00.00689Z","caller":"traceutil/trace.go:171","msg":"trace[1019952929] transaction","detail":"{read_only:false; response_revision:26488; number_of_response:1; }","duration":"151.341323ms","start":"2026-04-22T14:45:59.855517Z","end":"2026-04-22T14:46:00.006858Z","steps":["trace[1019952929] 'process raft request' (duration: 147.043422ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:00.680788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.30833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/magnum-api-bf9c8b96f-q9wsz\" ","response":"range_response_count:1 size:8824"} {"level":"info","ts":"2026-04-22T14:46:00.682181Z","caller":"traceutil/trace.go:171","msg":"trace[984797845] range","detail":"{range_begin:/registry/pods/openstack/magnum-api-bf9c8b96f-q9wsz; range_end:; response_count:1; response_revision:26491; }","duration":"175.740307ms","start":"2026-04-22T14:46:00.506421Z","end":"2026-04-22T14:46:00.682162Z","steps":["trace[984797845] 'range keys from in-memory index tree' (duration: 174.130407ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:00.680893Z","caller":"traceutil/trace.go:171","msg":"trace[1489177410] linearizableReadLoop","detail":"{readStateIndex:27348; appliedIndex:27347; }","duration":"148.56915ms","start":"2026-04-22T14:46:00.532298Z","end":"2026-04-22T14:46:00.680867Z","steps":["trace[1489177410] 'read index received' (duration: 84.077408ms)","trace[1489177410] 'applied index is now lower than readState.Index' (duration: 64.482242ms)"],"step_count":2} {"level":"warn","ts":"2026-04-22T14:46:00.680999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.682993ms","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-04-22T14:46:00.683341Z","caller":"traceutil/trace.go:171","msg":"trace[814704598] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinepools/; range_end:/registry/cluster.x-k8s.io/machinepools0; response_count:0; response_revision:26492; }","duration":"151.052766ms","start":"2026-04-22T14:46:00.532272Z","end":"2026-04-22T14:46:00.683325Z","steps":["trace[814704598] 'agreement among raft nodes before linearized reading' (duration: 148.664833ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:00.681034Z","caller":"traceutil/trace.go:171","msg":"trace[1846426125] transaction","detail":"{read_only:false; response_revision:26492; number_of_response:1; }","duration":"151.932554ms","start":"2026-04-22T14:46:00.52909Z","end":"2026-04-22T14:46:00.681022Z","steps":["trace[1846426125] 'process raft request' (duration: 87.331119ms)","trace[1846426125] 'compare' (duration: 64.040134ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:46:12.312593Z","caller":"traceutil/trace.go:171","msg":"trace[1259665913] transaction","detail":"{read_only:false; response_revision:26581; number_of_response:1; }","duration":"138.518734ms","start":"2026-04-22T14:46:12.174046Z","end":"2026-04-22T14:46:12.312565Z","steps":["trace[1259665913] 'process raft request' (duration: 138.441452ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:12.312993Z","caller":"traceutil/trace.go:171","msg":"trace[2018417479] transaction","detail":"{read_only:false; response_revision:26580; number_of_response:1; }","duration":"172.335945ms","start":"2026-04-22T14:46:12.140618Z","end":"2026-04-22T14:46:12.312954Z","steps":["trace[2018417479] 'process raft request' (duration: 171.796585ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:12.313064Z","caller":"traceutil/trace.go:171","msg":"trace[2084835931] transaction","detail":"{read_only:false; response_revision:26579; number_of_response:1; }","duration":"239.291163ms","start":"2026-04-22T14:46:12.073747Z","end":"2026-04-22T14:46:12.313038Z","steps":["trace[2084835931] 'process raft request' (duration: 192.386148ms)","trace[2084835931] 'compare' (duration: 46.09195ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:46:31.64496Z","caller":"traceutil/trace.go:171","msg":"trace[13052868] transaction","detail":"{read_only:false; response_revision:26732; number_of_response:1; }","duration":"118.038001ms","start":"2026-04-22T14:46:31.526889Z","end":"2026-04-22T14:46:31.644927Z","steps":["trace[13052868] 'process raft request' (duration: 117.858668ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.030514Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.31383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.030592Z","caller":"traceutil/trace.go:171","msg":"trace[891021205] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26732; }","duration":"248.439922ms","start":"2026-04-22T14:46:31.782134Z","end":"2026-04-22T14:46:32.030574Z","steps":["trace[891021205] 'range keys from in-memory index tree' (duration: 248.232759ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.030592Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.661252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodeconfigs/\" range_end:\"/registry/cilium.io/ciliumnodeconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:46:32.030631Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.197254ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.030699Z","caller":"traceutil/trace.go:171","msg":"trace[725154987] range","detail":"{range_begin:/registry/cilium.io/ciliumnodeconfigs/; range_end:/registry/cilium.io/ciliumnodeconfigs0; response_count:0; response_revision:26732; }","duration":"274.846846ms","start":"2026-04-22T14:46:31.755822Z","end":"2026-04-22T14:46:32.030669Z","steps":["trace[725154987] 'count revisions from in-memory index tree' (duration: 274.55939ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.030729Z","caller":"traceutil/trace.go:171","msg":"trace[1577327067] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26732; }","duration":"251.348097ms","start":"2026-04-22T14:46:31.77936Z","end":"2026-04-22T14:46:32.030708Z","steps":["trace[1577327067] 'range keys from in-memory index tree' (duration: 251.123003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.030748Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.570597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.030823Z","caller":"traceutil/trace.go:171","msg":"trace[971728247] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26732; }","duration":"247.663948ms","start":"2026-04-22T14:46:31.783137Z","end":"2026-04-22T14:46:32.030801Z","steps":["trace[971728247] 'range keys from in-memory index tree' (duration: 247.516406ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.03082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.37332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.030902Z","caller":"traceutil/trace.go:171","msg":"trace[923686794] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26732; }","duration":"249.495863ms","start":"2026-04-22T14:46:31.781397Z","end":"2026-04-22T14:46:32.030893Z","steps":["trace[923686794] 'range keys from in-memory index tree' (duration: 249.295069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.906946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.031091Z","caller":"traceutil/trace.go:171","msg":"trace[1287224955] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26732; }","duration":"247.001567ms","start":"2026-04-22T14:46:31.784082Z","end":"2026-04-22T14:46:32.031084Z","steps":["trace[1287224955] 'range keys from in-memory index tree' (duration: 246.794234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.686165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:46:32.031197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"243.516171ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.031219Z","caller":"traceutil/trace.go:171","msg":"trace[1018639381] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26732; }","duration":"243.557982ms","start":"2026-04-22T14:46:31.787654Z","end":"2026-04-22T14:46:32.031212Z","steps":["trace[1018639381] 'range keys from in-memory index tree' (duration: 243.392279ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.031224Z","caller":"traceutil/trace.go:171","msg":"trace[685732762] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26732; }","duration":"243.753766ms","start":"2026-04-22T14:46:31.787455Z","end":"2026-04-22T14:46:32.031209Z","steps":["trace[685732762] 'range keys from in-memory index tree' (duration: 243.648734ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.725167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:46:32.031399Z","caller":"traceutil/trace.go:171","msg":"trace[1605726188] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26732; }","duration":"242.773528ms","start":"2026-04-22T14:46:31.788618Z","end":"2026-04-22T14:46:32.031391Z","steps":["trace[1605726188] 'range keys from in-memory index tree' (duration: 242.593974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.220173ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-04-22T14:46:32.031523Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.161747ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:46:32.031583Z","caller":"traceutil/trace.go:171","msg":"trace[1226252893] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26732; }","duration":"241.242409ms","start":"2026-04-22T14:46:31.790329Z","end":"2026-04-22T14:46:32.031571Z","steps":["trace[1226252893] 'range keys from in-memory index tree' (duration: 241.017844ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.284265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.03163Z","caller":"traceutil/trace.go:171","msg":"trace[668108577] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26732; }","duration":"244.355396ms","start":"2026-04-22T14:46:31.787262Z","end":"2026-04-22T14:46:32.031617Z","steps":["trace[668108577] 'range keys from in-memory index tree' (duration: 244.221364ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.03164Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.956947ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.033955Z","caller":"traceutil/trace.go:171","msg":"trace[1036484407] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26732; }","duration":"248.326891ms","start":"2026-04-22T14:46:31.785615Z","end":"2026-04-22T14:46:32.033942Z","steps":["trace[1036484407] 'range keys from in-memory index tree' (duration: 245.856635ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.132042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-endpoints\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.034211Z","caller":"traceutil/trace.go:171","msg":"trace[1003950531] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-endpoints; range_end:; response_count:0; response_revision:26732; }","duration":"248.015425ms","start":"2026-04-22T14:46:31.786185Z","end":"2026-04-22T14:46:32.0342Z","steps":["trace[1003950531] 'range keys from in-memory index tree' (duration: 244.99974ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.031525Z","caller":"traceutil/trace.go:171","msg":"trace[1802814892] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26732; }","duration":"245.303605ms","start":"2026-04-22T14:46:31.786204Z","end":"2026-04-22T14:46:32.031508Z","steps":["trace[1802814892] 'range keys from in-memory index tree' (duration: 245.109552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031816Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.222582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-db-sync\" ","response":"range_response_count:1 size:5007"} {"level":"info","ts":"2026-04-22T14:46:32.03442Z","caller":"traceutil/trace.go:171","msg":"trace[1586306817] range","detail":"{range_begin:/registry/jobs/openstack/manila-db-sync; range_end:; response_count:1; response_revision:26732; }","duration":"241.83073ms","start":"2026-04-22T14:46:31.79257Z","end":"2026-04-22T14:46:32.034401Z","steps":["trace[1586306817] 'range keys from in-memory index tree' (duration: 239.146581ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.031912Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.478448ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-ks-user\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.034522Z","caller":"traceutil/trace.go:171","msg":"trace[1998588928] range","detail":"{range_begin:/registry/jobs/openstack/manila-ks-user; range_end:; response_count:0; response_revision:26732; }","duration":"247.086758ms","start":"2026-04-22T14:46:31.787411Z","end":"2026-04-22T14:46:32.034498Z","steps":["trace[1998588928] 'range keys from in-memory index tree' (duration: 244.430768ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.03268Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.669185ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"warn","ts":"2026-04-22T14:46:32.032868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.918065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/manila-rabbit-init\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-04-22T14:46:32.034635Z","caller":"traceutil/trace.go:171","msg":"trace[2105001070] range","detail":"{range_begin:/registry/jobs/openstack/manila-rabbit-init; range_end:; response_count:0; response_revision:26732; }","duration":"248.712918ms","start":"2026-04-22T14:46:31.785911Z","end":"2026-04-22T14:46:32.034624Z","steps":["trace[2105001070] 'range keys from in-memory index tree' (duration: 245.753883ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.034757Z","caller":"traceutil/trace.go:171","msg":"trace[323505944] transaction","detail":"{read_only:false; response_revision:26733; number_of_response:1; }","duration":"186.311604ms","start":"2026-04-22T14:46:31.848396Z","end":"2026-04-22T14:46:32.034708Z","steps":["trace[323505944] 'process raft request' (duration: 44.53473ms)","trace[323505944] 'compare' (duration: 138.455423ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:46:32.034791Z","caller":"traceutil/trace.go:171","msg":"trace[1762439909] linearizableReadLoop","detail":"{readStateIndex:27598; appliedIndex:27595; }","duration":"179.455577ms","start":"2026-04-22T14:46:31.855314Z","end":"2026-04-22T14:46:32.034769Z","steps":["trace[1762439909] 'read index received' (duration: 37.638072ms)","trace[1762439909] 'applied index is now lower than readState.Index' (duration: 141.816565ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:46:32.034872Z","caller":"traceutil/trace.go:171","msg":"trace[1722869610] transaction","detail":"{read_only:false; response_revision:26734; number_of_response:1; }","duration":"186.403557ms","start":"2026-04-22T14:46:31.848442Z","end":"2026-04-22T14:46:32.034846Z","steps":["trace[1722869610] 'process raft request' (duration: 186.182603ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.034904Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.592249ms","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-04-22T14:46:32.034938Z","caller":"traceutil/trace.go:171","msg":"trace[637483353] transaction","detail":"{read_only:false; response_revision:26735; number_of_response:1; }","duration":"186.412246ms","start":"2026-04-22T14:46:31.848506Z","end":"2026-04-22T14:46:32.034918Z","steps":["trace[637483353] 'process raft request' (duration: 186.219183ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.034943Z","caller":"traceutil/trace.go:171","msg":"trace[375426960] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26735; }","duration":"179.672231ms","start":"2026-04-22T14:46:31.855258Z","end":"2026-04-22T14:46:32.03493Z","steps":["trace[375426960] 'agreement among raft nodes before linearized reading' (duration: 179.565239ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.035027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.640742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-04-22T14:46:32.035057Z","caller":"traceutil/trace.go:171","msg":"trace[1731725536] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26735; }","duration":"140.710984ms","start":"2026-04-22T14:46:31.894339Z","end":"2026-04-22T14:46:32.03505Z","steps":["trace[1731725536] 'agreement among raft nodes before linearized reading' (duration: 140.632122ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.224719Z","caller":"traceutil/trace.go:171","msg":"trace[1484626258] transaction","detail":"{read_only:false; response_revision:26736; number_of_response:1; }","duration":"185.785456ms","start":"2026-04-22T14:46:32.038904Z","end":"2026-04-22T14:46:32.224689Z","steps":["trace[1484626258] 'process raft request' (duration: 125.838247ms)","trace[1484626258] 'compare' (duration: 59.630613ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:46:32.373529Z","caller":"traceutil/trace.go:171","msg":"trace[1528404949] transaction","detail":"{read_only:false; response_revision:26739; number_of_response:1; }","duration":"325.909309ms","start":"2026-04-22T14:46:32.047596Z","end":"2026-04-22T14:46:32.373505Z","steps":["trace[1528404949] 'process raft request' (duration: 325.794347ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.373528Z","caller":"traceutil/trace.go:171","msg":"trace[1754625491] transaction","detail":"{read_only:false; response_revision:26738; number_of_response:1; }","duration":"333.547121ms","start":"2026-04-22T14:46:32.039946Z","end":"2026-04-22T14:46:32.373493Z","steps":["trace[1754625491] 'process raft request' (duration: 333.356857ms)"],"step_count":1} {"level":"info","ts":"2026-04-22T14:46:32.373661Z","caller":"traceutil/trace.go:171","msg":"trace[1616211032] transaction","detail":"{read_only:false; response_revision:26737; number_of_response:1; }","duration":"334.56934ms","start":"2026-04-22T14:46:32.039057Z","end":"2026-04-22T14:46:32.373626Z","steps":["trace[1616211032] 'process raft request' (duration: 325.709215ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.373691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:46:32.047578Z","time spent":"326.01785ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:46:32.373718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:46:32.039928Z","time spent":"333.680173ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-22T14:46:32.374051Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:46:32.039049Z","time spent":"334.690062ms","remote":"127.0.0.1:51348","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-22T14:46:32.374117Z","caller":"traceutil/trace.go:171","msg":"trace[1737435630] linearizableReadLoop","detail":"{readStateIndex:27602; appliedIndex:27598; }","duration":"317.338128ms","start":"2026-04-22T14:46:32.056758Z","end":"2026-04-22T14:46:32.374096Z","steps":["trace[1737435630] 'read index received' (duration: 107.978263ms)","trace[1737435630] 'applied index is now lower than readState.Index' (duration: 209.358255ms)"],"step_count":2} {"level":"info","ts":"2026-04-22T14:46:32.37425Z","caller":"traceutil/trace.go:171","msg":"trace[1271094338] transaction","detail":"{read_only:false; response_revision:26740; number_of_response:1; }","duration":"252.956967ms","start":"2026-04-22T14:46:32.121274Z","end":"2026-04-22T14:46:32.374231Z","steps":["trace[1271094338] 'process raft request' (duration: 252.157982ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.374837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.066611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.10\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-04-22T14:46:32.374907Z","caller":"traceutil/trace.go:171","msg":"trace[1464752771] range","detail":"{range_begin:/registry/masterleases/199.19.213.10; range_end:; response_count:1; response_revision:26740; }","duration":"318.169873ms","start":"2026-04-22T14:46:32.05672Z","end":"2026-04-22T14:46:32.37489Z","steps":["trace[1464752771] 'agreement among raft nodes before linearized reading' (duration: 317.44048ms)"],"step_count":1} {"level":"warn","ts":"2026-04-22T14:46:32.374955Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-22T14:46:32.056708Z","time spent":"318.237224ms","remote":"127.0.0.1:51084","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":160,"request content":"key:\"/registry/masterleases/199.19.213.10\" "} {"level":"info","ts":"2026-04-22T14:46:55.758819Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c84.wal"} {"level":"info","ts":"2026-04-22T14:50:18.954617Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26191} {"level":"info","ts":"2026-04-22T14:50:19.091053Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26191,"took":"132.685075ms","hash":2935882506,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":34074624,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-22T14:50:19.091126Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2935882506,"revision":26191,"compact-revision":23351} {"level":"info","ts":"2026-04-22T14:50:43.076559Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"93eaf76b69bfff2c","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T14:50:43.084374Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-04-22T14:50:43.084468Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-04-22T14:55:18.961541Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28892} {"level":"info","ts":"2026-04-22T14:55:19.094685Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28892,"took":"128.767642ms","hash":1124842790,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":30830592,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-04-22T14:55:19.094767Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1124842790,"revision":28892,"compact-revision":26191} {"level":"info","ts":"2026-04-22T15:00:18.968513Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":31126} {"level":"info","ts":"2026-04-22T15:00:19.094578Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":31126,"took":"122.152601ms","hash":4171616745,"current-db-size-bytes":59023360,"current-db-size":"59 MB","current-db-size-in-use-bytes":30511104,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-04-22T15:00:19.094644Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4171616745,"revision":31126,"compact-revision":28892} {"level":"info","ts":"2026-04-22T15:05:18.982696Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33440} {"level":"info","ts":"2026-04-22T15:05:19.130629Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33440,"took":"144.01585ms","hash":4066524757,"current-db-size-bytes":61333504,"current-db-size":"61 MB","current-db-size-in-use-bytes":32477184,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-22T15:05:19.1307Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4066524757,"revision":33440,"compact-revision":31126} {"level":"info","ts":"2026-04-22T15:10:18.987714Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35792} {"level":"info","ts":"2026-04-22T15:10:19.131772Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35792,"took":"139.302463ms","hash":2000161505,"current-db-size-bytes":62631936,"current-db-size":"63 MB","current-db-size-in-use-bytes":31903744,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-22T15:10:19.131825Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2000161505,"revision":35792,"compact-revision":33440} {"level":"info","ts":"2026-04-22T15:11:58.101651Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"93eaf76b69bfff2c","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-22T15:11:58.108558Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-04-22T15:11:58.108691Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-04-22T15:15:18.995196Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":38021} {"level":"info","ts":"2026-04-22T15:15:19.110258Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":38021,"took":"109.036916ms","hash":942340209,"current-db-size-bytes":62631936,"current-db-size":"63 MB","current-db-size-in-use-bytes":32088064,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-04-22T15:15:19.110338Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":942340209,"revision":38021,"compact-revision":35792}