{"level":"warn","ts":"2026-06-16T01:15:52.493892Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T01:15:52.49398Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.95:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.95:2380","--initial-cluster=instance=https://199.204.45.95:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.95:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.95:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-16T01:15:52.494081Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-16T01:15:52.494094Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-06-16T01:15:52.494112Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-16T01:15:52.494731Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"]} {"level":"info","ts":"2026-06-16T01:15:52.494809Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.95:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-16T01:15:52.49883Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.825115ms"} {"level":"info","ts":"2026-06-16T01:15:52.506254Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"be773dfc027af3eb","cluster-id":"9ba5fbd7288fd5af"} {"level":"info","ts":"2026-06-16T01:15:52.50635Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=()"} {"level":"info","ts":"2026-06-16T01:15:52.506379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 0"} {"level":"info","ts":"2026-06-16T01:15:52.506396Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft be773dfc027af3eb [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-16T01:15:52.506417Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became follower at term 1"} {"level":"info","ts":"2026-06-16T01:15:52.506462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"warn","ts":"2026-06-16T01:15:52.513322Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-16T01:15:52.51503Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-16T01:15:52.51687Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-16T01:15:52.519511Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"be773dfc027af3eb","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-16T01:15:52.519631Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"be773dfc027af3eb","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-16T01:15:52.519819Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-16T01:15:52.519883Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-16T01:15:52.519893Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-16T01:15:52.520569Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb switched to configuration voters=(13724506542017541099)"} {"level":"info","ts":"2026-06-16T01:15:52.522361Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","added-peer-id":"be773dfc027af3eb","added-peer-peer-urls":["https://199.204.45.95:2380"]} {"level":"info","ts":"2026-06-16T01:15:52.525132Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-16T01:15:52.525366Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-06-16T01:15:52.525455Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.95:2380"} {"level":"info","ts":"2026-06-16T01:15:52.525774Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"be773dfc027af3eb","initial-advertise-peer-urls":["https://199.204.45.95:2380"],"listen-peer-urls":["https://199.204.45.95:2380"],"advertise-client-urls":["https://199.204.45.95:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.95:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-16T01:15:52.525878Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-16T01:15:53.507692Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb is starting a new election at term 1"} {"level":"info","ts":"2026-06-16T01:15:53.507757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became pre-candidate at term 1"} {"level":"info","ts":"2026-06-16T01:15:53.507799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgPreVoteResp from be773dfc027af3eb at term 1"} {"level":"info","ts":"2026-06-16T01:15:53.507819Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became candidate at term 2"} {"level":"info","ts":"2026-06-16T01:15:53.50783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb received MsgVoteResp from be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-06-16T01:15:53.507847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"be773dfc027af3eb became leader at term 2"} {"level":"info","ts":"2026-06-16T01:15:53.507861Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: be773dfc027af3eb elected leader be773dfc027af3eb at term 2"} {"level":"info","ts":"2026-06-16T01:15:53.509064Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T01:15:53.509979Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T01:15:53.510175Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-16T01:15:53.509988Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"be773dfc027af3eb","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.95:2379]}","request-path":"/0/members/be773dfc027af3eb/attributes","cluster-id":"9ba5fbd7288fd5af","publish-timeout":"7s"} {"level":"info","ts":"2026-06-16T01:15:53.510368Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-16T01:15:53.510435Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-16T01:15:53.510641Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9ba5fbd7288fd5af","local-member-id":"be773dfc027af3eb","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T01:15:53.510787Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T01:15:53.510833Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-16T01:15:53.513464Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.95:2379"} {"level":"info","ts":"2026-06-16T01:15:53.513492Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-16T01:16:35.240645Z","caller":"traceutil/trace.go:171","msg":"trace[1945793116] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"207.981023ms","start":"2026-06-16T01:16:35.032608Z","end":"2026-06-16T01:16:35.240589Z","steps":["trace[1945793116] 'process raft request' (duration: 207.207371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:16:35.764767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.040387ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-wp7l7\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-16T01:16:35.764925Z","caller":"traceutil/trace.go:171","msg":"trace[1654678801] range","detail":"{range_begin:/registry/pods/kube-system/cilium-wp7l7; range_end:; response_count:1; response_revision:590; }","duration":"252.255313ms","start":"2026-06-16T01:16:35.51264Z","end":"2026-06-16T01:16:35.764895Z","steps":["trace[1654678801] 'range keys from in-memory index tree' (duration: 251.904853ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:16:51.132814Z","caller":"traceutil/trace.go:171","msg":"trace[382349934] transaction","detail":"{read_only:false; response_revision:755; number_of_response:1; }","duration":"123.827803ms","start":"2026-06-16T01:16:51.008941Z","end":"2026-06-16T01:16:51.132769Z","steps":["trace[382349934] 'process raft request' (duration: 123.414222ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:18:07.067744Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.160826ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-74df3b57-d7d2-4759-8f97-1a3bacab17d4\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-16T01:18:07.067903Z","caller":"traceutil/trace.go:171","msg":"trace[349850852] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-74df3b57-d7d2-4759-8f97-1a3bacab17d4; range_end:; response_count:1; response_revision:1823; }","duration":"262.374093ms","start":"2026-06-16T01:18:06.805511Z","end":"2026-06-16T01:18:07.067885Z","steps":["trace[349850852] 'range keys from in-memory index tree' (duration: 261.948661ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:18:07.068003Z","caller":"traceutil/trace.go:171","msg":"trace[541248858] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"146.94364ms","start":"2026-06-16T01:18:06.921012Z","end":"2026-06-16T01:18:07.067955Z","steps":["trace[541248858] 'process raft request' (duration: 49.632641ms)","trace[541248858] 'compare' (duration: 97.082663ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:18:07.068294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.348805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T01:18:07.068458Z","caller":"traceutil/trace.go:171","msg":"trace[152278921] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1825; }","duration":"113.565561ms","start":"2026-06-16T01:18:06.954858Z","end":"2026-06-16T01:18:07.068424Z","steps":["trace[152278921] 'agreement among raft nodes before linearized reading' (duration: 113.249672ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:18:07.068584Z","caller":"traceutil/trace.go:171","msg":"trace[2095394523] linearizableReadLoop","detail":"{readStateIndex:1898; appliedIndex:1897; }","duration":"113.658394ms","start":"2026-06-16T01:18:06.954903Z","end":"2026-06-16T01:18:07.068562Z","steps":["trace[2095394523] 'read index received' (duration: 15.631165ms)","trace[2095394523] 'applied index is now lower than readState.Index' (duration: 97.460763ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:18:14.851876Z","caller":"traceutil/trace.go:171","msg":"trace[240082367] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"125.951506ms","start":"2026-06-16T01:18:14.725897Z","end":"2026-06-16T01:18:14.851848Z","steps":["trace[240082367] 'process raft request' (duration: 102.967236ms)","trace[240082367] 'compare' (duration: 22.854906ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:18:19.226365Z","caller":"traceutil/trace.go:171","msg":"trace[30850611] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"122.332235ms","start":"2026-06-16T01:18:19.104008Z","end":"2026-06-16T01:18:19.22634Z","steps":["trace[30850611] 'process raft request' (duration: 122.140469ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:18:50.996424Z","caller":"traceutil/trace.go:171","msg":"trace[829106454] transaction","detail":"{read_only:false; response_revision:2117; number_of_response:1; }","duration":"116.909609ms","start":"2026-06-16T01:18:50.879484Z","end":"2026-06-16T01:18:50.996394Z","steps":["trace[829106454] 'process raft request' (duration: 116.705324ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:18:51.147041Z","caller":"traceutil/trace.go:171","msg":"trace[523541092] transaction","detail":"{read_only:false; response_revision:2118; number_of_response:1; }","duration":"127.851342ms","start":"2026-06-16T01:18:51.019142Z","end":"2026-06-16T01:18:51.146994Z","steps":["trace[523541092] 'process raft request' (duration: 67.735331ms)","trace[523541092] 'compare' (duration: 59.796422ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:18:51.170952Z","caller":"traceutil/trace.go:171","msg":"trace[1993364401] transaction","detail":"{read_only:false; response_revision:2119; number_of_response:1; }","duration":"149.248183ms","start":"2026-06-16T01:18:51.021673Z","end":"2026-06-16T01:18:51.170921Z","steps":["trace[1993364401] 'process raft request' (duration: 149.088448ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:18:57.393213Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.947589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T01:18:57.393297Z","caller":"traceutil/trace.go:171","msg":"trace[1399668720] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2150; }","duration":"185.080033ms","start":"2026-06-16T01:18:57.2082Z","end":"2026-06-16T01:18:57.39328Z","steps":["trace[1399668720] 'range keys from in-memory index tree' (duration: 184.807785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:18:57.393455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.564968ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-06-16T01:18:57.393501Z","caller":"traceutil/trace.go:171","msg":"trace[2091422237] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2150; }","duration":"222.65169ms","start":"2026-06-16T01:18:57.170835Z","end":"2026-06-16T01:18:57.393486Z","steps":["trace[2091422237] 'range keys from in-memory index tree' (duration: 222.329472ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:18:57.626474Z","caller":"traceutil/trace.go:171","msg":"trace[2083044185] linearizableReadLoop","detail":"{readStateIndex:2237; appliedIndex:2236; }","duration":"146.519147ms","start":"2026-06-16T01:18:57.479932Z","end":"2026-06-16T01:18:57.626451Z","steps":["trace[2083044185] 'read index received' (duration: 146.293531ms)","trace[2083044185] 'applied index is now lower than readState.Index' (duration: 224.646µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:18:57.626526Z","caller":"traceutil/trace.go:171","msg":"trace[314426771] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"227.625558ms","start":"2026-06-16T01:18:57.398875Z","end":"2026-06-16T01:18:57.626501Z","steps":["trace[314426771] 'process raft request' (duration: 227.344841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:18:57.626947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.98073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-06-16T01:18:57.627075Z","caller":"traceutil/trace.go:171","msg":"trace[1251988202] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2152; }","duration":"147.164305ms","start":"2026-06-16T01:18:57.47988Z","end":"2026-06-16T01:18:57.627044Z","steps":["trace[1251988202] 'agreement among raft nodes before linearized reading' (duration: 146.676282ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:20:23.463026Z","caller":"traceutil/trace.go:171","msg":"trace[1249601028] linearizableReadLoop","detail":"{readStateIndex:2919; appliedIndex:2918; }","duration":"195.455758ms","start":"2026-06-16T01:20:23.267537Z","end":"2026-06-16T01:20:23.462993Z","steps":["trace[1249601028] 'read index received' (duration: 195.251663ms)","trace[1249601028] 'applied index is now lower than readState.Index' (duration: 202.905µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:20:23.463081Z","caller":"traceutil/trace.go:171","msg":"trace[2004739651] transaction","detail":"{read_only:false; response_revision:2809; number_of_response:1; }","duration":"202.911516ms","start":"2026-06-16T01:20:23.260143Z","end":"2026-06-16T01:20:23.463055Z","steps":["trace[2004739651] 'process raft request' (duration: 202.664149ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:20:23.463361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.786877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-16T01:20:23.463856Z","caller":"traceutil/trace.go:171","msg":"trace[434853631] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2809; }","duration":"196.312501ms","start":"2026-06-16T01:20:23.267499Z","end":"2026-06-16T01:20:23.463811Z","steps":["trace[434853631] 'agreement among raft nodes before linearized reading' (duration: 195.671704ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:20:23.464259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.102097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/securitypolicies/\" range_end:\"/registry/gateway.envoyproxy.io/securitypolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T01:20:23.464445Z","caller":"traceutil/trace.go:171","msg":"trace[777881546] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:2809; }","duration":"177.268822ms","start":"2026-06-16T01:20:23.287088Z","end":"2026-06-16T01:20:23.464357Z","steps":["trace[777881546] 'agreement among raft nodes before linearized reading' (duration: 176.720007ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:22:53.357754Z","caller":"traceutil/trace.go:171","msg":"trace[834170256] transaction","detail":"{read_only:false; response_revision:3802; number_of_response:1; }","duration":"112.464099ms","start":"2026-06-16T01:22:53.245242Z","end":"2026-06-16T01:22:53.357706Z","steps":["trace[834170256] 'process raft request' (duration: 112.228462ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:24:17.343633Z","caller":"traceutil/trace.go:171","msg":"trace[1443638591] transaction","detail":"{read_only:false; response_revision:4965; number_of_response:1; }","duration":"102.865214ms","start":"2026-06-16T01:24:17.240743Z","end":"2026-06-16T01:24:17.343609Z","steps":["trace[1443638591] 'process raft request' (duration: 102.683869ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:24:19.111327Z","caller":"traceutil/trace.go:171","msg":"trace[1304615504] linearizableReadLoop","detail":"{readStateIndex:5192; appliedIndex:5191; }","duration":"124.93094ms","start":"2026-06-16T01:24:18.986374Z","end":"2026-06-16T01:24:19.111305Z","steps":["trace[1304615504] 'read index received' (duration: 124.807067ms)","trace[1304615504] 'applied index is now lower than readState.Index' (duration: 122.953µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:24:19.111419Z","caller":"traceutil/trace.go:171","msg":"trace[1177206369] transaction","detail":"{read_only:false; response_revision:5000; number_of_response:1; }","duration":"153.766402ms","start":"2026-06-16T01:24:18.957626Z","end":"2026-06-16T01:24:19.111392Z","steps":["trace[1177206369] 'process raft request' (duration: 153.521315ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:19.111489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.843686ms","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-06-16T01:24:19.11154Z","caller":"traceutil/trace.go:171","msg":"trace[1509358606] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:5000; }","duration":"113.942568ms","start":"2026-06-16T01:24:18.997585Z","end":"2026-06-16T01:24:19.111528Z","steps":["trace[1509358606] 'agreement among raft nodes before linearized reading' (duration: 113.844636ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:19.111632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.240219ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-5f6f8e8e-869b-4c5b-bee4-a9029c7c0468\" ","response":"range_response_count:1 size:3893"} {"level":"info","ts":"2026-06-16T01:24:19.111737Z","caller":"traceutil/trace.go:171","msg":"trace[450283544] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-5f6f8e8e-869b-4c5b-bee4-a9029c7c0468; range_end:; response_count:1; response_revision:5000; }","duration":"125.394233ms","start":"2026-06-16T01:24:18.986317Z","end":"2026-06-16T01:24:19.111711Z","steps":["trace[450283544] 'agreement among raft nodes before linearized reading' (duration: 125.111366ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:24:30.660824Z","caller":"traceutil/trace.go:171","msg":"trace[143681381] transaction","detail":"{read_only:false; response_revision:5221; number_of_response:1; }","duration":"137.913847ms","start":"2026-06-16T01:24:30.522883Z","end":"2026-06-16T01:24:30.660796Z","steps":["trace[143681381] 'process raft request' (duration: 137.613539ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:31.239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.78267ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T01:24:31.239325Z","caller":"traceutil/trace.go:171","msg":"trace[2073371873] transaction","detail":"{read_only:false; response_revision:5228; number_of_response:1; }","duration":"306.863075ms","start":"2026-06-16T01:24:30.932438Z","end":"2026-06-16T01:24:31.239301Z","steps":["trace[2073371873] 'process raft request' (duration: 92.060427ms)","trace[2073371873] 'compare' (duration: 213.551033ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:24:31.239435Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:30.932417Z","time spent":"306.968358ms","remote":"127.0.0.1:60616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7956,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:24:31.239582Z","caller":"traceutil/trace.go:171","msg":"trace[1846913614] transaction","detail":"{read_only:false; response_revision:5229; number_of_response:1; }","duration":"304.245734ms","start":"2026-06-16T01:24:30.935315Z","end":"2026-06-16T01:24:31.239561Z","steps":["trace[1846913614] 'process raft request' (duration: 303.816602ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:31.239683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:30.935296Z","time spent":"304.339976ms","remote":"127.0.0.1:57824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1408,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:24:39.422955Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.826252ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-16T01:24:39.423213Z","caller":"traceutil/trace.go:171","msg":"trace[1204519757] transaction","detail":"{read_only:false; response_revision:5411; number_of_response:1; }","duration":"362.460212ms","start":"2026-06-16T01:24:39.060719Z","end":"2026-06-16T01:24:39.423179Z","steps":["trace[1204519757] 'process raft request' (duration: 125.30148ms)","trace[1204519757] 'compare' (duration: 236.580396ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:24:39.423302Z","caller":"traceutil/trace.go:171","msg":"trace[857460535] transaction","detail":"{read_only:false; response_revision:5412; number_of_response:1; }","duration":"362.270966ms","start":"2026-06-16T01:24:39.061003Z","end":"2026-06-16T01:24:39.423274Z","steps":["trace[857460535] 'process raft request' (duration: 362.070951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:39.423408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:39.060978Z","time spent":"362.371869ms","remote":"127.0.0.1:60598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1137,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:24:39.423439Z","caller":"traceutil/trace.go:171","msg":"trace[1350812698] linearizableReadLoop","detail":"{readStateIndex:5620; appliedIndex:5614; }","duration":"312.090358ms","start":"2026-06-16T01:24:39.111331Z","end":"2026-06-16T01:24:39.423421Z","steps":["trace[1350812698] 'read index received' (duration: 74.708091ms)","trace[1350812698] 'applied index is now lower than readState.Index' (duration: 237.381167ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:24:39.423408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:39.060709Z","time spent":"362.606226ms","remote":"127.0.0.1:60598","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1375,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:24:39.423601Z","caller":"traceutil/trace.go:171","msg":"trace[512115871] transaction","detail":"{read_only:false; response_revision:5414; number_of_response:1; }","duration":"360.93692ms","start":"2026-06-16T01:24:39.062615Z","end":"2026-06-16T01:24:39.423552Z","steps":["trace[512115871] 'process raft request' (duration: 360.607951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:39.423687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"312.356846ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-16T01:24:39.423727Z","caller":"traceutil/trace.go:171","msg":"trace[1151306029] transaction","detail":"{read_only:false; response_revision:5413; number_of_response:1; }","duration":"362.269426ms","start":"2026-06-16T01:24:39.061442Z","end":"2026-06-16T01:24:39.423711Z","steps":["trace[1151306029] 'process raft request' (duration: 361.723911ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:24:39.423739Z","caller":"traceutil/trace.go:171","msg":"trace[979612676] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5416; }","duration":"312.442099ms","start":"2026-06-16T01:24:39.111279Z","end":"2026-06-16T01:24:39.423721Z","steps":["trace[979612676] 'agreement among raft nodes before linearized reading' (duration: 312.280004ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:39.423758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.637833ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-16T01:24:39.423777Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.788157ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-16T01:24:39.423798Z","caller":"traceutil/trace.go:171","msg":"trace[2053988723] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5416; }","duration":"100.710345ms","start":"2026-06-16T01:24:39.323074Z","end":"2026-06-16T01:24:39.423784Z","steps":["trace[2053988723] 'agreement among raft nodes before linearized reading' (duration: 100.614553ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:39.423788Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:39.11126Z","time spent":"312.51696ms","remote":"127.0.0.1:60596","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1805,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "} {"level":"warn","ts":"2026-06-16T01:24:39.423814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:39.061431Z","time spent":"362.341309ms","remote":"127.0.0.1:57824","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1677,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:24:39.423846Z","caller":"traceutil/trace.go:171","msg":"trace[1143638892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5416; }","duration":"214.88928ms","start":"2026-06-16T01:24:39.208936Z","end":"2026-06-16T01:24:39.423825Z","steps":["trace[1143638892] 'agreement among raft nodes before linearized reading' (duration: 214.762587ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:39.423824Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:39.062599Z","time spent":"361.113564ms","remote":"127.0.0.1:57894","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1413,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:24:39.423652Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.93677ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T01:24:39.424009Z","caller":"traceutil/trace.go:171","msg":"trace[1057480229] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:5416; }","duration":"298.28985ms","start":"2026-06-16T01:24:39.125699Z","end":"2026-06-16T01:24:39.423988Z","steps":["trace[1057480229] 'agreement among raft nodes before linearized reading' (duration: 297.907469ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:24:39.423606Z","caller":"traceutil/trace.go:171","msg":"trace[1123431709] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"359.529551ms","start":"2026-06-16T01:24:39.064019Z","end":"2026-06-16T01:24:39.423549Z","steps":["trace[1123431709] 'process raft request' (duration: 359.275894ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:24:39.423947Z","caller":"traceutil/trace.go:171","msg":"trace[35632552] transaction","detail":"{read_only:false; response_revision:5416; number_of_response:1; }","duration":"357.28207ms","start":"2026-06-16T01:24:39.066564Z","end":"2026-06-16T01:24:39.423846Z","steps":["trace[35632552] 'process raft request' (duration: 356.809647ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:39.424257Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:39.066558Z","time spent":"357.618239ms","remote":"127.0.0.1:60616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4752,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T01:24:39.424052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"284.561553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c8db4081-4fb9-43e3-88b3-8073d56dc430\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-16T01:24:39.424387Z","caller":"traceutil/trace.go:171","msg":"trace[982729417] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c8db4081-4fb9-43e3-88b3-8073d56dc430; range_end:; response_count:1; response_revision:5416; }","duration":"284.916913ms","start":"2026-06-16T01:24:39.139432Z","end":"2026-06-16T01:24:39.424349Z","steps":["trace[982729417] 'agreement among raft nodes before linearized reading' (duration: 284.366558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:24:39.424248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T01:24:39.064005Z","time spent":"360.069976ms","remote":"127.0.0.1:58060","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3884,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T01:25:53.536335Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2975} {"level":"info","ts":"2026-06-16T01:25:53.607218Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2975,"took":"68.905596ms","hash":101871368,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":33964032,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-16T01:25:53.607315Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":101871368,"revision":2975,"compact-revision":-1} {"level":"info","ts":"2026-06-16T01:30:53.543288Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6081} {"level":"info","ts":"2026-06-16T01:30:53.638315Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6081,"took":"92.718344ms","hash":2115829462,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":23744512,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-16T01:30:53.638394Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2115829462,"revision":6081,"compact-revision":2975} {"level":"info","ts":"2026-06-16T01:30:59.712963Z","caller":"traceutil/trace.go:171","msg":"trace[699367651] transaction","detail":"{read_only:false; response_revision:8311; number_of_response:1; }","duration":"229.393098ms","start":"2026-06-16T01:30:59.48353Z","end":"2026-06-16T01:30:59.712923Z","steps":["trace[699367651] 'process raft request' (duration: 199.160886ms)","trace[699367651] 'compare' (duration: 30.074118ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:31:00.41569Z","caller":"traceutil/trace.go:171","msg":"trace[2128537244] transaction","detail":"{read_only:false; response_revision:8312; number_of_response:1; }","duration":"158.970089ms","start":"2026-06-16T01:31:00.256682Z","end":"2026-06-16T01:31:00.415653Z","steps":["trace[2128537244] 'process raft request' (duration: 158.781914ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:01.636545Z","caller":"traceutil/trace.go:171","msg":"trace[510587973] transaction","detail":"{read_only:false; response_revision:8320; number_of_response:1; }","duration":"112.679734ms","start":"2026-06-16T01:31:01.523838Z","end":"2026-06-16T01:31:01.636518Z","steps":["trace[510587973] 'process raft request' (duration: 112.53875ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:27.711704Z","caller":"traceutil/trace.go:171","msg":"trace[326107182] transaction","detail":"{read_only:false; response_revision:8513; number_of_response:1; }","duration":"192.908184ms","start":"2026-06-16T01:31:27.518736Z","end":"2026-06-16T01:31:27.711644Z","steps":["trace[326107182] 'process raft request' (duration: 192.309478ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:27.853326Z","caller":"traceutil/trace.go:171","msg":"trace[872846029] transaction","detail":"{read_only:false; response_revision:8514; number_of_response:1; }","duration":"136.48594ms","start":"2026-06-16T01:31:27.716802Z","end":"2026-06-16T01:31:27.853288Z","steps":["trace[872846029] 'process raft request' (duration: 136.268704ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:27.854449Z","caller":"traceutil/trace.go:171","msg":"trace[91882763] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"137.467997ms","start":"2026-06-16T01:31:27.716952Z","end":"2026-06-16T01:31:27.85442Z","steps":["trace[91882763] 'process raft request' (duration: 137.273202ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:31:31.787035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.224791ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-06-16T01:31:32.106191Z","caller":"traceutil/trace.go:171","msg":"trace[180437410] transaction","detail":"{read_only:false; response_revision:8533; number_of_response:1; }","duration":"231.497106ms","start":"2026-06-16T01:31:31.87466Z","end":"2026-06-16T01:31:32.106157Z","steps":["trace[180437410] 'process raft request' (duration: 231.292401ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:32.11243Z","caller":"traceutil/trace.go:171","msg":"trace[2115986703] linearizableReadLoop","detail":"{readStateIndex:8839; appliedIndex:8837; }","duration":"234.177871ms","start":"2026-06-16T01:31:31.878227Z","end":"2026-06-16T01:31:32.112405Z","steps":["trace[2115986703] 'read index received' (duration: 227.715442ms)","trace[2115986703] 'applied index is now lower than readState.Index' (duration: 6.461449ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:31:32.112645Z","caller":"traceutil/trace.go:171","msg":"trace[259200243] transaction","detail":"{read_only:false; response_revision:8534; number_of_response:1; }","duration":"237.209324ms","start":"2026-06-16T01:31:31.875427Z","end":"2026-06-16T01:31:32.112637Z","steps":["trace[259200243] 'process raft request' (duration: 236.881225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:31:32.112861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.621893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T01:31:32.112891Z","caller":"traceutil/trace.go:171","msg":"trace[1819623505] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8534; }","duration":"234.678695ms","start":"2026-06-16T01:31:31.878205Z","end":"2026-06-16T01:31:32.112884Z","steps":["trace[1819623505] 'agreement among raft nodes before linearized reading' (duration: 234.571302ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:31:32.113031Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.70822ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-np8kg\" ","response":"range_response_count:1 size:6447"} {"level":"info","ts":"2026-06-16T01:31:32.113054Z","caller":"traceutil/trace.go:171","msg":"trace[203401141] range","detail":"{range_begin:/registry/pods/openstack/keepalived-np8kg; range_end:; response_count:1; response_revision:8534; }","duration":"208.765131ms","start":"2026-06-16T01:31:31.904283Z","end":"2026-06-16T01:31:32.113048Z","steps":["trace[203401141] 'agreement among raft nodes before linearized reading' (duration: 208.7035ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:40.653698Z","caller":"traceutil/trace.go:171","msg":"trace[126521054] transaction","detail":"{read_only:false; response_revision:8622; number_of_response:1; }","duration":"101.451065ms","start":"2026-06-16T01:31:40.55222Z","end":"2026-06-16T01:31:40.653671Z","steps":["trace[126521054] 'process raft request' (duration: 97.049053ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:40.676364Z","caller":"traceutil/trace.go:171","msg":"trace[494365] linearizableReadLoop","detail":"{readStateIndex:8933; appliedIndex:8931; }","duration":"101.343681ms","start":"2026-06-16T01:31:40.574993Z","end":"2026-06-16T01:31:40.676336Z","steps":["trace[494365] 'read index received' (duration: 74.290966ms)","trace[494365] 'applied index is now lower than readState.Index' (duration: 27.051305ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:31:40.676433Z","caller":"traceutil/trace.go:171","msg":"trace[422930746] transaction","detail":"{read_only:false; response_revision:8623; number_of_response:1; }","duration":"118.219797ms","start":"2026-06-16T01:31:40.558184Z","end":"2026-06-16T01:31:40.676404Z","steps":["trace[422930746] 'process raft request' (duration: 117.95818ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:31:40.676667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.612639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-06-16T01:31:40.67672Z","caller":"traceutil/trace.go:171","msg":"trace[969568952] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:8623; }","duration":"101.757693ms","start":"2026-06-16T01:31:40.57495Z","end":"2026-06-16T01:31:40.676708Z","steps":["trace[969568952] 'agreement among raft nodes before linearized reading' (duration: 101.543237ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:31:41.214978Z","caller":"traceutil/trace.go:171","msg":"trace[74772023] transaction","detail":"{read_only:false; response_revision:8627; number_of_response:1; }","duration":"134.202237ms","start":"2026-06-16T01:31:41.080748Z","end":"2026-06-16T01:31:41.21495Z","steps":["trace[74772023] 'process raft request' (duration: 94.844703ms)","trace[74772023] 'compare' (duration: 39.181679ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:31:59.396223Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000239c.wal"} {"level":"info","ts":"2026-06-16T01:33:36.801709Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T01:33:36.807556Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-16T01:33:36.807673Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-16T01:35:53.549072Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8277} {"level":"info","ts":"2026-06-16T01:35:53.637798Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8277,"took":"86.187403ms","hash":1620866415,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":26341376,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-16T01:35:53.637883Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1620866415,"revision":8277,"compact-revision":6081} {"level":"info","ts":"2026-06-16T01:36:23.756764Z","caller":"traceutil/trace.go:171","msg":"trace[341204807] linearizableReadLoop","detail":"{readStateIndex:11504; appliedIndex:11503; }","duration":"122.999877ms","start":"2026-06-16T01:36:23.633746Z","end":"2026-06-16T01:36:23.756746Z","steps":["trace[341204807] 'read index received' (duration: 122.791901ms)","trace[341204807] 'applied index is now lower than readState.Index' (duration: 207.396µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:36:23.756877Z","caller":"traceutil/trace.go:171","msg":"trace[558769078] transaction","detail":"{read_only:false; response_revision:11122; number_of_response:1; }","duration":"130.849582ms","start":"2026-06-16T01:36:23.625995Z","end":"2026-06-16T01:36:23.756844Z","steps":["trace[558769078] 'process raft request' (duration: 130.628246ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:36:23.756994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.233423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-16T01:36:23.757062Z","caller":"traceutil/trace.go:171","msg":"trace[386444878] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11122; }","duration":"123.348126ms","start":"2026-06-16T01:36:23.633699Z","end":"2026-06-16T01:36:23.757048Z","steps":["trace[386444878] 'agreement among raft nodes before linearized reading' (duration: 123.1421ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:36:23.888954Z","caller":"traceutil/trace.go:171","msg":"trace[551468624] linearizableReadLoop","detail":"{readStateIndex:11506; appliedIndex:11504; }","duration":"126.357499ms","start":"2026-06-16T01:36:23.762573Z","end":"2026-06-16T01:36:23.88893Z","steps":["trace[551468624] 'read index received' (duration: 78.742678ms)","trace[551468624] 'applied index is now lower than readState.Index' (duration: 47.613661ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:36:23.888973Z","caller":"traceutil/trace.go:171","msg":"trace[2018474964] transaction","detail":"{read_only:false; response_revision:11123; number_of_response:1; }","duration":"128.265151ms","start":"2026-06-16T01:36:23.760679Z","end":"2026-06-16T01:36:23.888944Z","steps":["trace[2018474964] 'process raft request' (duration: 80.61767ms)","trace[2018474964] 'compare' (duration: 47.443746ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:36:23.889212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.625506ms","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-06-16T01:36:23.889262Z","caller":"traceutil/trace.go:171","msg":"trace[1335320682] range","detail":"{range_begin:/registry/csistoragecapacities/; range_end:/registry/csistoragecapacities0; response_count:0; response_revision:11124; }","duration":"126.723149ms","start":"2026-06-16T01:36:23.762521Z","end":"2026-06-16T01:36:23.889244Z","steps":["trace[1335320682] 'agreement among raft nodes before linearized reading' (duration: 126.635886ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:36:23.889253Z","caller":"traceutil/trace.go:171","msg":"trace[516315163] transaction","detail":"{read_only:false; response_revision:11124; number_of_response:1; }","duration":"128.513128ms","start":"2026-06-16T01:36:23.76068Z","end":"2026-06-16T01:36:23.889193Z","steps":["trace[516315163] 'process raft request' (duration: 128.20487ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:36:46.20716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.196697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-16T01:36:46.207266Z","caller":"traceutil/trace.go:171","msg":"trace[1146122341] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11245; }","duration":"206.346071ms","start":"2026-06-16T01:36:46.000899Z","end":"2026-06-16T01:36:46.207245Z","steps":["trace[1146122341] 'range keys from in-memory index tree' (duration: 205.988322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:36:46.207253Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.17513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-06-16T01:36:46.207263Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"217.179969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/\" range_end:\"/registry/leases0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-16T01:36:46.207334Z","caller":"traceutil/trace.go:171","msg":"trace[908770084] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11245; }","duration":"160.305724ms","start":"2026-06-16T01:36:46.047006Z","end":"2026-06-16T01:36:46.207312Z","steps":["trace[908770084] 'range keys from in-memory index tree' (duration: 159.981174ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:36:46.207365Z","caller":"traceutil/trace.go:171","msg":"trace[1486186703] range","detail":"{range_begin:/registry/leases/; range_end:/registry/leases0; response_count:0; response_revision:11245; }","duration":"217.345964ms","start":"2026-06-16T01:36:45.989995Z","end":"2026-06-16T01:36:46.207341Z","steps":["trace[1486186703] 'count revisions from in-memory index tree' (duration: 217.087207ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:36:46.344629Z","caller":"traceutil/trace.go:171","msg":"trace[1811963482] transaction","detail":"{read_only:false; response_revision:11248; number_of_response:1; }","duration":"133.045683ms","start":"2026-06-16T01:36:46.211528Z","end":"2026-06-16T01:36:46.344573Z","steps":["trace[1811963482] 'process raft request' (duration: 129.068374ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:40:53.557535Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10768} {"level":"info","ts":"2026-06-16T01:40:53.641494Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10768,"took":"80.690916ms","hash":4118922681,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":26828800,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-16T01:40:53.641557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4118922681,"revision":10768,"compact-revision":8277} {"level":"warn","ts":"2026-06-16T01:43:05.609098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.049176ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-np8kg\" ","response":"range_response_count:1 size:6447"} {"level":"info","ts":"2026-06-16T01:43:05.609202Z","caller":"traceutil/trace.go:171","msg":"trace[1836181040] range","detail":"{range_begin:/registry/pods/openstack/keepalived-np8kg; range_end:; response_count:1; response_revision:13794; }","duration":"135.20389ms","start":"2026-06-16T01:43:05.473977Z","end":"2026-06-16T01:43:05.609181Z","steps":["trace[1836181040] 'range keys from in-memory index tree' (duration: 134.872811ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:43:05.621979Z","caller":"traceutil/trace.go:171","msg":"trace[865840610] transaction","detail":"{read_only:false; response_revision:13795; number_of_response:1; }","duration":"115.515909ms","start":"2026-06-16T01:43:05.506439Z","end":"2026-06-16T01:43:05.621955Z","steps":["trace[865840610] 'process raft request' (duration: 115.366775ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:43:14.122636Z","caller":"traceutil/trace.go:171","msg":"trace[902673608] linearizableReadLoop","detail":"{readStateIndex:14334; appliedIndex:14333; }","duration":"133.981246ms","start":"2026-06-16T01:43:13.988605Z","end":"2026-06-16T01:43:14.122587Z","steps":["trace[902673608] 'read index received' (duration: 112.569347ms)","trace[902673608] 'applied index is now lower than readState.Index' (duration: 21.410509ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:43:14.12266Z","caller":"traceutil/trace.go:171","msg":"trace[361058841] transaction","detail":"{read_only:false; response_revision:13856; number_of_response:1; }","duration":"138.320676ms","start":"2026-06-16T01:43:13.984301Z","end":"2026-06-16T01:43:14.122622Z","steps":["trace[361058841] 'process raft request' (duration: 116.932617ms)","trace[361058841] 'compare' (duration: 20.993008ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:43:14.122803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.175552ms","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-06-16T01:43:14.122918Z","caller":"traceutil/trace.go:171","msg":"trace[2047066641] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:13856; }","duration":"134.326236ms","start":"2026-06-16T01:43:13.988554Z","end":"2026-06-16T01:43:14.12288Z","steps":["trace[2047066641] 'agreement among raft nodes before linearized reading' (duration: 134.152321ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:44:26.702541Z","caller":"traceutil/trace.go:171","msg":"trace[1241963443] transaction","detail":"{read_only:false; response_revision:14788; number_of_response:1; }","duration":"143.356804ms","start":"2026-06-16T01:44:26.559138Z","end":"2026-06-16T01:44:26.702495Z","steps":["trace[1241963443] 'process raft request' (duration: 44.001631ms)","trace[1241963443] 'compare' (duration: 98.833759ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:44:26.703373Z","caller":"traceutil/trace.go:171","msg":"trace[304225874] transaction","detail":"{read_only:false; response_revision:14789; number_of_response:1; }","duration":"140.947428ms","start":"2026-06-16T01:44:26.562395Z","end":"2026-06-16T01:44:26.703342Z","steps":["trace[304225874] 'process raft request' (duration: 140.003832ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:44:26.703483Z","caller":"traceutil/trace.go:171","msg":"trace[230994531] linearizableReadLoop","detail":"{readStateIndex:15298; appliedIndex:15296; }","duration":"119.542529ms","start":"2026-06-16T01:44:26.583905Z","end":"2026-06-16T01:44:26.703448Z","steps":["trace[230994531] 'read index received' (duration: 19.208078ms)","trace[230994531] 'applied index is now lower than readState.Index' (duration: 100.331491ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:44:26.703714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.439126ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-16T01:44:26.703815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.146546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-16T01:44:26.703812Z","caller":"traceutil/trace.go:171","msg":"trace[504941303] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:14790; }","duration":"119.56241ms","start":"2026-06-16T01:44:26.584221Z","end":"2026-06-16T01:44:26.703783Z","steps":["trace[504941303] 'agreement among raft nodes before linearized reading' (duration: 119.410286ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:44:26.703802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.876008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"warn","ts":"2026-06-16T01:44:26.703968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.639181ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-06-16T01:44:26.703999Z","caller":"traceutil/trace.go:171","msg":"trace[1531317022] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:14790; }","duration":"120.130105ms","start":"2026-06-16T01:44:26.583843Z","end":"2026-06-16T01:44:26.703973Z","steps":["trace[1531317022] 'agreement among raft nodes before linearized reading' (duration: 119.740874ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:44:26.704032Z","caller":"traceutil/trace.go:171","msg":"trace[525150531] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:14790; }","duration":"115.725634ms","start":"2026-06-16T01:44:26.58829Z","end":"2026-06-16T01:44:26.704016Z","steps":["trace[525150531] 'agreement among raft nodes before linearized reading' (duration: 115.55947ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:44:26.703856Z","caller":"traceutil/trace.go:171","msg":"trace[61037387] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14790; }","duration":"108.224288ms","start":"2026-06-16T01:44:26.595621Z","end":"2026-06-16T01:44:26.703845Z","steps":["trace[61037387] 'agreement among raft nodes before linearized reading' (duration: 108.013632ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:44:26.705311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.20531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T01:44:26.705448Z","caller":"traceutil/trace.go:171","msg":"trace[2103277849] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14790; }","duration":"107.371434ms","start":"2026-06-16T01:44:26.598054Z","end":"2026-06-16T01:44:26.705425Z","steps":["trace[2103277849] 'agreement among raft nodes before linearized reading' (duration: 105.703218ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:45:00.746881Z","caller":"traceutil/trace.go:171","msg":"trace[832359515] transaction","detail":"{read_only:false; response_revision:14965; number_of_response:1; }","duration":"204.777203ms","start":"2026-06-16T01:45:00.542075Z","end":"2026-06-16T01:45:00.746852Z","steps":["trace[832359515] 'process raft request' (duration: 204.484785ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:45:00.968388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.224918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-16T01:45:00.968466Z","caller":"traceutil/trace.go:171","msg":"trace[109591495] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14966; }","duration":"108.351791ms","start":"2026-06-16T01:45:00.860094Z","end":"2026-06-16T01:45:00.968445Z","steps":["trace[109591495] 'range keys from in-memory index tree' (duration: 107.987951ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:45:00.968388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.821386ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-16T01:45:00.968583Z","caller":"traceutil/trace.go:171","msg":"trace[718710953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:14966; }","duration":"104.057833ms","start":"2026-06-16T01:45:00.864509Z","end":"2026-06-16T01:45:00.968566Z","steps":["trace[718710953] 'range keys from in-memory index tree' (duration: 103.616021ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:45:53.563607Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12839} {"level":"info","ts":"2026-06-16T01:45:53.635296Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12839,"took":"69.0771ms","hash":3492767908,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":29863936,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-16T01:45:53.635346Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3492767908,"revision":12839,"compact-revision":10768} {"level":"info","ts":"2026-06-16T01:50:53.631388Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15302} {"level":"info","ts":"2026-06-16T01:50:54.061878Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15302,"took":"427.461818ms","hash":3092649227,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":31801344,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T01:50:54.061964Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3092649227,"revision":15302,"compact-revision":12839} {"level":"info","ts":"2026-06-16T01:50:54.256998Z","caller":"traceutil/trace.go:171","msg":"trace[2089886165] transaction","detail":"{read_only:false; response_revision:17582; number_of_response:1; }","duration":"217.872998ms","start":"2026-06-16T01:50:54.039092Z","end":"2026-06-16T01:50:54.256965Z","steps":["trace[2089886165] 'process raft request' (duration: 217.631891ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:50:54.359552Z","caller":"traceutil/trace.go:171","msg":"trace[116001980] transaction","detail":"{read_only:false; response_revision:17583; number_of_response:1; }","duration":"265.179612ms","start":"2026-06-16T01:50:54.094345Z","end":"2026-06-16T01:50:54.359525Z","steps":["trace[116001980] 'process raft request' (duration: 264.938786ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:50:54.359762Z","caller":"traceutil/trace.go:171","msg":"trace[1895467836] linearizableReadLoop","detail":"{readStateIndex:18188; appliedIndex:18185; }","duration":"204.251203ms","start":"2026-06-16T01:50:54.15547Z","end":"2026-06-16T01:50:54.359721Z","steps":["trace[1895467836] 'read index received' (duration: 101.280393ms)","trace[1895467836] 'applied index is now lower than readState.Index' (duration: 102.96786ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:50:54.3599Z","caller":"traceutil/trace.go:171","msg":"trace[149112127] transaction","detail":"{read_only:false; response_revision:17584; number_of_response:1; }","duration":"218.28027ms","start":"2026-06-16T01:50:54.141577Z","end":"2026-06-16T01:50:54.359858Z","steps":["trace[149112127] 'process raft request' (duration: 217.904059ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:50:54.359994Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.209233ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T01:50:54.36004Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.553081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-16T01:50:54.360139Z","caller":"traceutil/trace.go:171","msg":"trace[1150247741] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17584; }","duration":"150.370017ms","start":"2026-06-16T01:50:54.209717Z","end":"2026-06-16T01:50:54.360087Z","steps":["trace[1150247741] 'agreement among raft nodes before linearized reading' (duration: 150.187272ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:50:54.360168Z","caller":"traceutil/trace.go:171","msg":"trace[227473572] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:17584; }","duration":"204.729866ms","start":"2026-06-16T01:50:54.155423Z","end":"2026-06-16T01:50:54.360153Z","steps":["trace[227473572] 'agreement among raft nodes before linearized reading' (duration: 204.452238ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:50:54.55361Z","caller":"traceutil/trace.go:171","msg":"trace[188054293] transaction","detail":"{read_only:false; response_revision:17585; number_of_response:1; }","duration":"189.575828ms","start":"2026-06-16T01:50:54.364004Z","end":"2026-06-16T01:50:54.55358Z","steps":["trace[188054293] 'process raft request' (duration: 89.834057ms)","trace[188054293] 'compare' (duration: 99.542115ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:54:29.83366Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T01:54:29.838778Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-16T01:54:29.838869Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-16T01:55:53.638091Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17581} {"level":"info","ts":"2026-06-16T01:55:53.739292Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17581,"took":"97.42572ms","hash":3396850753,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":33906688,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-16T01:55:53.739348Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3396850753,"revision":17581,"compact-revision":15302} {"level":"info","ts":"2026-06-16T01:56:26.637014Z","caller":"traceutil/trace.go:171","msg":"trace[1550577348] linearizableReadLoop","detail":"{readStateIndex:20892; appliedIndex:20891; }","duration":"108.263998ms","start":"2026-06-16T01:56:26.528718Z","end":"2026-06-16T01:56:26.636982Z","steps":["trace[1550577348] 'read index received' (duration: 108.081063ms)","trace[1550577348] 'applied index is now lower than readState.Index' (duration: 180.905µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:56:26.637129Z","caller":"traceutil/trace.go:171","msg":"trace[767101008] transaction","detail":"{read_only:false; response_revision:20202; number_of_response:1; }","duration":"141.685351ms","start":"2026-06-16T01:56:26.495393Z","end":"2026-06-16T01:56:26.637079Z","steps":["trace[767101008] 'process raft request' (duration: 141.352742ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:56:26.63738Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.557543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-16T01:56:26.637402Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.641639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T01:56:26.637481Z","caller":"traceutil/trace.go:171","msg":"trace[1529441111] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20202; }","duration":"101.739479ms","start":"2026-06-16T01:56:26.535714Z","end":"2026-06-16T01:56:26.637454Z","steps":["trace[1529441111] 'agreement among raft nodes before linearized reading' (duration: 101.474591ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:26.637522Z","caller":"traceutil/trace.go:171","msg":"trace[155442542] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20202; }","duration":"108.887307ms","start":"2026-06-16T01:56:26.528606Z","end":"2026-06-16T01:56:26.637493Z","steps":["trace[155442542] 'agreement among raft nodes before linearized reading' (duration: 108.496456ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:26.753523Z","caller":"traceutil/trace.go:171","msg":"trace[1531334744] transaction","detail":"{read_only:false; response_revision:20203; number_of_response:1; }","duration":"111.406806ms","start":"2026-06-16T01:56:26.642078Z","end":"2026-06-16T01:56:26.753484Z","steps":["trace[1531334744] 'process raft request' (duration: 111.018335ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:26.753686Z","caller":"traceutil/trace.go:171","msg":"trace[1528485486] transaction","detail":"{read_only:false; response_revision:20204; number_of_response:1; }","duration":"111.308012ms","start":"2026-06-16T01:56:26.642346Z","end":"2026-06-16T01:56:26.753654Z","steps":["trace[1528485486] 'process raft request' (duration: 111.009134ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:26.753743Z","caller":"traceutil/trace.go:171","msg":"trace[1366580331] transaction","detail":"{read_only:false; response_revision:20205; number_of_response:1; }","duration":"111.272572ms","start":"2026-06-16T01:56:26.642431Z","end":"2026-06-16T01:56:26.753703Z","steps":["trace[1366580331] 'process raft request' (duration: 111.125948ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:42.54525Z","caller":"traceutil/trace.go:171","msg":"trace[754707984] transaction","detail":"{read_only:false; response_revision:20283; number_of_response:1; }","duration":"132.324443ms","start":"2026-06-16T01:56:42.412893Z","end":"2026-06-16T01:56:42.545218Z","steps":["trace[754707984] 'process raft request' (duration: 127.693515ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:42.704837Z","caller":"traceutil/trace.go:171","msg":"trace[863968847] linearizableReadLoop","detail":"{readStateIndex:20978; appliedIndex:20977; }","duration":"112.160066ms","start":"2026-06-16T01:56:42.59265Z","end":"2026-06-16T01:56:42.70481Z","steps":["trace[863968847] 'read index received' (duration: 58.113984ms)","trace[863968847] 'applied index is now lower than readState.Index' (duration: 54.045042ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:56:42.704958Z","caller":"traceutil/trace.go:171","msg":"trace[1638222849] transaction","detail":"{read_only:false; response_revision:20284; number_of_response:1; }","duration":"289.822491ms","start":"2026-06-16T01:56:42.415087Z","end":"2026-06-16T01:56:42.704909Z","steps":["trace[1638222849] 'process raft request' (duration: 235.776449ms)","trace[1638222849] 'compare' (duration: 53.810645ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T01:56:42.705057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.380332ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T01:56:42.7052Z","caller":"traceutil/trace.go:171","msg":"trace[1416092838] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:20284; }","duration":"112.600279ms","start":"2026-06-16T01:56:42.592568Z","end":"2026-06-16T01:56:42.705169Z","steps":["trace[1416092838] 'agreement among raft nodes before linearized reading' (duration: 112.335091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:56:42.973837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.880582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-06-16T01:56:42.973855Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.361194ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T01:56:42.973929Z","caller":"traceutil/trace.go:171","msg":"trace[313254350] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:20285; }","duration":"140.002985ms","start":"2026-06-16T01:56:42.833905Z","end":"2026-06-16T01:56:42.973908Z","steps":["trace[313254350] 'range keys from in-memory index tree' (duration: 139.730617ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:42.973972Z","caller":"traceutil/trace.go:171","msg":"trace[1009014115] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:20285; }","duration":"132.54823ms","start":"2026-06-16T01:56:42.841395Z","end":"2026-06-16T01:56:42.973943Z","steps":["trace[1009014115] 'count revisions from in-memory index tree' (duration: 132.248091ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:56:42.974024Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.229887ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-16T01:56:42.974085Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.389198ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T01:56:42.97418Z","caller":"traceutil/trace.go:171","msg":"trace[890250090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:20285; }","duration":"139.508571ms","start":"2026-06-16T01:56:42.834647Z","end":"2026-06-16T01:56:42.974156Z","steps":["trace[890250090] 'range keys from in-memory index tree' (duration: 139.224073ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:42.974113Z","caller":"traceutil/trace.go:171","msg":"trace[1015763577] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20285; }","duration":"146.369821ms","start":"2026-06-16T01:56:42.827723Z","end":"2026-06-16T01:56:42.974093Z","steps":["trace[1015763577] 'range keys from in-memory index tree' (duration: 146.042922ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:56:42.974299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.536417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T01:56:42.974355Z","caller":"traceutil/trace.go:171","msg":"trace[1769676344] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20285; }","duration":"141.61473ms","start":"2026-06-16T01:56:42.832723Z","end":"2026-06-16T01:56:42.974338Z","steps":["trace[1769676344] 'range keys from in-memory index tree' (duration: 141.396673ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:43.102862Z","caller":"traceutil/trace.go:171","msg":"trace[162293917] transaction","detail":"{read_only:false; response_revision:20286; number_of_response:1; }","duration":"124.435805ms","start":"2026-06-16T01:56:42.978403Z","end":"2026-06-16T01:56:43.102839Z","steps":["trace[162293917] 'process raft request' (duration: 124.298841ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:43.106525Z","caller":"traceutil/trace.go:171","msg":"trace[512254783] transaction","detail":"{read_only:false; response_revision:20288; number_of_response:1; }","duration":"127.211742ms","start":"2026-06-16T01:56:42.979281Z","end":"2026-06-16T01:56:43.106493Z","steps":["trace[512254783] 'process raft request' (duration: 127.122609ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:43.106651Z","caller":"traceutil/trace.go:171","msg":"trace[24930682] linearizableReadLoop","detail":"{readStateIndex:20982; appliedIndex:20979; }","duration":"126.962425ms","start":"2026-06-16T01:56:42.97968Z","end":"2026-06-16T01:56:43.106643Z","steps":["trace[24930682] 'read index received' (duration: 123.081438ms)","trace[24930682] 'applied index is now lower than readState.Index' (duration: 3.880017ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T01:56:43.106702Z","caller":"traceutil/trace.go:171","msg":"trace[207054745] transaction","detail":"{read_only:false; response_revision:20289; number_of_response:1; }","duration":"126.966315ms","start":"2026-06-16T01:56:42.979684Z","end":"2026-06-16T01:56:43.10665Z","steps":["trace[207054745] 'process raft request' (duration: 126.76733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T01:56:43.10683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.133459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18450"} {"level":"info","ts":"2026-06-16T01:56:43.106863Z","caller":"traceutil/trace.go:171","msg":"trace[1916270401] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:20289; }","duration":"127.200202ms","start":"2026-06-16T01:56:42.979655Z","end":"2026-06-16T01:56:43.106856Z","steps":["trace[1916270401] 'agreement among raft nodes before linearized reading' (duration: 127.046497ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T01:56:43.106547Z","caller":"traceutil/trace.go:171","msg":"trace[467247836] transaction","detail":"{read_only:false; response_revision:20287; number_of_response:1; }","duration":"127.848179ms","start":"2026-06-16T01:56:42.978663Z","end":"2026-06-16T01:56:43.106511Z","steps":["trace[467247836] 'process raft request' (duration: 127.549841ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:00:40.115058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.179665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:00:40.11516Z","caller":"traceutil/trace.go:171","msg":"trace[1770032371] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:22813; }","duration":"263.325659ms","start":"2026-06-16T02:00:39.851814Z","end":"2026-06-16T02:00:40.115139Z","steps":["trace[1770032371] 'count revisions from in-memory index tree' (duration: 263.097923ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:00:40.116166Z","caller":"traceutil/trace.go:171","msg":"trace[1366480362] transaction","detail":"{read_only:false; response_revision:22814; number_of_response:1; }","duration":"152.742567ms","start":"2026-06-16T02:00:39.96317Z","end":"2026-06-16T02:00:40.115912Z","steps":["trace[1366480362] 'process raft request' (duration: 143.989585ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:00:53.645516Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20026} {"level":"info","ts":"2026-06-16T02:00:53.767268Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20026,"took":"115.328734ms","hash":3520104540,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":43012096,"current-db-size-in-use":"43 MB"} {"level":"info","ts":"2026-06-16T02:00:53.767351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3520104540,"revision":20026,"compact-revision":17581} {"level":"info","ts":"2026-06-16T02:04:09.981997Z","caller":"traceutil/trace.go:171","msg":"trace[223160950] transaction","detail":"{read_only:false; response_revision:24923; number_of_response:1; }","duration":"100.389858ms","start":"2026-06-16T02:04:09.881557Z","end":"2026-06-16T02:04:09.981947Z","steps":["trace[223160950] 'process raft request' (duration: 99.932985ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:10.462149Z","caller":"traceutil/trace.go:171","msg":"trace[1323693078] linearizableReadLoop","detail":"{readStateIndex:25748; appliedIndex:25747; }","duration":"156.784741ms","start":"2026-06-16T02:04:10.305339Z","end":"2026-06-16T02:04:10.462124Z","steps":["trace[1323693078] 'read index received' (duration: 156.601356ms)","trace[1323693078] 'applied index is now lower than readState.Index' (duration: 182.515µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:10.462271Z","caller":"traceutil/trace.go:171","msg":"trace[385852457] transaction","detail":"{read_only:false; response_revision:24924; number_of_response:1; }","duration":"234.799891ms","start":"2026-06-16T02:04:10.22746Z","end":"2026-06-16T02:04:10.46226Z","steps":["trace[385852457] 'process raft request' (duration: 234.507783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:10.462468Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.116931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:04:10.462513Z","caller":"traceutil/trace.go:171","msg":"trace[1073561780] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:24924; }","duration":"157.221404ms","start":"2026-06-16T02:04:10.305279Z","end":"2026-06-16T02:04:10.4625Z","steps":["trace[1073561780] 'agreement among raft nodes before linearized reading' (duration: 157.125351ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:10.704454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.15095ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:10.704587Z","caller":"traceutil/trace.go:171","msg":"trace[806559984] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24924; }","duration":"132.301004ms","start":"2026-06-16T02:04:10.572269Z","end":"2026-06-16T02:04:10.70457Z","steps":["trace[806559984] 'range keys from in-memory index tree' (duration: 132.13526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:10.705011Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.717272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:10.705295Z","caller":"traceutil/trace.go:171","msg":"trace[858162252] linearizableReadLoop","detail":"{readStateIndex:25751; appliedIndex:25748; }","duration":"243.053563ms","start":"2026-06-16T02:04:10.462223Z","end":"2026-06-16T02:04:10.705276Z","steps":["trace[858162252] 'read index received' (duration: 14.853807ms)","trace[858162252] 'applied index is now lower than readState.Index' (duration: 228.198856ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:10.705332Z","caller":"traceutil/trace.go:171","msg":"trace[1375231266] transaction","detail":"{read_only:false; response_revision:24926; number_of_response:1; }","duration":"372.579209ms","start":"2026-06-16T02:04:10.332736Z","end":"2026-06-16T02:04:10.705315Z","steps":["trace[1375231266] 'process raft request' (duration: 372.405394ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:10.705367Z","caller":"traceutil/trace.go:171","msg":"trace[1718040148] transaction","detail":"{read_only:false; response_revision:24925; number_of_response:1; }","duration":"380.289616ms","start":"2026-06-16T02:04:10.325042Z","end":"2026-06-16T02:04:10.705331Z","steps":["trace[1718040148] 'process raft request' (duration: 152.128261ms)","trace[1718040148] 'compare' (duration: 227.089015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:10.705458Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"336.014733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:561"} {"level":"warn","ts":"2026-06-16T02:04:10.705462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:10.332716Z","time spent":"372.658891ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:04:10.70551Z","caller":"traceutil/trace.go:171","msg":"trace[636417627] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:24927; }","duration":"336.102905ms","start":"2026-06-16T02:04:10.369395Z","end":"2026-06-16T02:04:10.705497Z","steps":["trace[636417627] 'agreement among raft nodes before linearized reading' (duration: 335.933301ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:10.705515Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:10.325013Z","time spent":"380.42396ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:10.705549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:10.369377Z","time spent":"336.162687ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":71,"response count":1,"response size":585,"request content":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" "} {"level":"info","ts":"2026-06-16T02:04:10.705758Z","caller":"traceutil/trace.go:171","msg":"trace[1272195252] transaction","detail":"{read_only:false; response_revision:24927; number_of_response:1; }","duration":"370.998634ms","start":"2026-06-16T02:04:10.334747Z","end":"2026-06-16T02:04:10.705745Z","steps":["trace[1272195252] 'process raft request' (duration: 370.48877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:10.705816Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:10.334741Z","time spent":"371.044336ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:10.705879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.608132ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:10.705959Z","caller":"traceutil/trace.go:171","msg":"trace[1023579360] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:24927; }","duration":"324.765537ms","start":"2026-06-16T02:04:10.38117Z","end":"2026-06-16T02:04:10.705935Z","steps":["trace[1023579360] 'agreement among raft nodes before linearized reading' (duration: 324.559751ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:10.705994Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:10.381149Z","time spent":"324.837579ms","remote":"127.0.0.1:53476","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":30,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-06-16T02:04:10.982264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.925157ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:10.982342Z","caller":"traceutil/trace.go:171","msg":"trace[1110384642] linearizableReadLoop","detail":"{readStateIndex:25752; appliedIndex:25751; }","duration":"125.593296ms","start":"2026-06-16T02:04:10.856736Z","end":"2026-06-16T02:04:10.982329Z","steps":["trace[1110384642] 'read index received' (duration: 440.923µs)","trace[1110384642] 'applied index is now lower than readState.Index' (duration: 125.151373ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:10.982408Z","caller":"traceutil/trace.go:171","msg":"trace[833437722] transaction","detail":"{read_only:false; response_revision:24928; number_of_response:1; }","duration":"271.987026ms","start":"2026-06-16T02:04:10.710415Z","end":"2026-06-16T02:04:10.982402Z","steps":["trace[833437722] 'process raft request' (duration: 146.838393ms)","trace[833437722] 'compare' (duration: 124.571686ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:10.982769Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.994567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:10.982849Z","caller":"traceutil/trace.go:171","msg":"trace[709367173] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:24928; }","duration":"126.128351ms","start":"2026-06-16T02:04:10.856702Z","end":"2026-06-16T02:04:10.98283Z","steps":["trace[709367173] 'agreement among raft nodes before linearized reading' (duration: 125.958846ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:11.194146Z","caller":"traceutil/trace.go:171","msg":"trace[1298508085] linearizableReadLoop","detail":"{readStateIndex:25753; appliedIndex:25752; }","duration":"211.754015ms","start":"2026-06-16T02:04:10.982358Z","end":"2026-06-16T02:04:11.194112Z","steps":["trace[1298508085] 'read index received' (duration: 173.961354ms)","trace[1298508085] 'applied index is now lower than readState.Index' (duration: 37.791301ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:11.194202Z","caller":"traceutil/trace.go:171","msg":"trace[2135874539] transaction","detail":"{read_only:false; response_revision:24929; number_of_response:1; }","duration":"294.618761ms","start":"2026-06-16T02:04:10.899533Z","end":"2026-06-16T02:04:11.194152Z","steps":["trace[2135874539] 'process raft request' (duration: 256.759378ms)","trace[2135874539] 'compare' (duration: 37.632627ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:11.194359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.024898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T02:04:11.194412Z","caller":"traceutil/trace.go:171","msg":"trace[1767355008] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24929; }","duration":"287.10566ms","start":"2026-06-16T02:04:10.907292Z","end":"2026-06-16T02:04:11.194397Z","steps":["trace[1767355008] 'agreement among raft nodes before linearized reading' (duration: 286.933265ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:16.900859Z","caller":"traceutil/trace.go:171","msg":"trace[171119190] transaction","detail":"{read_only:false; response_revision:24976; number_of_response:1; }","duration":"176.150034ms","start":"2026-06-16T02:04:16.724682Z","end":"2026-06-16T02:04:16.900832Z","steps":["trace[171119190] 'process raft request' (duration: 163.966582ms)","trace[171119190] 'compare' (duration: 11.994127ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:16.901192Z","caller":"traceutil/trace.go:171","msg":"trace[902160125] transaction","detail":"{read_only:false; response_revision:24977; number_of_response:1; }","duration":"173.006665ms","start":"2026-06-16T02:04:16.728125Z","end":"2026-06-16T02:04:16.901131Z","steps":["trace[902160125] 'process raft request' (duration: 172.663546ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:16.901386Z","caller":"traceutil/trace.go:171","msg":"trace[594829481] transaction","detail":"{read_only:false; response_revision:24978; number_of_response:1; }","duration":"105.44292ms","start":"2026-06-16T02:04:16.795916Z","end":"2026-06-16T02:04:16.901358Z","steps":["trace[594829481] 'process raft request' (duration: 105.115831ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:17.460818Z","caller":"traceutil/trace.go:171","msg":"trace[1047315437] transaction","detail":"{read_only:false; response_revision:24979; number_of_response:1; }","duration":"244.410341ms","start":"2026-06-16T02:04:17.216384Z","end":"2026-06-16T02:04:17.460794Z","steps":["trace[1047315437] 'process raft request' (duration: 244.224236ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:17.502245Z","caller":"traceutil/trace.go:171","msg":"trace[907037535] linearizableReadLoop","detail":"{readStateIndex:25806; appliedIndex:25804; }","duration":"230.634024ms","start":"2026-06-16T02:04:17.271549Z","end":"2026-06-16T02:04:17.502183Z","steps":["trace[907037535] 'read index received' (duration: 189.039627ms)","trace[907037535] 'applied index is now lower than readState.Index' (duration: 41.593397ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:17.502358Z","caller":"traceutil/trace.go:171","msg":"trace[1931894405] transaction","detail":"{read_only:false; response_revision:24980; number_of_response:1; }","duration":"231.065627ms","start":"2026-06-16T02:04:17.271253Z","end":"2026-06-16T02:04:17.502318Z","steps":["trace[1931894405] 'process raft request' (duration: 230.81174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:17.502417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.857881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-16T02:04:17.502459Z","caller":"traceutil/trace.go:171","msg":"trace[1607103826] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24980; }","duration":"230.950784ms","start":"2026-06-16T02:04:17.271494Z","end":"2026-06-16T02:04:17.502445Z","steps":["trace[1607103826] 'agreement among raft nodes before linearized reading' (duration: 230.80554ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:17.751332Z","caller":"traceutil/trace.go:171","msg":"trace[890388186] linearizableReadLoop","detail":"{readStateIndex:25809; appliedIndex:25807; }","duration":"131.821371ms","start":"2026-06-16T02:04:17.619486Z","end":"2026-06-16T02:04:17.751308Z","steps":["trace[890388186] 'read index received' (duration: 118.898638ms)","trace[890388186] 'applied index is now lower than readState.Index' (duration: 12.921803ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:17.751429Z","caller":"traceutil/trace.go:171","msg":"trace[313965739] transaction","detail":"{read_only:false; response_revision:24982; number_of_response:1; }","duration":"140.422892ms","start":"2026-06-16T02:04:17.610993Z","end":"2026-06-16T02:04:17.751416Z","steps":["trace[313965739] 'process raft request' (duration: 127.271473ms)","trace[313965739] 'compare' (duration: 12.779718ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:17.75147Z","caller":"traceutil/trace.go:171","msg":"trace[1904561790] transaction","detail":"{read_only:false; response_revision:24983; number_of_response:1; }","duration":"136.101681ms","start":"2026-06-16T02:04:17.615346Z","end":"2026-06-16T02:04:17.751448Z","steps":["trace[1904561790] 'process raft request' (duration: 135.892655ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:17.751665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.325392ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T02:04:17.751698Z","caller":"traceutil/trace.go:171","msg":"trace[2111157177] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24983; }","duration":"102.415726ms","start":"2026-06-16T02:04:17.649276Z","end":"2026-06-16T02:04:17.751691Z","steps":["trace[2111157177] 'agreement among raft nodes before linearized reading' (duration: 102.313983ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:17.751779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.302664ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-16T02:04:17.751802Z","caller":"traceutil/trace.go:171","msg":"trace[244822217] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24983; }","duration":"132.363455ms","start":"2026-06-16T02:04:17.619433Z","end":"2026-06-16T02:04:17.751796Z","steps":["trace[244822217] 'agreement among raft nodes before linearized reading' (duration: 132.309264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:17.751962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.627401ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T02:04:17.75202Z","caller":"traceutil/trace.go:171","msg":"trace[1400388768] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24983; }","duration":"102.732564ms","start":"2026-06-16T02:04:17.649276Z","end":"2026-06-16T02:04:17.752008Z","steps":["trace[1400388768] 'agreement among raft nodes before linearized reading' (duration: 102.58388ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:18.131471Z","caller":"traceutil/trace.go:171","msg":"trace[202680845] transaction","detail":"{read_only:false; response_revision:24988; number_of_response:1; }","duration":"121.672576ms","start":"2026-06-16T02:04:18.009767Z","end":"2026-06-16T02:04:18.131439Z","steps":["trace[202680845] 'process raft request' (duration: 121.446839ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:18.30879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.865261ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:18.308878Z","caller":"traceutil/trace.go:171","msg":"trace[472855682] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24988; }","duration":"117.016295ms","start":"2026-06-16T02:04:18.19184Z","end":"2026-06-16T02:04:18.308856Z","steps":["trace[472855682] 'range keys from in-memory index tree' (duration: 116.761488ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:18.308883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.344166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:18.308942Z","caller":"traceutil/trace.go:171","msg":"trace[125096267] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24988; }","duration":"101.430667ms","start":"2026-06-16T02:04:18.207496Z","end":"2026-06-16T02:04:18.308927Z","steps":["trace[125096267] 'range keys from in-memory index tree' (duration: 101.252242ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:19.193356Z","caller":"traceutil/trace.go:171","msg":"trace[2007948371] transaction","detail":"{read_only:false; response_revision:24990; number_of_response:1; }","duration":"286.777431ms","start":"2026-06-16T02:04:18.906558Z","end":"2026-06-16T02:04:19.193335Z","steps":["trace[2007948371] 'process raft request' (duration: 286.637027ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:19.43847Z","caller":"traceutil/trace.go:171","msg":"trace[2130741484] linearizableReadLoop","detail":"{readStateIndex:25817; appliedIndex:25816; }","duration":"229.108081ms","start":"2026-06-16T02:04:19.209332Z","end":"2026-06-16T02:04:19.43844Z","steps":["trace[2130741484] 'read index received' (duration: 213.598886ms)","trace[2130741484] 'applied index is now lower than readState.Index' (duration: 15.507355ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:19.438628Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.276076ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:19.438683Z","caller":"traceutil/trace.go:171","msg":"trace[1396151763] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24991; }","duration":"229.375659ms","start":"2026-06-16T02:04:19.209292Z","end":"2026-06-16T02:04:19.438668Z","steps":["trace[1396151763] 'agreement among raft nodes before linearized reading' (duration: 229.267986ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:19.438963Z","caller":"traceutil/trace.go:171","msg":"trace[295393325] transaction","detail":"{read_only:false; response_revision:24991; number_of_response:1; }","duration":"532.008314ms","start":"2026-06-16T02:04:18.906926Z","end":"2026-06-16T02:04:19.438935Z","steps":["trace[295393325] 'process raft request' (duration: 516.071807ms)","trace[295393325] 'compare' (duration: 15.32441ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:19.439108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:18.906901Z","time spent":"532.125338ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:04:19.594828Z","caller":"traceutil/trace.go:171","msg":"trace[2061040232] transaction","detail":"{read_only:false; response_revision:24992; number_of_response:1; }","duration":"128.822717ms","start":"2026-06-16T02:04:19.465976Z","end":"2026-06-16T02:04:19.594799Z","steps":["trace[2061040232] 'process raft request' (duration: 116.327076ms)","trace[2061040232] 'compare' (duration: 12.146991ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:19.879045Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.931446ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:19.879185Z","caller":"traceutil/trace.go:171","msg":"trace[1062784631] transaction","detail":"{read_only:false; response_revision:24994; number_of_response:1; }","duration":"280.333559ms","start":"2026-06-16T02:04:19.598827Z","end":"2026-06-16T02:04:19.879161Z","steps":["trace[1062784631] 'process raft request' (duration: 128.166738ms)","trace[1062784631] 'compare' (duration: 151.488092ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:19.929029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.405911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-16T02:04:19.929059Z","caller":"traceutil/trace.go:171","msg":"trace[11786020] transaction","detail":"{read_only:false; response_revision:24995; number_of_response:1; }","duration":"313.740367ms","start":"2026-06-16T02:04:19.614914Z","end":"2026-06-16T02:04:19.928654Z","steps":["trace[11786020] 'process raft request' (duration: 313.424979ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:19.929118Z","caller":"traceutil/trace.go:171","msg":"trace[210127282] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:24995; }","duration":"239.588176ms","start":"2026-06-16T02:04:19.689514Z","end":"2026-06-16T02:04:19.929102Z","steps":["trace[210127282] 'agreement among raft nodes before linearized reading' (duration: 239.222096ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:19.929239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:19.614884Z","time spent":"314.254141ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:04:19.928987Z","caller":"traceutil/trace.go:171","msg":"trace[1533709959] linearizableReadLoop","detail":"{readStateIndex:25821; appliedIndex:25819; }","duration":"238.934627ms","start":"2026-06-16T02:04:19.689625Z","end":"2026-06-16T02:04:19.92856Z","steps":["trace[1533709959] 'read index received' (duration: 37.386519ms)","trace[1533709959] 'applied index is now lower than readState.Index' (duration: 201.546388ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:20.042061Z","caller":"traceutil/trace.go:171","msg":"trace[1844313850] linearizableReadLoop","detail":"{readStateIndex:25823; appliedIndex:25821; }","duration":"112.481818ms","start":"2026-06-16T02:04:19.92954Z","end":"2026-06-16T02:04:20.042022Z","steps":["trace[1844313850] 'read index received' (duration: 95.532372ms)","trace[1844313850] 'applied index is now lower than readState.Index' (duration: 16.948446ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:20.042356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.184348ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-16T02:04:20.042406Z","caller":"traceutil/trace.go:171","msg":"trace[1325923096] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24997; }","duration":"242.320773ms","start":"2026-06-16T02:04:19.800072Z","end":"2026-06-16T02:04:20.042392Z","steps":["trace[1325923096] 'agreement among raft nodes before linearized reading' (duration: 242.091586ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.042431Z","caller":"traceutil/trace.go:171","msg":"trace[246449971] transaction","detail":"{read_only:false; response_revision:24996; number_of_response:1; }","duration":"284.851236ms","start":"2026-06-16T02:04:19.757533Z","end":"2026-06-16T02:04:20.042384Z","steps":["trace[246449971] 'process raft request' (duration: 267.645593ms)","trace[246449971] 'compare' (duration: 16.511034ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:20.042583Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"warn","ts":"2026-06-16T02:04:20.0426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.045146ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance\" ","response":"range_response_count:1 size:418324"} {"level":"info","ts":"2026-06-16T02:04:20.042666Z","caller":"traceutil/trace.go:171","msg":"trace[1965706937] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24997; }","duration":"228.086423ms","start":"2026-06-16T02:04:19.814563Z","end":"2026-06-16T02:04:20.042649Z","steps":["trace[1965706937] 'agreement among raft nodes before linearized reading' (duration: 227.833866ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.042696Z","caller":"traceutil/trace.go:171","msg":"trace[754575682] range","detail":"{range_begin:/registry/nfd.k8s-sigs.io/nodefeatures/monitoring/instance; range_end:; response_count:1; response_revision:24997; }","duration":"169.191309ms","start":"2026-06-16T02:04:19.873477Z","end":"2026-06-16T02:04:20.042669Z","steps":["trace[754575682] 'agreement among raft nodes before linearized reading' (duration: 168.86079ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:20.042853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.207066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T02:04:20.042892Z","caller":"traceutil/trace.go:171","msg":"trace[34501492] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24997; }","duration":"228.237827ms","start":"2026-06-16T02:04:19.814639Z","end":"2026-06-16T02:04:20.042876Z","steps":["trace[34501492] 'agreement among raft nodes before linearized reading' (duration: 228.156045ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:20.042921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.690788ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T02:04:20.042963Z","caller":"traceutil/trace.go:171","msg":"trace[881447902] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24997; }","duration":"229.76007ms","start":"2026-06-16T02:04:19.81319Z","end":"2026-06-16T02:04:20.04295Z","steps":["trace[881447902] 'agreement among raft nodes before linearized reading' (duration: 229.656407ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.04303Z","caller":"traceutil/trace.go:171","msg":"trace[491606485] transaction","detail":"{read_only:false; response_revision:24997; number_of_response:1; }","duration":"285.402962ms","start":"2026-06-16T02:04:19.757612Z","end":"2026-06-16T02:04:20.043015Z","steps":["trace[491606485] 'process raft request' (duration: 284.338952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:20.32688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.248733ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:20.326988Z","caller":"traceutil/trace.go:171","msg":"trace[113698338] transaction","detail":"{read_only:false; response_revision:24998; number_of_response:1; }","duration":"280.118772ms","start":"2026-06-16T02:04:20.046851Z","end":"2026-06-16T02:04:20.32697Z","steps":["trace[113698338] 'process raft request' (duration: 127.663154ms)","trace[113698338] 'compare' (duration: 152.139739ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:20.330274Z","caller":"traceutil/trace.go:171","msg":"trace[1191063490] linearizableReadLoop","detail":"{readStateIndex:25827; appliedIndex:25823; }","duration":"208.827041ms","start":"2026-06-16T02:04:20.121424Z","end":"2026-06-16T02:04:20.330251Z","steps":["trace[1191063490] 'read index received' (duration: 53.105011ms)","trace[1191063490] 'applied index is now lower than readState.Index' (duration: 155.72095ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:20.330558Z","caller":"traceutil/trace.go:171","msg":"trace[2009965859] transaction","detail":"{read_only:false; response_revision:24999; number_of_response:1; }","duration":"282.805148ms","start":"2026-06-16T02:04:20.047738Z","end":"2026-06-16T02:04:20.330543Z","steps":["trace[2009965859] 'process raft request' (duration: 282.283423ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:20.330852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.392537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:04:20.330937Z","caller":"traceutil/trace.go:171","msg":"trace[1617328123] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25002; }","duration":"209.549621ms","start":"2026-06-16T02:04:20.121368Z","end":"2026-06-16T02:04:20.330918Z","steps":["trace[1617328123] 'agreement among raft nodes before linearized reading' (duration: 209.368506ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.331143Z","caller":"traceutil/trace.go:171","msg":"trace[1658756991] transaction","detail":"{read_only:false; response_revision:25000; number_of_response:1; }","duration":"282.697065ms","start":"2026-06-16T02:04:20.048435Z","end":"2026-06-16T02:04:20.331132Z","steps":["trace[1658756991] 'process raft request' (duration: 281.698837ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.331221Z","caller":"traceutil/trace.go:171","msg":"trace[42320088] transaction","detail":"{read_only:false; response_revision:25001; number_of_response:1; }","duration":"281.760768ms","start":"2026-06-16T02:04:20.04945Z","end":"2026-06-16T02:04:20.331211Z","steps":["trace[42320088] 'process raft request' (duration: 280.724299ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.331277Z","caller":"traceutil/trace.go:171","msg":"trace[1359065343] transaction","detail":"{read_only:false; response_revision:25002; number_of_response:1; }","duration":"187.791381ms","start":"2026-06-16T02:04:20.143479Z","end":"2026-06-16T02:04:20.331271Z","steps":["trace[1359065343] 'process raft request' (duration: 186.730211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:20.330885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.923533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:20.331352Z","caller":"traceutil/trace.go:171","msg":"trace[429533218] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25002; }","duration":"121.409207ms","start":"2026-06-16T02:04:20.209936Z","end":"2026-06-16T02:04:20.331345Z","steps":["trace[429533218] 'agreement among raft nodes before linearized reading' (duration: 120.894093ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.667886Z","caller":"traceutil/trace.go:171","msg":"trace[113236083] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"263.858197ms","start":"2026-06-16T02:04:20.404002Z","end":"2026-06-16T02:04:20.66786Z","steps":["trace[113236083] 'process raft request' (duration: 263.515467ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:20.992659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.969191ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:20.99291Z","caller":"traceutil/trace.go:171","msg":"trace[1787854659] transaction","detail":"{read_only:false; response_revision:25005; number_of_response:1; }","duration":"301.617617ms","start":"2026-06-16T02:04:20.691271Z","end":"2026-06-16T02:04:20.992888Z","steps":["trace[1787854659] 'process raft request' (duration: 301.505384ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:20.99295Z","caller":"traceutil/trace.go:171","msg":"trace[341689990] transaction","detail":"{read_only:false; response_revision:25004; number_of_response:1; }","duration":"432.143011ms","start":"2026-06-16T02:04:20.560745Z","end":"2026-06-16T02:04:20.992888Z","steps":["trace[341689990] 'process raft request' (duration: 261.8285ms)","trace[341689990] 'compare' (duration: 169.532099ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:20.993031Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:20.691245Z","time spent":"301.727121ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:20.993208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:20.560722Z","time spent":"432.350137ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:04:21.381582Z","caller":"traceutil/trace.go:171","msg":"trace[450108700] linearizableReadLoop","detail":"{readStateIndex:25832; appliedIndex:25831; }","duration":"262.059497ms","start":"2026-06-16T02:04:21.119484Z","end":"2026-06-16T02:04:21.381544Z","steps":["trace[450108700] 'read index received' (duration: 261.878742ms)","trace[450108700] 'applied index is now lower than readState.Index' (duration: 179.305µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:21.381675Z","caller":"traceutil/trace.go:171","msg":"trace[1172580135] transaction","detail":"{read_only:false; response_revision:25006; number_of_response:1; }","duration":"367.575079ms","start":"2026-06-16T02:04:21.01404Z","end":"2026-06-16T02:04:21.381615Z","steps":["trace[1172580135] 'process raft request' (duration: 367.26152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:21.381811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:21.014011Z","time spent":"367.716293ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":672,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:21.383393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.868097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-06-16T02:04:21.383497Z","caller":"traceutil/trace.go:171","msg":"trace[145407714] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:25006; }","duration":"263.997771ms","start":"2026-06-16T02:04:21.119477Z","end":"2026-06-16T02:04:21.383475Z","steps":["trace[145407714] 'agreement among raft nodes before linearized reading' (duration: 262.225291ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:21.389365Z","caller":"traceutil/trace.go:171","msg":"trace[719679633] transaction","detail":"{read_only:false; response_revision:25007; number_of_response:1; }","duration":"191.506056ms","start":"2026-06-16T02:04:21.197843Z","end":"2026-06-16T02:04:21.389349Z","steps":["trace[719679633] 'process raft request' (duration: 191.392783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:21.389451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.687376ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:04:21.389489Z","caller":"traceutil/trace.go:171","msg":"trace[1597605153] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:25007; }","duration":"199.788438ms","start":"2026-06-16T02:04:21.18969Z","end":"2026-06-16T02:04:21.389479Z","steps":["trace[1597605153] 'agreement among raft nodes before linearized reading' (duration: 199.643984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:21.38962Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.540218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:21.38965Z","caller":"traceutil/trace.go:171","msg":"trace[1892354003] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25007; }","duration":"180.58801ms","start":"2026-06-16T02:04:21.209051Z","end":"2026-06-16T02:04:21.389639Z","steps":["trace[1892354003] 'agreement among raft nodes before linearized reading' (duration: 180.539979ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:21.563606Z","caller":"traceutil/trace.go:171","msg":"trace[900773303] transaction","detail":"{read_only:false; response_revision:25008; number_of_response:1; }","duration":"119.666689ms","start":"2026-06-16T02:04:21.443824Z","end":"2026-06-16T02:04:21.56349Z","steps":["trace[900773303] 'process raft request' (duration: 116.706996ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:21.745233Z","caller":"traceutil/trace.go:171","msg":"trace[1388249339] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"145.183205ms","start":"2026-06-16T02:04:21.600023Z","end":"2026-06-16T02:04:21.745207Z","steps":["trace[1388249339] 'process raft request' (duration: 141.147222ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:21.745251Z","caller":"traceutil/trace.go:171","msg":"trace[358030941] transaction","detail":"{read_only:false; response_revision:25010; number_of_response:1; }","duration":"144.713643ms","start":"2026-06-16T02:04:21.600508Z","end":"2026-06-16T02:04:21.745222Z","steps":["trace[358030941] 'process raft request' (duration: 144.63245ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:22.073768Z","caller":"traceutil/trace.go:171","msg":"trace[1325977203] linearizableReadLoop","detail":"{readStateIndex:25837; appliedIndex:25836; }","duration":"112.380564ms","start":"2026-06-16T02:04:21.961362Z","end":"2026-06-16T02:04:22.073743Z","steps":["trace[1325977203] 'read index received' (duration: 112.192179ms)","trace[1325977203] 'applied index is now lower than readState.Index' (duration: 186.825µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:22.073812Z","caller":"traceutil/trace.go:171","msg":"trace[1957362455] transaction","detail":"{read_only:false; response_revision:25011; number_of_response:1; }","duration":"137.46961ms","start":"2026-06-16T02:04:21.936314Z","end":"2026-06-16T02:04:22.073784Z","steps":["trace[1957362455] 'process raft request' (duration: 137.257284ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:22.073917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.531399ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:22.073963Z","caller":"traceutil/trace.go:171","msg":"trace[1128712653] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:25011; }","duration":"112.622061ms","start":"2026-06-16T02:04:21.961329Z","end":"2026-06-16T02:04:22.073951Z","steps":["trace[1128712653] 'agreement among raft nodes before linearized reading' (duration: 112.506958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:22.320037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.324057ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:30"} {"level":"info","ts":"2026-06-16T02:04:22.3208Z","caller":"traceutil/trace.go:171","msg":"trace[1344165984] transaction","detail":"{read_only:false; response_revision:25012; number_of_response:1; }","duration":"272.393947ms","start":"2026-06-16T02:04:22.048381Z","end":"2026-06-16T02:04:22.320775Z","steps":["trace[1344165984] 'process raft request' (duration: 271.78218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:22.452143Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.11965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"warn","ts":"2026-06-16T02:04:22.452572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.077475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T02:04:22.452781Z","caller":"traceutil/trace.go:171","msg":"trace[2117787573] transaction","detail":"{read_only:false; response_revision:25014; number_of_response:1; }","duration":"115.841352ms","start":"2026-06-16T02:04:22.336478Z","end":"2026-06-16T02:04:22.452319Z","steps":["trace[2117787573] 'process raft request' (duration: 115.76671ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:22.452937Z","caller":"traceutil/trace.go:171","msg":"trace[811042028] linearizableReadLoop","detail":"{readStateIndex:25840; appliedIndex:25839; }","duration":"117.952521ms","start":"2026-06-16T02:04:22.334487Z","end":"2026-06-16T02:04:22.45244Z","steps":["trace[811042028] 'read index received' (duration: 40.441µs)","trace[811042028] 'applied index is now lower than readState.Index' (duration: 117.91054ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:22.453073Z","caller":"traceutil/trace.go:171","msg":"trace[1144333976] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25014; }","duration":"118.202068ms","start":"2026-06-16T02:04:22.334445Z","end":"2026-06-16T02:04:22.452648Z","steps":["trace[1144333976] 'agreement among raft nodes before linearized reading' (duration: 117.997952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:22.45321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.59976ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T02:04:22.453247Z","caller":"traceutil/trace.go:171","msg":"trace[1446412348] transaction","detail":"{read_only:false; response_revision:25013; number_of_response:1; }","duration":"403.205699ms","start":"2026-06-16T02:04:22.049452Z","end":"2026-06-16T02:04:22.452657Z","steps":["trace[1446412348] 'process raft request' (duration: 271.308667ms)","trace[1446412348] 'compare' (duration: 130.599916ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:22.453264Z","caller":"traceutil/trace.go:171","msg":"trace[1057760711] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25014; }","duration":"118.664721ms","start":"2026-06-16T02:04:22.334584Z","end":"2026-06-16T02:04:22.453249Z","steps":["trace[1057760711] 'agreement among raft nodes before linearized reading' (duration: 118.550718ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:22.453352Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:22.049427Z","time spent":"403.846567ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":539,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:22.453381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.736633ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T02:04:22.45344Z","caller":"traceutil/trace.go:171","msg":"trace[392685251] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25014; }","duration":"118.843756ms","start":"2026-06-16T02:04:22.33458Z","end":"2026-06-16T02:04:22.453424Z","steps":["trace[392685251] 'agreement among raft nodes before linearized reading' (duration: 118.64253ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:22.453342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.364612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-16T02:04:22.453504Z","caller":"traceutil/trace.go:171","msg":"trace[331808888] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25014; }","duration":"118.571369ms","start":"2026-06-16T02:04:22.334914Z","end":"2026-06-16T02:04:22.453485Z","steps":["trace[331808888] 'agreement among raft nodes before linearized reading' (duration: 118.246679ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:22.715969Z","caller":"traceutil/trace.go:171","msg":"trace[572802077] transaction","detail":"{read_only:false; response_revision:25016; number_of_response:1; }","duration":"258.077565ms","start":"2026-06-16T02:04:22.457858Z","end":"2026-06-16T02:04:22.715936Z","steps":["trace[572802077] 'process raft request' (duration: 239.093282ms)","trace[572802077] 'compare' (duration: 18.635123ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:22.715992Z","caller":"traceutil/trace.go:171","msg":"trace[785152133] transaction","detail":"{read_only:false; response_revision:25017; number_of_response:1; }","duration":"258.052724ms","start":"2026-06-16T02:04:22.457919Z","end":"2026-06-16T02:04:22.715972Z","steps":["trace[785152133] 'process raft request' (duration: 257.944231ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:22.716081Z","caller":"traceutil/trace.go:171","msg":"trace[1561083503] linearizableReadLoop","detail":"{readStateIndex:25845; appliedIndex:25841; }","duration":"256.47315ms","start":"2026-06-16T02:04:22.459591Z","end":"2026-06-16T02:04:22.716064Z","steps":["trace[1561083503] 'read index received' (duration: 28.114009ms)","trace[1561083503] 'applied index is now lower than readState.Index' (duration: 228.357591ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:22.71613Z","caller":"traceutil/trace.go:171","msg":"trace[1730742463] transaction","detail":"{read_only:false; response_revision:25018; number_of_response:1; }","duration":"257.680264ms","start":"2026-06-16T02:04:22.458425Z","end":"2026-06-16T02:04:22.716105Z","steps":["trace[1730742463] 'process raft request' (duration: 257.512259ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:22.71617Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.561172ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:04:22.716199Z","caller":"traceutil/trace.go:171","msg":"trace[1642193946] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:25018; }","duration":"256.623654ms","start":"2026-06-16T02:04:22.459566Z","end":"2026-06-16T02:04:22.71619Z","steps":["trace[1642193946] 'agreement among raft nodes before linearized reading' (duration: 256.559002ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:27.858037Z","caller":"traceutil/trace.go:171","msg":"trace[72790519] transaction","detail":"{read_only:false; response_revision:25052; number_of_response:1; }","duration":"268.792426ms","start":"2026-06-16T02:04:27.589206Z","end":"2026-06-16T02:04:27.857998Z","steps":["trace[72790519] 'process raft request' (duration: 268.56616ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:28.433261Z","caller":"traceutil/trace.go:171","msg":"trace[529996335] transaction","detail":"{read_only:false; response_revision:25053; number_of_response:1; }","duration":"664.71838ms","start":"2026-06-16T02:04:27.768516Z","end":"2026-06-16T02:04:28.433235Z","steps":["trace[529996335] 'process raft request' (duration: 643.281618ms)","trace[529996335] 'compare' (duration: 21.186255ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:28.433417Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:27.768492Z","time spent":"664.856063ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":498,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:04:28.433493Z","caller":"traceutil/trace.go:171","msg":"trace[1338903965] linearizableReadLoop","detail":"{readStateIndex:25882; appliedIndex:25880; }","duration":"337.447323ms","start":"2026-06-16T02:04:28.096019Z","end":"2026-06-16T02:04:28.433467Z","steps":["trace[1338903965] 'read index received' (duration: 315.783505ms)","trace[1338903965] 'applied index is now lower than readState.Index' (duration: 21.660888ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:28.433754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.71355ms","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-06-16T02:04:28.433818Z","caller":"traceutil/trace.go:171","msg":"trace[557421056] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25055; }","duration":"337.813033ms","start":"2026-06-16T02:04:28.095988Z","end":"2026-06-16T02:04:28.433801Z","steps":["trace[557421056] 'agreement among raft nodes before linearized reading' (duration: 337.624048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:28.433818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.54975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"warn","ts":"2026-06-16T02:04:28.433856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.095974Z","time spent":"337.874834ms","remote":"127.0.0.1:60616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"info","ts":"2026-06-16T02:04:28.433861Z","caller":"traceutil/trace.go:171","msg":"trace[1358736235] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25055; }","duration":"335.634662ms","start":"2026-06-16T02:04:28.098215Z","end":"2026-06-16T02:04:28.43385Z","steps":["trace[1358736235] 'agreement among raft nodes before linearized reading' (duration: 335.461558ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:28.433894Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.098199Z","time spent":"335.686923ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-06-16T02:04:28.433801Z","caller":"traceutil/trace.go:171","msg":"trace[1442446622] transaction","detail":"{read_only:false; response_revision:25054; number_of_response:1; }","duration":"664.771911ms","start":"2026-06-16T02:04:27.769008Z","end":"2026-06-16T02:04:28.433779Z","steps":["trace[1442446622] 'process raft request' (duration: 664.188825ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:28.43432Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:27.768994Z","time spent":"665.261135ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:28.68459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.667272ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:28.684863Z","caller":"traceutil/trace.go:171","msg":"trace[1804982881] transaction","detail":"{read_only:false; response_revision:25058; number_of_response:1; }","duration":"186.537576ms","start":"2026-06-16T02:04:28.498306Z","end":"2026-06-16T02:04:28.684844Z","steps":["trace[1804982881] 'process raft request' (duration: 186.486215ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:28.685123Z","caller":"traceutil/trace.go:171","msg":"trace[310825541] transaction","detail":"{read_only:false; response_revision:25057; number_of_response:1; }","duration":"208.829942ms","start":"2026-06-16T02:04:28.476264Z","end":"2026-06-16T02:04:28.685094Z","steps":["trace[310825541] 'process raft request' (duration: 208.464172ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:28.685117Z","caller":"traceutil/trace.go:171","msg":"trace[1906776482] transaction","detail":"{read_only:false; response_revision:25056; number_of_response:1; }","duration":"244.251327ms","start":"2026-06-16T02:04:28.440823Z","end":"2026-06-16T02:04:28.685074Z","steps":["trace[1906776482] 'process raft request' (duration: 109.994718ms)","trace[1906776482] 'compare' (duration: 133.522348ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:28.685209Z","caller":"traceutil/trace.go:171","msg":"trace[1222085474] linearizableReadLoop","detail":"{readStateIndex:25884; appliedIndex:25883; }","duration":"244.313218ms","start":"2026-06-16T02:04:28.440852Z","end":"2026-06-16T02:04:28.685165Z","steps":["trace[1222085474] 'read index received' (duration: 109.891845ms)","trace[1222085474] 'applied index is now lower than readState.Index' (duration: 134.414093ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:28.685383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.523894ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18352"} {"level":"info","ts":"2026-06-16T02:04:28.685414Z","caller":"traceutil/trace.go:171","msg":"trace[1908574045] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25058; }","duration":"244.573636ms","start":"2026-06-16T02:04:28.44083Z","end":"2026-06-16T02:04:28.685404Z","steps":["trace[1908574045] 'agreement among raft nodes before linearized reading' (duration: 244.424552ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.133497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.352839ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:29.133566Z","caller":"traceutil/trace.go:171","msg":"trace[1487948487] linearizableReadLoop","detail":"{readStateIndex:25887; appliedIndex:25886; }","duration":"448.179232ms","start":"2026-06-16T02:04:28.685377Z","end":"2026-06-16T02:04:29.133557Z","steps":["trace[1487948487] 'read index received' (duration: 151.621227ms)","trace[1487948487] 'applied index is now lower than readState.Index' (duration: 296.557175ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:29.133693Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"684.592739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:29.133715Z","caller":"traceutil/trace.go:171","msg":"trace[350930802] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25059; }","duration":"684.633359ms","start":"2026-06-16T02:04:28.449075Z","end":"2026-06-16T02:04:29.133709Z","steps":["trace[350930802] 'agreement among raft nodes before linearized reading' (duration: 684.594778ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.133732Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.449063Z","time spent":"684.665301ms","remote":"127.0.0.1:57824","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" "} {"level":"warn","ts":"2026-06-16T02:04:29.133928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"551.687397ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-16T02:04:29.134028Z","caller":"traceutil/trace.go:171","msg":"trace[258408849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25059; }","duration":"551.79781ms","start":"2026-06-16T02:04:28.582207Z","end":"2026-06-16T02:04:29.134005Z","steps":["trace[258408849] 'agreement among raft nodes before linearized reading' (duration: 551.43634ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.134096Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.582124Z","time spent":"551.957725ms","remote":"127.0.0.1:57812","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":"info","ts":"2026-06-16T02:04:29.134225Z","caller":"traceutil/trace.go:171","msg":"trace[1282274955] transaction","detail":"{read_only:false; response_revision:25059; number_of_response:1; }","duration":"555.409422ms","start":"2026-06-16T02:04:28.578778Z","end":"2026-06-16T02:04:29.134187Z","steps":["trace[1282274955] 'process raft request' (duration: 258.310451ms)","trace[1282274955] 'compare' (duration: 296.208876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:29.134396Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.578748Z","time spent":"555.561776ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:29.134478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"497.152816ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:04:29.13459Z","caller":"traceutil/trace.go:171","msg":"trace[932972882] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:25059; }","duration":"497.333771ms","start":"2026-06-16T02:04:28.637227Z","end":"2026-06-16T02:04:29.134561Z","steps":["trace[932972882] 'agreement among raft nodes before linearized reading' (duration: 496.94794ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.134665Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.637202Z","time spent":"497.444824ms","remote":"127.0.0.1:47026","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":37,"response size":32,"request content":"key:\"/registry/cert-manager.io/certificates/\" range_end:\"/registry/cert-manager.io/certificates0\" count_only:true "} {"level":"info","ts":"2026-06-16T02:04:29.329382Z","caller":"traceutil/trace.go:171","msg":"trace[1977536697] transaction","detail":"{read_only:false; response_revision:25060; number_of_response:1; }","duration":"306.883265ms","start":"2026-06-16T02:04:29.022466Z","end":"2026-06-16T02:04:29.32935Z","steps":["trace[1977536697] 'process raft request' (duration: 304.159319ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.329598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"572.318817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:29.329658Z","caller":"traceutil/trace.go:171","msg":"trace[33999362] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25061; }","duration":"572.433089ms","start":"2026-06-16T02:04:28.757211Z","end":"2026-06-16T02:04:29.329644Z","steps":["trace[33999362] 'agreement among raft nodes before linearized reading' (duration: 572.277925ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.329698Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.757183Z","time spent":"572.508432ms","remote":"127.0.0.1:58056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-16T02:04:29.329779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.75655ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T02:04:29.329818Z","caller":"traceutil/trace.go:171","msg":"trace[284324367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25061; }","duration":"587.810011ms","start":"2026-06-16T02:04:28.741999Z","end":"2026-06-16T02:04:29.329809Z","steps":["trace[284324367] 'agreement among raft nodes before linearized reading' (duration: 587.646316ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.32977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.289717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-16T02:04:29.329853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.741992Z","time spent":"587.853912ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-16T02:04:29.3296Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:29.02244Z","time spent":"307.07931ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:29.329921Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"492.767573ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:29.329923Z","caller":"traceutil/trace.go:171","msg":"trace[1757407955] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25061; }","duration":"587.435601ms","start":"2026-06-16T02:04:28.742435Z","end":"2026-06-16T02:04:29.329871Z","steps":["trace[1757407955] 'agreement among raft nodes before linearized reading' (duration: 587.129692ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:29.329955Z","caller":"traceutil/trace.go:171","msg":"trace[1982609296] range","detail":"{range_begin:/registry/cluster.x-k8s.io/machinehealthchecks/; range_end:/registry/cluster.x-k8s.io/machinehealthchecks0; response_count:0; response_revision:25061; }","duration":"507.403554ms","start":"2026-06-16T02:04:28.822541Z","end":"2026-06-16T02:04:29.329945Z","steps":["trace[1982609296] 'agreement among raft nodes before linearized reading' (duration: 507.346472ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.329993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.822507Z","time spent":"507.478396ms","remote":"127.0.0.1:35436","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":30,"request content":"key:\"/registry/cluster.x-k8s.io/machinehealthchecks/\" range_end:\"/registry/cluster.x-k8s.io/machinehealthchecks0\" count_only:true "} {"level":"warn","ts":"2026-06-16T02:04:29.330002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.74243Z","time spent":"587.531753ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-16T02:04:29.330368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"591.924656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T02:04:29.330409Z","caller":"traceutil/trace.go:171","msg":"trace[623088178] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25061; }","duration":"592.008479ms","start":"2026-06-16T02:04:28.73839Z","end":"2026-06-16T02:04:29.330399Z","steps":["trace[623088178] 'agreement among raft nodes before linearized reading' (duration: 591.899746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:29.330445Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:28.738366Z","time spent":"592.069551ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-06-16T02:04:29.331829Z","caller":"traceutil/trace.go:171","msg":"trace[620195393] linearizableReadLoop","detail":"{readStateIndex:25888; appliedIndex:25887; }","duration":"195.861598ms","start":"2026-06-16T02:04:29.133579Z","end":"2026-06-16T02:04:29.329441Z","steps":["trace[620195393] 'read index received' (duration: 192.063091ms)","trace[620195393] 'applied index is now lower than readState.Index' (duration: 3.795347ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:29.34117Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.674565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T02:04:29.341189Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.97517ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:29.341232Z","caller":"traceutil/trace.go:171","msg":"trace[2037853084] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25064; }","duration":"202.042051ms","start":"2026-06-16T02:04:29.139176Z","end":"2026-06-16T02:04:29.341218Z","steps":["trace[2037853084] 'agreement among raft nodes before linearized reading' (duration: 201.965069ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:29.341228Z","caller":"traceutil/trace.go:171","msg":"trace[183264641] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25064; }","duration":"132.768917ms","start":"2026-06-16T02:04:29.208443Z","end":"2026-06-16T02:04:29.341212Z","steps":["trace[183264641] 'agreement among raft nodes before linearized reading' (duration: 132.685095ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:29.341173Z","caller":"traceutil/trace.go:171","msg":"trace[586967978] transaction","detail":"{read_only:false; response_revision:25061; number_of_response:1; }","duration":"200.285732ms","start":"2026-06-16T02:04:29.140718Z","end":"2026-06-16T02:04:29.341004Z","steps":["trace[586967978] 'process raft request' (duration: 188.630015ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:38.65111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.049005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21475566-dd51-4a93-8d0f-6f909bbca348\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-16T02:04:38.651205Z","caller":"traceutil/trace.go:171","msg":"trace[345256722] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-21475566-dd51-4a93-8d0f-6f909bbca348; range_end:; response_count:1; response_revision:25184; }","duration":"216.193569ms","start":"2026-06-16T02:04:38.434991Z","end":"2026-06-16T02:04:38.651184Z","steps":["trace[345256722] 'range keys from in-memory index tree' (duration: 215.85243ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:38.651696Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.481604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:38.651978Z","caller":"traceutil/trace.go:171","msg":"trace[845571192] transaction","detail":"{read_only:false; response_revision:25186; number_of_response:1; }","duration":"176.494694ms","start":"2026-06-16T02:04:38.475469Z","end":"2026-06-16T02:04:38.651964Z","steps":["trace[845571192] 'process raft request' (duration: 176.359911ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:38.651973Z","caller":"traceutil/trace.go:171","msg":"trace[2025269599] transaction","detail":"{read_only:false; response_revision:25185; number_of_response:1; }","duration":"177.585126ms","start":"2026-06-16T02:04:38.474345Z","end":"2026-06-16T02:04:38.65193Z","steps":["trace[2025269599] 'process raft request' (duration: 31.785983ms)","trace[2025269599] 'compare' (duration: 144.975029ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:38.652091Z","caller":"traceutil/trace.go:171","msg":"trace[1612247050] linearizableReadLoop","detail":"{readStateIndex:26017; appliedIndex:26014; }","duration":"169.160338ms","start":"2026-06-16T02:04:38.482903Z","end":"2026-06-16T02:04:38.652064Z","steps":["trace[1612247050] 'read index received' (duration: 23.191011ms)","trace[1612247050] 'applied index is now lower than readState.Index' (duration: 145.967847ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:38.652156Z","caller":"traceutil/trace.go:171","msg":"trace[802510128] transaction","detail":"{read_only:false; response_revision:25187; number_of_response:1; }","duration":"176.228437ms","start":"2026-06-16T02:04:38.475868Z","end":"2026-06-16T02:04:38.652096Z","steps":["trace[802510128] 'process raft request' (duration: 176.056282ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:38.652303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.367315ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:1854"} {"level":"warn","ts":"2026-06-16T02:04:38.652353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.76829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/floatingips/\" range_end:\"/registry/openstack.k-orc.cloud/floatingips0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:38.6524Z","caller":"traceutil/trace.go:171","msg":"trace[1598223213] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/datadir-percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25187; }","duration":"169.509538ms","start":"2026-06-16T02:04:38.48287Z","end":"2026-06-16T02:04:38.652379Z","steps":["trace[1598223213] 'agreement among raft nodes before linearized reading' (duration: 169.279922ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:38.652409Z","caller":"traceutil/trace.go:171","msg":"trace[569982422] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/floatingips/; range_end:/registry/openstack.k-orc.cloud/floatingips0; response_count:0; response_revision:25187; }","duration":"156.886394ms","start":"2026-06-16T02:04:38.495504Z","end":"2026-06-16T02:04:38.65239Z","steps":["trace[569982422] 'agreement among raft nodes before linearized reading' (duration: 156.774381ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:38.92324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.435937ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:38.923361Z","caller":"traceutil/trace.go:171","msg":"trace[2039423534] linearizableReadLoop","detail":"{readStateIndex:26018; appliedIndex:26017; }","duration":"182.265077ms","start":"2026-06-16T02:04:38.741079Z","end":"2026-06-16T02:04:38.923344Z","steps":["trace[2039423534] 'read index received' (duration: 54.49053ms)","trace[2039423534] 'applied index is now lower than readState.Index' (duration: 127.770957ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:38.923469Z","caller":"traceutil/trace.go:171","msg":"trace[82944469] transaction","detail":"{read_only:false; response_revision:25188; number_of_response:1; }","duration":"204.129711ms","start":"2026-06-16T02:04:38.719248Z","end":"2026-06-16T02:04:38.923378Z","steps":["trace[82944469] 'process raft request' (duration: 76.463567ms)","trace[82944469] 'compare' (duration: 127.297013ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:38.923548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.452782ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T02:04:38.923633Z","caller":"traceutil/trace.go:171","msg":"trace[326130620] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25188; }","duration":"182.583305ms","start":"2026-06-16T02:04:38.741026Z","end":"2026-06-16T02:04:38.923609Z","steps":["trace[326130620] 'agreement among raft nodes before linearized reading' (duration: 182.363109ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.293539Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.320542ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:39.293787Z","caller":"traceutil/trace.go:171","msg":"trace[183071036] transaction","detail":"{read_only:false; response_revision:25189; number_of_response:1; }","duration":"364.643806ms","start":"2026-06-16T02:04:38.929117Z","end":"2026-06-16T02:04:39.293761Z","steps":["trace[183071036] 'process raft request' (duration: 132.006975ms)","trace[183071036] 'compare' (duration: 231.997923ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:39.293823Z","caller":"traceutil/trace.go:171","msg":"trace[134761959] transaction","detail":"{read_only:false; response_revision:25190; number_of_response:1; }","duration":"122.305694ms","start":"2026-06-16T02:04:39.171507Z","end":"2026-06-16T02:04:39.293813Z","steps":["trace[134761959] 'process raft request' (duration: 122.136249ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.293883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:38.929102Z","time spent":"364.737649ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:39.294062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.509394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21475566-dd51-4a93-8d0f-6f909bbca348\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-16T02:04:39.294107Z","caller":"traceutil/trace.go:171","msg":"trace[1626281411] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-21475566-dd51-4a93-8d0f-6f909bbca348; range_end:; response_count:1; response_revision:25190; }","duration":"130.622987ms","start":"2026-06-16T02:04:39.163474Z","end":"2026-06-16T02:04:39.294097Z","steps":["trace[1626281411] 'agreement among raft nodes before linearized reading' (duration: 130.459932ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.293885Z","caller":"traceutil/trace.go:171","msg":"trace[410787614] linearizableReadLoop","detail":"{readStateIndex:26019; appliedIndex:26018; }","duration":"130.280107ms","start":"2026-06-16T02:04:39.163553Z","end":"2026-06-16T02:04:39.293833Z","steps":["trace[410787614] 'read index received' (duration: 81.212µs)","trace[410787614] 'applied index is now lower than readState.Index' (duration: 130.195065ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:39.520191Z","caller":"traceutil/trace.go:171","msg":"trace[1449865642] linearizableReadLoop","detail":"{readStateIndex:26021; appliedIndex:26020; }","duration":"165.796644ms","start":"2026-06-16T02:04:39.354374Z","end":"2026-06-16T02:04:39.520171Z","steps":["trace[1449865642] 'read index received' (duration: 165.63984ms)","trace[1449865642] 'applied index is now lower than readState.Index' (duration: 155.864µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:39.520226Z","caller":"traceutil/trace.go:171","msg":"trace[900317216] transaction","detail":"{read_only:false; response_revision:25191; number_of_response:1; }","duration":"219.231024ms","start":"2026-06-16T02:04:39.300979Z","end":"2026-06-16T02:04:39.520211Z","steps":["trace[900317216] 'process raft request' (duration: 219.065289ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.520311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.931558ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:39.52035Z","caller":"traceutil/trace.go:171","msg":"trace[950562496] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:25191; }","duration":"166.041321ms","start":"2026-06-16T02:04:39.354299Z","end":"2026-06-16T02:04:39.52034Z","steps":["trace[950562496] 'agreement among raft nodes before linearized reading' (duration: 165.953058ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.776049Z","caller":"traceutil/trace.go:171","msg":"trace[1993073583] transaction","detail":"{read_only:false; response_revision:25192; number_of_response:1; }","duration":"408.152088ms","start":"2026-06-16T02:04:39.367848Z","end":"2026-06-16T02:04:39.776Z","steps":["trace[1993073583] 'process raft request' (duration: 342.977668ms)","trace[1993073583] 'compare' (duration: 64.83861ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:39.77609Z","caller":"traceutil/trace.go:171","msg":"trace[866921215] transaction","detail":"{read_only:false; response_revision:25193; number_of_response:1; }","duration":"313.132551ms","start":"2026-06-16T02:04:39.462939Z","end":"2026-06-16T02:04:39.776072Z","steps":["trace[866921215] 'process raft request' (duration: 312.929085ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.776175Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.367777ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-16T02:04:39.776195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.367805Z","time spent":"408.316102ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:04:39.776224Z","caller":"traceutil/trace.go:171","msg":"trace[784676580] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25193; }","duration":"318.45518ms","start":"2026-06-16T02:04:39.457757Z","end":"2026-06-16T02:04:39.776212Z","steps":["trace[784676580] 'agreement among raft nodes before linearized reading' (duration: 318.284005ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.776246Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.457738Z","time spent":"318.503452ms","remote":"127.0.0.1:60616","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12237,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-16T02:04:39.776239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.785242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-16T02:04:39.776279Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.462903Z","time spent":"313.226333ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:04:39.776285Z","caller":"traceutil/trace.go:171","msg":"trace[119096821] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25193; }","duration":"384.876555ms","start":"2026-06-16T02:04:39.391399Z","end":"2026-06-16T02:04:39.776275Z","steps":["trace[119096821] 'agreement among raft nodes before linearized reading' (duration: 384.70221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.776323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.391382Z","time spent":"384.933016ms","remote":"127.0.0.1:57812","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":"info","ts":"2026-06-16T02:04:39.77605Z","caller":"traceutil/trace.go:171","msg":"trace[1243154845] linearizableReadLoop","detail":"{readStateIndex:26023; appliedIndex:26021; }","duration":"255.773941ms","start":"2026-06-16T02:04:39.520252Z","end":"2026-06-16T02:04:39.776025Z","steps":["trace[1243154845] 'read index received' (duration: 190.55685ms)","trace[1243154845] 'applied index is now lower than readState.Index' (duration: 65.21608ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:39.776416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.792995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1782"} {"level":"warn","ts":"2026-06-16T02:04:39.776433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"375.309116ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:39.776466Z","caller":"traceutil/trace.go:171","msg":"trace[1659803868] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25193; }","duration":"375.388139ms","start":"2026-06-16T02:04:39.401066Z","end":"2026-06-16T02:04:39.776454Z","steps":["trace[1659803868] 'agreement among raft nodes before linearized reading' (duration: 375.334347ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.776495Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.401042Z","time spent":"375.44547ms","remote":"127.0.0.1:49272","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":30,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true "} {"level":"warn","ts":"2026-06-16T02:04:39.776502Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.039646ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:39.776558Z","caller":"traceutil/trace.go:171","msg":"trace[23076698] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:25193; }","duration":"252.087337ms","start":"2026-06-16T02:04:39.524451Z","end":"2026-06-16T02:04:39.776538Z","steps":["trace[23076698] 'agreement among raft nodes before linearized reading' (duration: 252.017145ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.776441Z","caller":"traceutil/trace.go:171","msg":"trace[1107398060] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:25193; }","duration":"294.856147ms","start":"2026-06-16T02:04:39.481575Z","end":"2026-06-16T02:04:39.776431Z","steps":["trace[1107398060] 'agreement among raft nodes before linearized reading' (duration: 294.786255ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.776771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.15487ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"warn","ts":"2026-06-16T02:04:39.776776Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.679125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T02:04:39.776797Z","caller":"traceutil/trace.go:171","msg":"trace[2018568954] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25193; }","duration":"381.193531ms","start":"2026-06-16T02:04:39.395595Z","end":"2026-06-16T02:04:39.776788Z","steps":["trace[2018568954] 'agreement among raft nodes before linearized reading' (duration: 381.120949ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.776809Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.144163ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-21475566-dd51-4a93-8d0f-6f909bbca348\" ","response":"range_response_count:1 size:3763"} {"level":"warn","ts":"2026-06-16T02:04:39.776829Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.39559Z","time spent":"381.233232ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":519,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-16T02:04:39.776828Z","caller":"traceutil/trace.go:171","msg":"trace[1434490600] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25193; }","duration":"381.757097ms","start":"2026-06-16T02:04:39.395059Z","end":"2026-06-16T02:04:39.776816Z","steps":["trace[1434490600] 'agreement among raft nodes before linearized reading' (duration: 381.592522ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.776848Z","caller":"traceutil/trace.go:171","msg":"trace[968443416] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-21475566-dd51-4a93-8d0f-6f909bbca348; range_end:; response_count:1; response_revision:25193; }","duration":"120.249895ms","start":"2026-06-16T02:04:39.656585Z","end":"2026-06-16T02:04:39.776835Z","steps":["trace[968443416] 'agreement among raft nodes before linearized reading' (duration: 120.141242ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.776859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.395051Z","time spent":"381.803238ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":465,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-16T02:04:39.776892Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.310825ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T02:04:39.776928Z","caller":"traceutil/trace.go:171","msg":"trace[1170999655] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25193; }","duration":"381.347296ms","start":"2026-06-16T02:04:39.395571Z","end":"2026-06-16T02:04:39.776918Z","steps":["trace[1170999655] 'agreement among raft nodes before linearized reading' (duration: 381.239073ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.77696Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.39554Z","time spent":"381.413688ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-06-16T02:04:39.91777Z","caller":"traceutil/trace.go:171","msg":"trace[1238005204] transaction","detail":"{read_only:false; response_revision:25194; number_of_response:1; }","duration":"137.060847ms","start":"2026-06-16T02:04:39.780669Z","end":"2026-06-16T02:04:39.91773Z","steps":["trace[1238005204] 'process raft request' (duration: 134.574177ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.917981Z","caller":"traceutil/trace.go:171","msg":"trace[1133541577] transaction","detail":"{read_only:false; response_revision:25195; number_of_response:1; }","duration":"136.813171ms","start":"2026-06-16T02:04:39.781143Z","end":"2026-06-16T02:04:39.917957Z","steps":["trace[1133541577] 'process raft request' (duration: 136.490222ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.918839Z","caller":"traceutil/trace.go:171","msg":"trace[259642055] linearizableReadLoop","detail":"{readStateIndex:26026; appliedIndex:26023; }","duration":"137.48925ms","start":"2026-06-16T02:04:39.781329Z","end":"2026-06-16T02:04:39.918818Z","steps":["trace[259642055] 'read index received' (duration: 133.987502ms)","trace[259642055] 'applied index is now lower than readState.Index' (duration: 3.500198ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:39.919388Z","caller":"traceutil/trace.go:171","msg":"trace[1250360740] transaction","detail":"{read_only:false; response_revision:25197; number_of_response:1; }","duration":"137.326555ms","start":"2026-06-16T02:04:39.782027Z","end":"2026-06-16T02:04:39.919353Z","steps":["trace[1250360740] 'process raft request' (duration: 136.631225ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.919463Z","caller":"traceutil/trace.go:171","msg":"trace[1382554148] transaction","detail":"{read_only:false; response_revision:25196; number_of_response:1; }","duration":"138.21476ms","start":"2026-06-16T02:04:39.781226Z","end":"2026-06-16T02:04:39.919441Z","steps":["trace[1382554148] 'process raft request' (duration: 136.517323ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.919494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.108717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:39.919617Z","caller":"traceutil/trace.go:171","msg":"trace[2132499040] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25198; }","duration":"138.284941ms","start":"2026-06-16T02:04:39.781303Z","end":"2026-06-16T02:04:39.919588Z","steps":["trace[2132499040] 'agreement among raft nodes before linearized reading' (duration: 138.003753ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:39.919712Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.994904ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"warn","ts":"2026-06-16T02:04:39.919891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.190099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-5f6f8e8e-869b-4c5b-bee4-a9029c7c0468\" ","response":"range_response_count:1 size:1276"} {"level":"info","ts":"2026-06-16T02:04:39.919941Z","caller":"traceutil/trace.go:171","msg":"trace[1587649711] range","detail":"{range_begin:/registry/persistentvolumes/pvc-5f6f8e8e-869b-4c5b-bee4-a9029c7c0468; range_end:; response_count:1; response_revision:25198; }","duration":"138.257461ms","start":"2026-06-16T02:04:39.78167Z","end":"2026-06-16T02:04:39.919927Z","steps":["trace[1587649711] 'agreement among raft nodes before linearized reading' (duration: 138.137308ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:39.920008Z","caller":"traceutil/trace.go:171","msg":"trace[108518779] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25198; }","duration":"138.216569ms","start":"2026-06-16T02:04:39.781624Z","end":"2026-06-16T02:04:39.919841Z","steps":["trace[108518779] 'agreement among raft nodes before linearized reading' (duration: 137.782067ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:40.327326Z","caller":"traceutil/trace.go:171","msg":"trace[1362878154] linearizableReadLoop","detail":"{readStateIndex:26029; appliedIndex:26028; }","duration":"334.416118ms","start":"2026-06-16T02:04:39.992874Z","end":"2026-06-16T02:04:40.32729Z","steps":["trace[1362878154] 'read index received' (duration: 334.073168ms)","trace[1362878154] 'applied index is now lower than readState.Index' (duration: 341.51µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:40.327359Z","caller":"traceutil/trace.go:171","msg":"trace[754245779] transaction","detail":"{read_only:false; response_revision:25199; number_of_response:1; }","duration":"369.979606ms","start":"2026-06-16T02:04:39.957352Z","end":"2026-06-16T02:04:40.327332Z","steps":["trace[754245779] 'process raft request' (duration: 369.708228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:40.32747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"334.574862ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:04:40.327506Z","caller":"traceutil/trace.go:171","msg":"trace[1401042850] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25199; }","duration":"334.658434ms","start":"2026-06-16T02:04:39.99284Z","end":"2026-06-16T02:04:40.327498Z","steps":["trace[1401042850] 'agreement among raft nodes before linearized reading' (duration: 334.572712ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:40.327531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.992824Z","time spent":"334.701376ms","remote":"127.0.0.1:58056","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":0,"response size":30,"request content":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" "} {"level":"warn","ts":"2026-06-16T02:04:40.327567Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:04:39.957328Z","time spent":"370.11751ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":628,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:04:46.072567Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.325149ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:04:46.072873Z","caller":"traceutil/trace.go:171","msg":"trace[537304217] linearizableReadLoop","detail":"{readStateIndex:26088; appliedIndex:26086; }","duration":"127.686725ms","start":"2026-06-16T02:04:45.945161Z","end":"2026-06-16T02:04:46.072848Z","steps":["trace[537304217] 'read index received' (duration: 72.474205ms)","trace[537304217] 'applied index is now lower than readState.Index' (duration: 55.21094ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:04:46.072881Z","caller":"traceutil/trace.go:171","msg":"trace[136951920] transaction","detail":"{read_only:false; response_revision:25256; number_of_response:1; }","duration":"128.120167ms","start":"2026-06-16T02:04:45.944734Z","end":"2026-06-16T02:04:46.072854Z","steps":["trace[136951920] 'process raft request' (duration: 128.042405ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:46.072873Z","caller":"traceutil/trace.go:171","msg":"trace[856946602] transaction","detail":"{read_only:false; response_revision:25255; number_of_response:1; }","duration":"274.250728ms","start":"2026-06-16T02:04:45.798575Z","end":"2026-06-16T02:04:46.072825Z","steps":["trace[856946602] 'process raft request' (duration: 128.499097ms)","trace[856946602] 'compare' (duration: 145.077792ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:04:46.073138Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.900861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-16T02:04:46.073179Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.042096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-16T02:04:46.073226Z","caller":"traceutil/trace.go:171","msg":"trace[334172619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25256; }","duration":"127.123028ms","start":"2026-06-16T02:04:45.946087Z","end":"2026-06-16T02:04:46.07321Z","steps":["trace[334172619] 'agreement among raft nodes before linearized reading' (duration: 126.927163ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:46.073224Z","caller":"traceutil/trace.go:171","msg":"trace[1325659194] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25256; }","duration":"128.075655ms","start":"2026-06-16T02:04:45.945127Z","end":"2026-06-16T02:04:46.073203Z","steps":["trace[1325659194] 'agreement among raft nodes before linearized reading' (duration: 127.776127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:46.073222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.352369ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-16T02:04:46.073281Z","caller":"traceutil/trace.go:171","msg":"trace[1723418852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25256; }","duration":"125.449142ms","start":"2026-06-16T02:04:45.947817Z","end":"2026-06-16T02:04:46.073266Z","steps":["trace[1723418852] 'agreement among raft nodes before linearized reading' (duration: 125.294577ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:04:46.073694Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.797453ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-06-16T02:04:46.073746Z","caller":"traceutil/trace.go:171","msg":"trace[1203911126] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25256; }","duration":"125.338139ms","start":"2026-06-16T02:04:45.94839Z","end":"2026-06-16T02:04:46.073729Z","steps":["trace[1203911126] 'agreement among raft nodes before linearized reading' (duration: 124.643789ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:46.182529Z","caller":"traceutil/trace.go:171","msg":"trace[868601536] transaction","detail":"{read_only:false; response_revision:25258; number_of_response:1; }","duration":"104.408181ms","start":"2026-06-16T02:04:46.078095Z","end":"2026-06-16T02:04:46.182503Z","steps":["trace[868601536] 'process raft request' (duration: 95.969665ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:46.182721Z","caller":"traceutil/trace.go:171","msg":"trace[728426384] transaction","detail":"{read_only:false; response_revision:25259; number_of_response:1; }","duration":"104.587256ms","start":"2026-06-16T02:04:46.078117Z","end":"2026-06-16T02:04:46.182704Z","steps":["trace[728426384] 'process raft request' (duration: 104.330889ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:04:46.182994Z","caller":"traceutil/trace.go:171","msg":"trace[515633887] transaction","detail":"{read_only:false; response_revision:25260; number_of_response:1; }","duration":"104.689549ms","start":"2026-06-16T02:04:46.078269Z","end":"2026-06-16T02:04:46.182959Z","steps":["trace[515633887] 'process raft request' (duration: 104.36218ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:00.114095Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006665.wal"} {"level":"info","ts":"2026-06-16T02:05:03.510348Z","caller":"traceutil/trace.go:171","msg":"trace[424068781] linearizableReadLoop","detail":"{readStateIndex:26267; appliedIndex:26266; }","duration":"109.184985ms","start":"2026-06-16T02:05:03.401111Z","end":"2026-06-16T02:05:03.510296Z","steps":["trace[424068781] 'read index received' (duration: 108.842505ms)","trace[424068781] 'applied index is now lower than readState.Index' (duration: 341.15µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:03.510921Z","caller":"traceutil/trace.go:171","msg":"trace[828556539] transaction","detail":"{read_only:false; response_revision:25431; number_of_response:1; }","duration":"138.56702ms","start":"2026-06-16T02:05:03.372324Z","end":"2026-06-16T02:05:03.510891Z","steps":["trace[828556539] 'process raft request' (duration: 137.655104ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:03.511135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.997587ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T02:05:03.511199Z","caller":"traceutil/trace.go:171","msg":"trace[41379671] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25431; }","duration":"110.08921ms","start":"2026-06-16T02:05:03.401093Z","end":"2026-06-16T02:05:03.511182Z","steps":["trace[41379671] 'agreement among raft nodes before linearized reading' (duration: 109.858563ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:03.635917Z","caller":"traceutil/trace.go:171","msg":"trace[1913705298] transaction","detail":"{read_only:false; response_revision:25432; number_of_response:1; }","duration":"121.224364ms","start":"2026-06-16T02:05:03.514658Z","end":"2026-06-16T02:05:03.635883Z","steps":["trace[1913705298] 'process raft request' (duration: 110.07531ms)","trace[1913705298] 'compare' (duration: 10.958888ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:04.123363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.441233ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:05:04.123482Z","caller":"traceutil/trace.go:171","msg":"trace[1925189617] transaction","detail":"{read_only:false; response_revision:25433; number_of_response:1; }","duration":"188.867372ms","start":"2026-06-16T02:05:03.934595Z","end":"2026-06-16T02:05:04.123462Z","steps":["trace[1925189617] 'process raft request' (duration: 64.238163ms)","trace[1925189617] 'compare' (duration: 124.296079ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:04.361554Z","caller":"traceutil/trace.go:171","msg":"trace[527715339] transaction","detail":"{read_only:false; response_revision:25434; number_of_response:1; }","duration":"227.872566ms","start":"2026-06-16T02:05:04.133641Z","end":"2026-06-16T02:05:04.361513Z","steps":["trace[527715339] 'process raft request' (duration: 227.64606ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.437411Z","caller":"traceutil/trace.go:171","msg":"trace[1003582929] linearizableReadLoop","detail":"{readStateIndex:26271; appliedIndex:26269; }","duration":"226.950581ms","start":"2026-06-16T02:05:04.210435Z","end":"2026-06-16T02:05:04.437386Z","steps":["trace[1003582929] 'read index received' (duration: 150.859055ms)","trace[1003582929] 'applied index is now lower than readState.Index' (duration: 76.090406ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:04.437579Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.133596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:05:04.437619Z","caller":"traceutil/trace.go:171","msg":"trace[291476523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25435; }","duration":"227.212988ms","start":"2026-06-16T02:05:04.210394Z","end":"2026-06-16T02:05:04.437607Z","steps":["trace[291476523] 'agreement among raft nodes before linearized reading' (duration: 227.135336ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.43759Z","caller":"traceutil/trace.go:171","msg":"trace[353794820] transaction","detail":"{read_only:false; response_revision:25435; number_of_response:1; }","duration":"301.923706ms","start":"2026-06-16T02:05:04.135626Z","end":"2026-06-16T02:05:04.43755Z","steps":["trace[353794820] 'process raft request' (duration: 301.626127ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:04.437761Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:04.135604Z","time spent":"302.064569ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:05:04.437871Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.675187ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-16T02:05:04.437886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.46695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-16T02:05:04.43795Z","caller":"traceutil/trace.go:171","msg":"trace[2001352657] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25435; }","duration":"198.795631ms","start":"2026-06-16T02:05:04.239133Z","end":"2026-06-16T02:05:04.437929Z","steps":["trace[2001352657] 'agreement among raft nodes before linearized reading' (duration: 198.534963ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:04.43794Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.825552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-06-16T02:05:04.437973Z","caller":"traceutil/trace.go:171","msg":"trace[1402764372] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25435; }","duration":"173.584863ms","start":"2026-06-16T02:05:04.264362Z","end":"2026-06-16T02:05:04.437947Z","steps":["trace[1402764372] 'agreement among raft nodes before linearized reading' (duration: 173.365097ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.43801Z","caller":"traceutil/trace.go:171","msg":"trace[1386606883] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25435; }","duration":"172.926144ms","start":"2026-06-16T02:05:04.265065Z","end":"2026-06-16T02:05:04.437991Z","steps":["trace[1386606883] 'agreement among raft nodes before linearized reading' (duration: 172.676757ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:04.438042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.795352ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-16T02:05:04.438154Z","caller":"traceutil/trace.go:171","msg":"trace[1851214505] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25435; }","duration":"187.986067ms","start":"2026-06-16T02:05:04.250141Z","end":"2026-06-16T02:05:04.438127Z","steps":["trace[1851214505] 'agreement among raft nodes before linearized reading' (duration: 187.595026ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.579772Z","caller":"traceutil/trace.go:171","msg":"trace[627354805] transaction","detail":"{read_only:false; response_revision:25436; number_of_response:1; }","duration":"137.13904ms","start":"2026-06-16T02:05:04.442614Z","end":"2026-06-16T02:05:04.579753Z","steps":["trace[627354805] 'process raft request' (duration: 136.969635ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.601188Z","caller":"traceutil/trace.go:171","msg":"trace[407706453] transaction","detail":"{read_only:false; response_revision:25437; number_of_response:1; }","duration":"158.194481ms","start":"2026-06-16T02:05:04.442966Z","end":"2026-06-16T02:05:04.601161Z","steps":["trace[407706453] 'process raft request' (duration: 157.960895ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.601185Z","caller":"traceutil/trace.go:171","msg":"trace[360783246] transaction","detail":"{read_only:false; response_revision:25439; number_of_response:1; }","duration":"157.675947ms","start":"2026-06-16T02:05:04.443483Z","end":"2026-06-16T02:05:04.601159Z","steps":["trace[360783246] 'process raft request' (duration: 157.633556ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.601195Z","caller":"traceutil/trace.go:171","msg":"trace[198876231] transaction","detail":"{read_only:false; response_revision:25438; number_of_response:1; }","duration":"158.149889ms","start":"2026-06-16T02:05:04.443026Z","end":"2026-06-16T02:05:04.601176Z","steps":["trace[198876231] 'process raft request' (duration: 158.053877ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:04.905418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.606911ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:05:04.905502Z","caller":"traceutil/trace.go:171","msg":"trace[1471525308] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:25439; }","duration":"221.746785ms","start":"2026-06-16T02:05:04.683735Z","end":"2026-06-16T02:05:04.905482Z","steps":["trace[1471525308] 'count revisions from in-memory index tree' (duration: 221.523988ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:04.905599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.623319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10850"} {"level":"info","ts":"2026-06-16T02:05:04.905679Z","caller":"traceutil/trace.go:171","msg":"trace[750028141] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25439; }","duration":"181.766723ms","start":"2026-06-16T02:05:04.723893Z","end":"2026-06-16T02:05:04.90566Z","steps":["trace[750028141] 'range keys from in-memory index tree' (duration: 181.406212ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:04.90566Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.4442ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-16T02:05:04.905768Z","caller":"traceutil/trace.go:171","msg":"trace[433454898] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25439; }","duration":"157.638025ms","start":"2026-06-16T02:05:04.748107Z","end":"2026-06-16T02:05:04.905745Z","steps":["trace[433454898] 'range keys from in-memory index tree' (duration: 157.207493ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:04.95977Z","caller":"traceutil/trace.go:171","msg":"trace[234086752] transaction","detail":"{read_only:false; response_revision:25440; number_of_response:1; }","duration":"182.824002ms","start":"2026-06-16T02:05:04.776923Z","end":"2026-06-16T02:05:04.959747Z","steps":["trace[234086752] 'process raft request' (duration: 182.646357ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.2351Z","caller":"traceutil/trace.go:171","msg":"trace[1928424895] transaction","detail":"{read_only:false; response_revision:25441; number_of_response:1; }","duration":"413.21624ms","start":"2026-06-16T02:05:04.821857Z","end":"2026-06-16T02:05:05.235073Z","steps":["trace[1928424895] 'process raft request' (duration: 412.975653ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.235267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:04.821832Z","time spent":"413.344753ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:05:05.235598Z","caller":"traceutil/trace.go:171","msg":"trace[837835297] transaction","detail":"{read_only:false; response_revision:25442; number_of_response:1; }","duration":"366.784746ms","start":"2026-06-16T02:05:04.868765Z","end":"2026-06-16T02:05:05.235549Z","steps":["trace[837835297] 'process raft request' (duration: 366.262242ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.235683Z","caller":"traceutil/trace.go:171","msg":"trace[990572702] transaction","detail":"{read_only:false; response_revision:25443; number_of_response:1; }","duration":"313.48828ms","start":"2026-06-16T02:05:04.922159Z","end":"2026-06-16T02:05:05.235647Z","steps":["trace[990572702] 'process raft request' (duration: 313.169131ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.235968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.443676ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-21475566-dd51-4a93-8d0f-6f909bbca348\" ","response":"range_response_count:1 size:1322"} {"level":"warn","ts":"2026-06-16T02:05:05.236065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:04.922043Z","time spent":"313.938073ms","remote":"127.0.0.1:60616","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10652,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:05:05.236106Z","caller":"traceutil/trace.go:171","msg":"trace[1203677380] range","detail":"{range_begin:/registry/persistentvolumes/pvc-21475566-dd51-4a93-8d0f-6f909bbca348; range_end:; response_count:1; response_revision:25443; }","duration":"325.58684ms","start":"2026-06-16T02:05:04.910465Z","end":"2026-06-16T02:05:05.236052Z","steps":["trace[1203677380] 'agreement among raft nodes before linearized reading' (duration: 325.301202ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.236187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:04.910445Z","time spent":"325.693463ms","remote":"127.0.0.1:60594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1346,"request content":"key:\"/registry/persistentvolumes/pvc-21475566-dd51-4a93-8d0f-6f909bbca348\" "} {"level":"info","ts":"2026-06-16T02:05:05.235596Z","caller":"traceutil/trace.go:171","msg":"trace[906870754] linearizableReadLoop","detail":"{readStateIndex:26278; appliedIndex:26275; }","duration":"325.067025ms","start":"2026-06-16T02:05:04.910504Z","end":"2026-06-16T02:05:05.235571Z","steps":["trace[906870754] 'read index received' (duration: 49.17055ms)","trace[906870754] 'applied index is now lower than readState.Index' (duration: 275.894655ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:05.236552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:04.868737Z","time spent":"367.135997ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:05:05.417242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.983557ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:05:05.417344Z","caller":"traceutil/trace.go:171","msg":"trace[1396765592] linearizableReadLoop","detail":"{readStateIndex:26280; appliedIndex:26279; }","duration":"181.097353ms","start":"2026-06-16T02:05:05.236229Z","end":"2026-06-16T02:05:05.417327Z","steps":["trace[1396765592] 'read index received' (duration: 44.91468ms)","trace[1396765592] 'applied index is now lower than readState.Index' (duration: 136.181503ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:05.417418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.847582ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:05:05.417451Z","caller":"traceutil/trace.go:171","msg":"trace[1876728821] range","detail":"{range_begin:/registry/rabbitmq.com/users/; range_end:/registry/rabbitmq.com/users0; response_count:0; response_revision:25444; }","duration":"302.929384ms","start":"2026-06-16T02:05:05.114512Z","end":"2026-06-16T02:05:05.417442Z","steps":["trace[1876728821] 'agreement among raft nodes before linearized reading' (duration: 302.864502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.417484Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:05.114496Z","time spent":"302.979766ms","remote":"127.0.0.1:48344","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/users/\" range_end:\"/registry/rabbitmq.com/users0\" count_only:true "} {"level":"info","ts":"2026-06-16T02:05:05.417409Z","caller":"traceutil/trace.go:171","msg":"trace[1332324615] transaction","detail":"{read_only:false; response_revision:25444; number_of_response:1; }","duration":"403.625611ms","start":"2026-06-16T02:05:05.013727Z","end":"2026-06-16T02:05:05.417353Z","steps":["trace[1332324615] 'process raft request' (duration: 267.403337ms)","trace[1332324615] 'compare' (duration: 135.70268ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:05.417785Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:05.013696Z","time spent":"403.98575ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":605,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-16T02:05:05.417954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.776274ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:05:05.418139Z","caller":"traceutil/trace.go:171","msg":"trace[351377716] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25444; }","duration":"207.446133ms","start":"2026-06-16T02:05:05.210582Z","end":"2026-06-16T02:05:05.418028Z","steps":["trace[351377716] 'agreement among raft nodes before linearized reading' (duration: 206.799355ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.440411Z","caller":"traceutil/trace.go:171","msg":"trace[1056087209] transaction","detail":"{read_only:false; response_revision:25445; number_of_response:1; }","duration":"197.583517ms","start":"2026-06-16T02:05:05.242808Z","end":"2026-06-16T02:05:05.440392Z","steps":["trace[1056087209] 'process raft request' (duration: 197.34561ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.440425Z","caller":"traceutil/trace.go:171","msg":"trace[2006122279] transaction","detail":"{read_only:false; response_revision:25446; number_of_response:1; }","duration":"197.34536ms","start":"2026-06-16T02:05:05.243062Z","end":"2026-06-16T02:05:05.440407Z","steps":["trace[2006122279] 'process raft request' (duration: 197.260068ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.440719Z","caller":"traceutil/trace.go:171","msg":"trace[671475028] transaction","detail":"{read_only:false; response_revision:25448; number_of_response:1; }","duration":"191.843516ms","start":"2026-06-16T02:05:05.248864Z","end":"2026-06-16T02:05:05.440707Z","steps":["trace[671475028] 'process raft request' (duration: 191.688601ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.440794Z","caller":"traceutil/trace.go:171","msg":"trace[1780620681] transaction","detail":"{read_only:false; response_revision:25447; number_of_response:1; }","duration":"197.209016ms","start":"2026-06-16T02:05:05.243575Z","end":"2026-06-16T02:05:05.440784Z","steps":["trace[1780620681] 'process raft request' (duration: 196.793634ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.616019Z","caller":"traceutil/trace.go:171","msg":"trace[2065124238] linearizableReadLoop","detail":"{readStateIndex:26285; appliedIndex:26284; }","duration":"169.910809ms","start":"2026-06-16T02:05:05.446083Z","end":"2026-06-16T02:05:05.615994Z","steps":["trace[2065124238] 'read index received' (duration: 169.871298ms)","trace[2065124238] 'applied index is now lower than readState.Index' (duration: 38.091µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:05.616249Z","caller":"traceutil/trace.go:171","msg":"trace[1218666847] transaction","detail":"{read_only:false; response_revision:25449; number_of_response:1; }","duration":"250.607215ms","start":"2026-06-16T02:05:05.365628Z","end":"2026-06-16T02:05:05.616235Z","steps":["trace[1218666847] 'process raft request' (duration: 250.220984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.616383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.28161ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0\" ","response":"range_response_count:1 size:1862"} {"level":"info","ts":"2026-06-16T02:05:05.616474Z","caller":"traceutil/trace.go:171","msg":"trace[879221425] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-neutron-server-0; range_end:; response_count:1; response_revision:25449; }","duration":"170.427414ms","start":"2026-06-16T02:05:05.446022Z","end":"2026-06-16T02:05:05.616449Z","steps":["trace[879221425] 'agreement among raft nodes before linearized reading' (duration: 170.160607ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.617549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.412929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"info","ts":"2026-06-16T02:05:05.617583Z","caller":"traceutil/trace.go:171","msg":"trace[2077414708] transaction","detail":"{read_only:false; response_revision:25450; number_of_response:1; }","duration":"100.862931ms","start":"2026-06-16T02:05:05.516697Z","end":"2026-06-16T02:05:05.617559Z","steps":["trace[2077414708] 'process raft request' (duration: 100.546543ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.617629Z","caller":"traceutil/trace.go:171","msg":"trace[1727149226] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:25450; }","duration":"167.536243ms","start":"2026-06-16T02:05:05.450074Z","end":"2026-06-16T02:05:05.61761Z","steps":["trace[1727149226] 'agreement among raft nodes before linearized reading' (duration: 167.296336ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.947456Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.114622ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:05:05.947556Z","caller":"traceutil/trace.go:171","msg":"trace[1785923621] linearizableReadLoop","detail":"{readStateIndex:26287; appliedIndex:26286; }","duration":"306.303729ms","start":"2026-06-16T02:05:05.641236Z","end":"2026-06-16T02:05:05.94754Z","steps":["trace[1785923621] 'read index received' (duration: 108.003372ms)","trace[1785923621] 'applied index is now lower than readState.Index' (duration: 198.299137ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:05.947919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.473084ms","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-06-16T02:05:05.948004Z","caller":"traceutil/trace.go:171","msg":"trace[612147359] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:25451; }","duration":"145.596887ms","start":"2026-06-16T02:05:05.802387Z","end":"2026-06-16T02:05:05.947984Z","steps":["trace[612147359] 'agreement among raft nodes before linearized reading' (duration: 145.365061ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:05.948126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.317592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T02:05:05.947857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.599097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-16T02:05:05.94819Z","caller":"traceutil/trace.go:171","msg":"trace[728545442] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigs0; response_count:0; response_revision:25451; }","duration":"128.430966ms","start":"2026-06-16T02:05:05.819742Z","end":"2026-06-16T02:05:05.948173Z","steps":["trace[728545442] 'agreement among raft nodes before linearized reading' (duration: 128.305342ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.948211Z","caller":"traceutil/trace.go:171","msg":"trace[1546200508] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25451; }","duration":"306.988318ms","start":"2026-06-16T02:05:05.641198Z","end":"2026-06-16T02:05:05.948187Z","steps":["trace[1546200508] 'agreement among raft nodes before linearized reading' (duration: 306.463873ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:05.948128Z","caller":"traceutil/trace.go:171","msg":"trace[1735206941] transaction","detail":"{read_only:false; response_revision:25451; number_of_response:1; }","duration":"321.555687ms","start":"2026-06-16T02:05:05.626538Z","end":"2026-06-16T02:05:05.948093Z","steps":["trace[1735206941] 'process raft request' (duration: 122.718515ms)","trace[1735206941] 'compare' (duration: 197.763972ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:05.948273Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:05.64118Z","time spent":"307.0752ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":506,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-16T02:05:05.948384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:05.62652Z","time spent":"321.798334ms","remote":"127.0.0.1:48326","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3218,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:05:06.18969Z","caller":"traceutil/trace.go:171","msg":"trace[164548384] transaction","detail":"{read_only:false; response_revision:25453; number_of_response:1; }","duration":"199.905601ms","start":"2026-06-16T02:05:05.989747Z","end":"2026-06-16T02:05:06.189653Z","steps":["trace[164548384] 'process raft request' (duration: 132.776237ms)","trace[164548384] 'compare' (duration: 66.732663ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:06.189743Z","caller":"traceutil/trace.go:171","msg":"trace[1008567903] linearizableReadLoop","detail":"{readStateIndex:26289; appliedIndex:26288; }","duration":"197.583767ms","start":"2026-06-16T02:05:05.992131Z","end":"2026-06-16T02:05:06.189715Z","steps":["trace[1008567903] 'read index received' (duration: 130.342819ms)","trace[1008567903] 'applied index is now lower than readState.Index' (duration: 67.238578ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:06.189942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.015703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T02:05:06.190016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"197.872665ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9650"} {"level":"info","ts":"2026-06-16T02:05:06.190076Z","caller":"traceutil/trace.go:171","msg":"trace[728550324] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25454; }","duration":"197.956077ms","start":"2026-06-16T02:05:05.992105Z","end":"2026-06-16T02:05:06.190061Z","steps":["trace[728550324] 'agreement among raft nodes before linearized reading' (duration: 197.747671ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:06.190023Z","caller":"traceutil/trace.go:171","msg":"trace[1141292159] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25454; }","duration":"170.156596ms","start":"2026-06-16T02:05:06.019848Z","end":"2026-06-16T02:05:06.190004Z","steps":["trace[1141292159] 'agreement among raft nodes before linearized reading' (duration: 170.035523ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:06.436879Z","caller":"traceutil/trace.go:171","msg":"trace[79337394] linearizableReadLoop","detail":"{readStateIndex:26292; appliedIndex:26291; }","duration":"154.317462ms","start":"2026-06-16T02:05:06.282536Z","end":"2026-06-16T02:05:06.436853Z","steps":["trace[79337394] 'read index received' (duration: 154.202999ms)","trace[79337394] 'applied index is now lower than readState.Index' (duration: 113.283µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:06.436964Z","caller":"traceutil/trace.go:171","msg":"trace[2117866273] transaction","detail":"{read_only:false; response_revision:25456; number_of_response:1; }","duration":"222.240079ms","start":"2026-06-16T02:05:06.214691Z","end":"2026-06-16T02:05:06.436931Z","steps":["trace[2117866273] 'process raft request' (duration: 221.987492ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.437044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.186943ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-16T02:05:06.437178Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"235.611854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9650"} {"level":"info","ts":"2026-06-16T02:05:06.437205Z","caller":"traceutil/trace.go:171","msg":"trace[1907817596] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:25456; }","duration":"229.372699ms","start":"2026-06-16T02:05:06.207815Z","end":"2026-06-16T02:05:06.437187Z","steps":["trace[1907817596] 'agreement among raft nodes before linearized reading' (duration: 229.163713ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:06.437253Z","caller":"traceutil/trace.go:171","msg":"trace[1906828192] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:25456; }","duration":"235.735457ms","start":"2026-06-16T02:05:06.201498Z","end":"2026-06-16T02:05:06.437234Z","steps":["trace[1906828192] 'agreement among raft nodes before linearized reading' (duration: 235.514151ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:06.585387Z","caller":"traceutil/trace.go:171","msg":"trace[61372824] transaction","detail":"{read_only:false; response_revision:25458; number_of_response:1; }","duration":"143.300183ms","start":"2026-06-16T02:05:06.442065Z","end":"2026-06-16T02:05:06.585366Z","steps":["trace[61372824] 'process raft request' (duration: 143.263612ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:06.585512Z","caller":"traceutil/trace.go:171","msg":"trace[138973424] linearizableReadLoop","detail":"{readStateIndex:26293; appliedIndex:26292; }","duration":"148.393835ms","start":"2026-06-16T02:05:06.437101Z","end":"2026-06-16T02:05:06.585494Z","steps":["trace[138973424] 'read index received' (duration: 130.188154ms)","trace[138973424] 'applied index is now lower than readState.Index' (duration: 18.203561ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:06.585455Z","caller":"traceutil/trace.go:171","msg":"trace[1568786558] transaction","detail":"{read_only:false; response_revision:25457; number_of_response:1; }","duration":"217.575317ms","start":"2026-06-16T02:05:06.367844Z","end":"2026-06-16T02:05:06.585419Z","steps":["trace[1568786558] 'process raft request' (duration: 199.428378ms)","trace[1568786558] 'compare' (duration: 17.929833ms)"],"step_count":2} {"level":"warn","ts":"2026-06-16T02:05:06.5857Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.050422ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18352"} {"level":"info","ts":"2026-06-16T02:05:06.585744Z","caller":"traceutil/trace.go:171","msg":"trace[1759975987] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:25458; }","duration":"301.162104ms","start":"2026-06-16T02:05:06.284571Z","end":"2026-06-16T02:05:06.585733Z","steps":["trace[1759975987] 'agreement among raft nodes before linearized reading' (duration: 301.0166ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.585768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:05:06.284548Z","time spent":"301.216036ms","remote":"127.0.0.1:60610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18376,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-06-16T02:05:06.585785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.32489ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/rabbitmq-manila.18b96d7522c31d1a\" ","response":"range_response_count:1 size:747"} {"level":"info","ts":"2026-06-16T02:05:06.585832Z","caller":"traceutil/trace.go:171","msg":"trace[1114506901] range","detail":"{range_begin:/registry/events/openstack/rabbitmq-manila.18b96d7522c31d1a; range_end:; response_count:1; response_revision:25458; }","duration":"145.426303ms","start":"2026-06-16T02:05:06.440394Z","end":"2026-06-16T02:05:06.585821Z","steps":["trace[1114506901] 'agreement among raft nodes before linearized reading' (duration: 145.228677ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.585906Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.705532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10670"} {"level":"info","ts":"2026-06-16T02:05:06.585983Z","caller":"traceutil/trace.go:171","msg":"trace[1344573260] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:25458; }","duration":"139.812665ms","start":"2026-06-16T02:05:06.446152Z","end":"2026-06-16T02:05:06.585964Z","steps":["trace[1344573260] 'agreement among raft nodes before linearized reading' (duration: 139.540817ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.852379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.575454ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:05:06.852469Z","caller":"traceutil/trace.go:171","msg":"trace[1377202974] transaction","detail":"{read_only:false; response_revision:25459; number_of_response:1; }","duration":"264.708339ms","start":"2026-06-16T02:05:06.587744Z","end":"2026-06-16T02:05:06.852452Z","steps":["trace[1377202974] 'process raft request' (duration: 143.981061ms)","trace[1377202974] 'compare' (duration: 120.469401ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:06.854062Z","caller":"traceutil/trace.go:171","msg":"trace[648820328] linearizableReadLoop","detail":"{readStateIndex:26296; appliedIndex:26294; }","duration":"257.347973ms","start":"2026-06-16T02:05:06.596697Z","end":"2026-06-16T02:05:06.854045Z","steps":["trace[648820328] 'read index received' (duration: 135.036631ms)","trace[648820328] 'applied index is now lower than readState.Index' (duration: 122.310552ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:06.854086Z","caller":"traceutil/trace.go:171","msg":"trace[2074527002] transaction","detail":"{read_only:false; response_revision:25460; number_of_response:1; }","duration":"264.047621ms","start":"2026-06-16T02:05:06.590021Z","end":"2026-06-16T02:05:06.854068Z","steps":["trace[2074527002] 'process raft request' (duration: 263.938218ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.854226Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"257.513518ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5652"} {"level":"info","ts":"2026-06-16T02:05:06.854252Z","caller":"traceutil/trace.go:171","msg":"trace[617494829] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:25460; }","duration":"257.549999ms","start":"2026-06-16T02:05:06.596693Z","end":"2026-06-16T02:05:06.854243Z","steps":["trace[617494829] 'agreement among raft nodes before linearized reading' (duration: 257.445486ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.854328Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.60144ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-06-16T02:05:06.854361Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.642509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-16T02:05:06.854405Z","caller":"traceutil/trace.go:171","msg":"trace[2145246977] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:25460; }","duration":"247.683202ms","start":"2026-06-16T02:05:06.606704Z","end":"2026-06-16T02:05:06.854387Z","steps":["trace[2145246977] 'agreement among raft nodes before linearized reading' (duration: 247.496477ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:06.85441Z","caller":"traceutil/trace.go:171","msg":"trace[468718022] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:25460; }","duration":"248.712081ms","start":"2026-06-16T02:05:06.605682Z","end":"2026-06-16T02:05:06.854394Z","steps":["trace[468718022] 'agreement among raft nodes before linearized reading' (duration: 248.525256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.854425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.648649ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"info","ts":"2026-06-16T02:05:06.854499Z","caller":"traceutil/trace.go:171","msg":"trace[33578506] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:25460; }","duration":"248.742681ms","start":"2026-06-16T02:05:06.605731Z","end":"2026-06-16T02:05:06.854474Z","steps":["trace[33578506] 'agreement among raft nodes before linearized reading' (duration: 248.518185ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:06.854518Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.129091ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.95\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-06-16T02:05:06.854617Z","caller":"traceutil/trace.go:171","msg":"trace[1726067209] range","detail":"{range_begin:/registry/masterleases/199.204.45.95; range_end:; response_count:1; response_revision:25460; }","duration":"229.297736ms","start":"2026-06-16T02:05:06.625297Z","end":"2026-06-16T02:05:06.854595Z","steps":["trace[1726067209] 'agreement among raft nodes before linearized reading' (duration: 228.950836ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:07.057994Z","caller":"traceutil/trace.go:171","msg":"trace[118096050] transaction","detail":"{read_only:false; response_revision:25462; number_of_response:1; }","duration":"199.432099ms","start":"2026-06-16T02:05:06.858536Z","end":"2026-06-16T02:05:07.057968Z","steps":["trace[118096050] 'process raft request' (duration: 199.337916ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:07.058178Z","caller":"traceutil/trace.go:171","msg":"trace[1625687474] transaction","detail":"{read_only:false; response_revision:25463; number_of_response:1; }","duration":"197.264777ms","start":"2026-06-16T02:05:06.8609Z","end":"2026-06-16T02:05:07.058165Z","steps":["trace[1625687474] 'process raft request' (duration: 197.0172ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:07.058005Z","caller":"traceutil/trace.go:171","msg":"trace[239389709] transaction","detail":"{read_only:false; response_revision:25461; number_of_response:1; }","duration":"199.514491ms","start":"2026-06-16T02:05:06.858463Z","end":"2026-06-16T02:05:07.057977Z","steps":["trace[239389709] 'process raft request' (duration: 199.237373ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:07.058373Z","caller":"traceutil/trace.go:171","msg":"trace[642790763] transaction","detail":"{read_only:false; response_revision:25464; number_of_response:1; }","duration":"124.507265ms","start":"2026-06-16T02:05:06.933856Z","end":"2026-06-16T02:05:07.058363Z","steps":["trace[642790763] 'process raft request' (duration: 124.385071ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:10.226385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.261695ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/magnum-system/\" range_end:\"/registry/endpointslices/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:05:10.226471Z","caller":"traceutil/trace.go:171","msg":"trace[615150814] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:25501; }","duration":"126.353127ms","start":"2026-06-16T02:05:10.100099Z","end":"2026-06-16T02:05:10.226452Z","steps":["trace[615150814] 'range keys from in-memory index tree' (duration: 126.230054ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:10.353654Z","caller":"traceutil/trace.go:171","msg":"trace[998281214] transaction","detail":"{read_only:false; response_revision:25502; number_of_response:1; }","duration":"102.273211ms","start":"2026-06-16T02:05:10.251346Z","end":"2026-06-16T02:05:10.353619Z","steps":["trace[998281214] 'process raft request' (duration: 102.101156ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:25.298157Z","caller":"traceutil/trace.go:171","msg":"trace[1353586268] transaction","detail":"{read_only:false; response_revision:25643; number_of_response:1; }","duration":"111.14512ms","start":"2026-06-16T02:05:25.186982Z","end":"2026-06-16T02:05:25.298127Z","steps":["trace[1353586268] 'process raft request' (duration: 110.742709ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:25.427941Z","caller":"traceutil/trace.go:171","msg":"trace[475755851] transaction","detail":"{read_only:false; response_revision:25644; number_of_response:1; }","duration":"124.908387ms","start":"2026-06-16T02:05:25.303008Z","end":"2026-06-16T02:05:25.427917Z","steps":["trace[475755851] 'process raft request' (duration: 96.984443ms)","trace[475755851] 'compare' (duration: 27.758819ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:25.428528Z","caller":"traceutil/trace.go:171","msg":"trace[767796561] transaction","detail":"{read_only:false; response_revision:25645; number_of_response:1; }","duration":"124.118054ms","start":"2026-06-16T02:05:25.304374Z","end":"2026-06-16T02:05:25.428492Z","steps":["trace[767796561] 'process raft request' (duration: 123.507297ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:25.428578Z","caller":"traceutil/trace.go:171","msg":"trace[1533332466] transaction","detail":"{read_only:false; response_revision:25646; number_of_response:1; }","duration":"122.991733ms","start":"2026-06-16T02:05:25.305554Z","end":"2026-06-16T02:05:25.428546Z","steps":["trace[1533332466] 'process raft request' (duration: 122.807228ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:25.507204Z","caller":"traceutil/trace.go:171","msg":"trace[888851830] linearizableReadLoop","detail":"{readStateIndex:26488; appliedIndex:26483; }","duration":"102.015824ms","start":"2026-06-16T02:05:25.405162Z","end":"2026-06-16T02:05:25.507178Z","steps":["trace[888851830] 'read index received' (duration: 14.93762ms)","trace[888851830] 'applied index is now lower than readState.Index' (duration: 87.077004ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:25.50727Z","caller":"traceutil/trace.go:171","msg":"trace[1279704827] transaction","detail":"{read_only:false; response_revision:25647; number_of_response:1; }","duration":"106.915751ms","start":"2026-06-16T02:05:25.400311Z","end":"2026-06-16T02:05:25.507226Z","steps":["trace[1279704827] 'process raft request' (duration: 106.685785ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:25.507306Z","caller":"traceutil/trace.go:171","msg":"trace[1807033187] transaction","detail":"{read_only:false; response_revision:25648; number_of_response:1; }","duration":"106.210861ms","start":"2026-06-16T02:05:25.401061Z","end":"2026-06-16T02:05:25.507271Z","steps":["trace[1807033187] 'process raft request' (duration: 106.076478ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:25.507554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.158898ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/keypairs/\" range_end:\"/registry/openstack.k-orc.cloud/keypairs0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-16T02:05:25.507607Z","caller":"traceutil/trace.go:171","msg":"trace[754265394] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/keypairs/; range_end:/registry/openstack.k-orc.cloud/keypairs0; response_count:0; response_revision:25648; }","duration":"102.464716ms","start":"2026-06-16T02:05:25.405125Z","end":"2026-06-16T02:05:25.507589Z","steps":["trace[754265394] 'agreement among raft nodes before linearized reading' (duration: 102.155228ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:25.760751Z","caller":"traceutil/trace.go:171","msg":"trace[1284057208] transaction","detail":"{read_only:false; response_revision:25649; number_of_response:1; }","duration":"171.154704ms","start":"2026-06-16T02:05:25.589566Z","end":"2026-06-16T02:05:25.760721Z","steps":["trace[1284057208] 'process raft request' (duration: 170.940578ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:29.645421Z","caller":"traceutil/trace.go:171","msg":"trace[1730946685] linearizableReadLoop","detail":"{readStateIndex:26521; appliedIndex:26519; }","duration":"109.453783ms","start":"2026-06-16T02:05:29.535942Z","end":"2026-06-16T02:05:29.645396Z","steps":["trace[1730946685] 'read index received' (duration: 104.319149ms)","trace[1730946685] 'applied index is now lower than readState.Index' (duration: 5.133444ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:29.645752Z","caller":"traceutil/trace.go:171","msg":"trace[741199395] transaction","detail":"{read_only:false; response_revision:25680; number_of_response:1; }","duration":"124.175936ms","start":"2026-06-16T02:05:29.521556Z","end":"2026-06-16T02:05:29.645732Z","steps":["trace[741199395] 'process raft request' (duration: 123.791826ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:29.645756Z","caller":"traceutil/trace.go:171","msg":"trace[923005022] transaction","detail":"{read_only:false; response_revision:25679; number_of_response:1; }","duration":"126.253725ms","start":"2026-06-16T02:05:29.519457Z","end":"2026-06-16T02:05:29.64571Z","steps":["trace[923005022] 'process raft request' (duration: 120.793341ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:29.64608Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.099301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-16T02:05:29.646174Z","caller":"traceutil/trace.go:171","msg":"trace[1074527289] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:25680; }","duration":"110.250655ms","start":"2026-06-16T02:05:29.535904Z","end":"2026-06-16T02:05:29.646154Z","steps":["trace[1074527289] 'agreement among raft nodes before linearized reading' (duration: 110.06022ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:35.521197Z","caller":"traceutil/trace.go:171","msg":"trace[1761462430] transaction","detail":"{read_only:false; response_revision:25718; number_of_response:1; }","duration":"185.386473ms","start":"2026-06-16T02:05:35.335779Z","end":"2026-06-16T02:05:35.521165Z","steps":["trace[1761462430] 'process raft request' (duration: 185.218228ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:05:35.670339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.522604ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-16T02:05:35.670513Z","caller":"traceutil/trace.go:171","msg":"trace[326869355] transaction","detail":"{read_only:false; response_revision:25721; number_of_response:1; }","duration":"144.692362ms","start":"2026-06-16T02:05:35.525803Z","end":"2026-06-16T02:05:35.670495Z","steps":["trace[326869355] 'process raft request' (duration: 144.63377ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:35.6706Z","caller":"traceutil/trace.go:171","msg":"trace[1190593190] transaction","detail":"{read_only:false; response_revision:25720; number_of_response:1; }","duration":"144.811635ms","start":"2026-06-16T02:05:35.525739Z","end":"2026-06-16T02:05:35.670551Z","steps":["trace[1190593190] 'process raft request' (duration: 18.994523ms)","trace[1190593190] 'compare' (duration: 125.39261ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:35.93793Z","caller":"traceutil/trace.go:171","msg":"trace[1695855834] transaction","detail":"{read_only:false; response_revision:25724; number_of_response:1; }","duration":"138.21002ms","start":"2026-06-16T02:05:35.799692Z","end":"2026-06-16T02:05:35.937902Z","steps":["trace[1695855834] 'process raft request' (duration: 138.027984ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:36.023766Z","caller":"traceutil/trace.go:171","msg":"trace[1484950344] transaction","detail":"{read_only:false; response_revision:25726; number_of_response:1; }","duration":"168.919372ms","start":"2026-06-16T02:05:35.854816Z","end":"2026-06-16T02:05:36.023735Z","steps":["trace[1484950344] 'process raft request' (duration: 168.818299ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:05:36.024073Z","caller":"traceutil/trace.go:171","msg":"trace[1159607775] transaction","detail":"{read_only:false; response_revision:25725; number_of_response:1; }","duration":"200.023045ms","start":"2026-06-16T02:05:35.823971Z","end":"2026-06-16T02:05:36.023994Z","steps":["trace[1159607775] 'process raft request' (duration: 180.325992ms)","trace[1159607775] 'compare' (duration: 19.188549ms)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:05:53.650998Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":22972} {"level":"info","ts":"2026-06-16T02:05:53.800349Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":22972,"took":"144.785834ms","hash":252340677,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":36569088,"current-db-size-in-use":"37 MB"} {"level":"info","ts":"2026-06-16T02:05:53.800408Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":252340677,"revision":22972,"compact-revision":20026} {"level":"info","ts":"2026-06-16T02:10:53.65735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25854} {"level":"info","ts":"2026-06-16T02:10:53.786323Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25854,"took":"124.25681ms","hash":1847854784,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":38133760,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-06-16T02:10:53.786396Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1847854784,"revision":25854,"compact-revision":22972} {"level":"info","ts":"2026-06-16T02:11:40.131525Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T02:11:40.136907Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-16T02:11:40.136999Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-16T02:15:53.664235Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28734} {"level":"info","ts":"2026-06-16T02:15:53.817217Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28734,"took":"147.301813ms","hash":189171423,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":31010816,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-16T02:15:53.817295Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":189171423,"revision":28734,"compact-revision":25854} {"level":"info","ts":"2026-06-16T02:20:53.669598Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30956} {"level":"info","ts":"2026-06-16T02:20:53.79045Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30956,"took":"111.74927ms","hash":4128000126,"current-db-size-bytes":58269696,"current-db-size":"58 MB","current-db-size-in-use-bytes":31531008,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T02:20:53.790528Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4128000126,"revision":30956,"compact-revision":28734} {"level":"info","ts":"2026-06-16T02:25:53.678434Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33225} {"level":"info","ts":"2026-06-16T02:25:53.843246Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33225,"took":"155.722584ms","hash":3401753442,"current-db-size-bytes":59310080,"current-db-size":"59 MB","current-db-size-in-use-bytes":31518720,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T02:25:53.843376Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3401753442,"revision":33225,"compact-revision":30956} {"level":"info","ts":"2026-06-16T02:30:53.684082Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35515} {"level":"info","ts":"2026-06-16T02:30:53.824806Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35515,"took":"136.444952ms","hash":2170401510,"current-db-size-bytes":59310080,"current-db-size":"59 MB","current-db-size-in-use-bytes":31313920,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-16T02:30:53.824872Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2170401510,"revision":35515,"compact-revision":33225} {"level":"info","ts":"2026-06-16T02:33:10.009515Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"be773dfc027af3eb","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-16T02:33:10.014845Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-16T02:33:10.014989Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-16T02:33:37.981008Z","caller":"traceutil/trace.go:171","msg":"trace[948006224] linearizableReadLoop","detail":"{readStateIndex:40217; appliedIndex:40216; }","duration":"224.348222ms","start":"2026-06-16T02:33:37.756637Z","end":"2026-06-16T02:33:37.980986Z","steps":["trace[948006224] 'read index received' (duration: 224.220478ms)","trace[948006224] 'applied index is now lower than readState.Index' (duration: 127.214µs)"],"step_count":2} {"level":"info","ts":"2026-06-16T02:33:37.98104Z","caller":"traceutil/trace.go:171","msg":"trace[474561803] transaction","detail":"{read_only:false; response_revision:38999; number_of_response:1; }","duration":"266.652669ms","start":"2026-06-16T02:33:37.714362Z","end":"2026-06-16T02:33:37.981014Z","steps":["trace[474561803] 'process raft request' (duration: 266.468194ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:33:37.9812Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"224.579778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/neutron-dhcp-agent-default-xf8sr.18b96cc8ee12b34e\" ","response":"range_response_count:1 size:957"} {"level":"info","ts":"2026-06-16T02:33:37.981227Z","caller":"traceutil/trace.go:171","msg":"trace[764368207] range","detail":"{range_begin:/registry/events/openstack/neutron-dhcp-agent-default-xf8sr.18b96cc8ee12b34e; range_end:; response_count:1; response_revision:38999; }","duration":"224.65419ms","start":"2026-06-16T02:33:37.756563Z","end":"2026-06-16T02:33:37.981217Z","steps":["trace[764368207] 'agreement among raft nodes before linearized reading' (duration: 224.507256ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:33:38.535197Z","caller":"traceutil/trace.go:171","msg":"trace[721935920] transaction","detail":"{read_only:false; response_revision:39007; number_of_response:1; }","duration":"341.365516ms","start":"2026-06-16T02:33:38.193798Z","end":"2026-06-16T02:33:38.535163Z","steps":["trace[721935920] 'process raft request' (duration: 339.317439ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:33:38.535409Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:33:38.19378Z","time spent":"341.516359ms","remote":"127.0.0.1:57812","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:33:38.535829Z","caller":"traceutil/trace.go:171","msg":"trace[509484426] transaction","detail":"{read_only:false; response_revision:39008; number_of_response:1; }","duration":"340.78638ms","start":"2026-06-16T02:33:38.195023Z","end":"2026-06-16T02:33:38.53581Z","steps":["trace[509484426] 'process raft request' (duration: 340.518872ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:33:38.535902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:33:38.195007Z","time spent":"340.861952ms","remote":"127.0.0.1:60498","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":646,"response count":0,"response size":42,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-16T02:33:38.536171Z","caller":"traceutil/trace.go:171","msg":"trace[299621578] transaction","detail":"{read_only:false; response_revision:39009; number_of_response:1; }","duration":"334.393513ms","start":"2026-06-16T02:33:38.201739Z","end":"2026-06-16T02:33:38.536132Z","steps":["trace[299621578] 'process raft request' (duration: 333.977942ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:33:38.536199Z","caller":"traceutil/trace.go:171","msg":"trace[1440632813] transaction","detail":"{read_only:false; response_revision:39011; number_of_response:1; }","duration":"238.899994ms","start":"2026-06-16T02:33:38.297272Z","end":"2026-06-16T02:33:38.536172Z","steps":["trace[1440632813] 'process raft request' (duration: 238.840582ms)"],"step_count":1} {"level":"info","ts":"2026-06-16T02:33:38.53637Z","caller":"traceutil/trace.go:171","msg":"trace[1696593149] transaction","detail":"{read_only:false; response_revision:39010; number_of_response:1; }","duration":"239.15235ms","start":"2026-06-16T02:33:38.297196Z","end":"2026-06-16T02:33:38.536349Z","steps":["trace[1696593149] 'process raft request' (duration: 238.820221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-16T02:33:38.536331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-16T02:33:38.201706Z","time spent":"334.539368ms","remote":"127.0.0.1:60512","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20690,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-16T02:35:53.693362Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37746} {"level":"info","ts":"2026-06-16T02:35:53.810255Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37746,"took":"112.824868ms","hash":1868770911,"current-db-size-bytes":59310080,"current-db-size":"59 MB","current-db-size-in-use-bytes":32247808,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-16T02:35:53.810318Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1868770911,"revision":37746,"compact-revision":35515}