{"level":"warn","ts":"2026-08-11T11:16:12.037425Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T11:16:12.037534Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.65:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.65:2380","--initial-cluster=instance=https://199.19.213.65:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.65:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.65: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-08-11T11:16:12.037615Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-11T11:16:12.037623Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.65:2380"]} {"level":"info","ts":"2026-08-11T11:16:12.037641Z","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-08-11T11:16:12.03828Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"]} {"level":"info","ts":"2026-08-11T11:16:12.038375Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.65: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-08-11T11:16:12.041322Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.681478ms"} {"level":"info","ts":"2026-08-11T11:16:12.048465Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a071a454a8148542","cluster-id":"aa233e43aeaf7fe5"} {"level":"info","ts":"2026-08-11T11:16:12.048838Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=()"} {"level":"info","ts":"2026-08-11T11:16:12.048886Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 0"} {"level":"info","ts":"2026-08-11T11:16:12.048993Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a071a454a8148542 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-11T11:16:12.049005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became follower at term 1"} {"level":"info","ts":"2026-08-11T11:16:12.049092Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"} {"level":"warn","ts":"2026-08-11T11:16:12.05968Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-11T11:16:12.061558Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-11T11:16:12.063077Z","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-08-11T11:16:12.066041Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a071a454a8148542","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-11T11:16:12.06649Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a071a454a8148542","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-11T11:16:12.066653Z","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-08-11T11:16:12.066725Z","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-08-11T11:16:12.066736Z","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-08-11T11:16:12.068012Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 switched to configuration voters=(11561202401940899138)"} {"level":"info","ts":"2026-08-11T11:16:12.068186Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","added-peer-id":"a071a454a8148542","added-peer-peer-urls":["https://199.19.213.65:2380"]} {"level":"info","ts":"2026-08-11T11:16:12.072867Z","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-08-11T11:16:12.073063Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.65:2380"} {"level":"info","ts":"2026-08-11T11:16:12.073114Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.65:2380"} {"level":"info","ts":"2026-08-11T11:16:12.073363Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a071a454a8148542","initial-advertise-peer-urls":["https://199.19.213.65:2380"],"listen-peer-urls":["https://199.19.213.65:2380"],"advertise-client-urls":["https://199.19.213.65:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.65:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-11T11:16:12.073464Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-11T11:16:12.949411Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 is starting a new election at term 1"} {"level":"info","ts":"2026-08-11T11:16:12.94956Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-11T11:16:12.94965Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgPreVoteResp from a071a454a8148542 at term 1"} {"level":"info","ts":"2026-08-11T11:16:12.949717Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became candidate at term 2"} {"level":"info","ts":"2026-08-11T11:16:12.949753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 received MsgVoteResp from a071a454a8148542 at term 2"} {"level":"info","ts":"2026-08-11T11:16:12.949795Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a071a454a8148542 became leader at term 2"} {"level":"info","ts":"2026-08-11T11:16:12.949845Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a071a454a8148542 elected leader a071a454a8148542 at term 2"} {"level":"info","ts":"2026-08-11T11:16:12.951155Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a071a454a8148542","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.65:2379]}","request-path":"/0/members/a071a454a8148542/attributes","cluster-id":"aa233e43aeaf7fe5","publish-timeout":"7s"} {"level":"info","ts":"2026-08-11T11:16:12.951172Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T11:16:12.95121Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T11:16:12.951334Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-11T11:16:12.951546Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-11T11:16:12.951578Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-11T11:16:12.952575Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"aa233e43aeaf7fe5","local-member-id":"a071a454a8148542","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T11:16:12.952739Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T11:16:12.95282Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-11T11:16:12.954898Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-11T11:16:12.960821Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.65:2379"} {"level":"info","ts":"2026-08-11T11:16:54.531324Z","caller":"traceutil/trace.go:171","msg":"trace[1946125613] linearizableReadLoop","detail":"{readStateIndex:667; appliedIndex:666; }","duration":"159.297317ms","start":"2026-08-11T11:16:54.37199Z","end":"2026-08-11T11:16:54.531287Z","steps":["trace[1946125613] 'read index received' (duration: 142.984805ms)","trace[1946125613] 'applied index is now lower than readState.Index' (duration: 16.310582ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:16:54.531486Z","caller":"traceutil/trace.go:171","msg":"trace[1179341182] transaction","detail":"{read_only:false; response_revision:641; number_of_response:1; }","duration":"170.658254ms","start":"2026-08-11T11:16:54.360765Z","end":"2026-08-11T11:16:54.531423Z","steps":["trace[1179341182] 'process raft request' (duration: 154.220339ms)","trace[1179341182] 'compare' (duration: 16.153918ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:16:54.531837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.808059ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io\" ","response":"range_response_count:1 size:570105"} {"level":"info","ts":"2026-08-11T11:16:54.532026Z","caller":"traceutil/trace.go:171","msg":"trace[1603076467] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/envoyproxies.gateway.envoyproxy.io; range_end:; response_count:1; response_revision:641; }","duration":"160.017135ms","start":"2026-08-11T11:16:54.371975Z","end":"2026-08-11T11:16:54.531992Z","steps":["trace[1603076467] 'agreement among raft nodes before linearized reading' (duration: 159.452171ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:17:01.002815Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.764434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T11:17:01.00293Z","caller":"traceutil/trace.go:171","msg":"trace[1797539887] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:699; }","duration":"143.981719ms","start":"2026-08-11T11:17:00.858921Z","end":"2026-08-11T11:17:01.002903Z","steps":["trace[1797539887] 'range keys from in-memory index tree' (duration: 143.538588ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:17:01.686632Z","caller":"traceutil/trace.go:171","msg":"trace[1706610660] transaction","detail":"{read_only:false; response_revision:703; number_of_response:1; }","duration":"289.269123ms","start":"2026-08-11T11:17:01.397336Z","end":"2026-08-11T11:17:01.686605Z","steps":["trace[1706610660] 'process raft request' (duration: 289.055137ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:17:01.80372Z","caller":"traceutil/trace.go:171","msg":"trace[1030421980] linearizableReadLoop","detail":"{readStateIndex:731; appliedIndex:730; }","duration":"184.183077ms","start":"2026-08-11T11:17:01.619505Z","end":"2026-08-11T11:17:01.803688Z","steps":["trace[1030421980] 'read index received' (duration: 67.052756ms)","trace[1030421980] 'applied index is now lower than readState.Index' (duration: 117.128711ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:17:01.803977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.165593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:17:01.804064Z","caller":"traceutil/trace.go:171","msg":"trace[270772892] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:703; }","duration":"174.294025ms","start":"2026-08-11T11:17:01.629742Z","end":"2026-08-11T11:17:01.804036Z","steps":["trace[270772892] 'agreement among raft nodes before linearized reading' (duration: 174.144462ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:17:01.804038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.491804ms","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-08-11T11:17:01.804215Z","caller":"traceutil/trace.go:171","msg":"trace[2129423830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:703; }","duration":"184.716609ms","start":"2026-08-11T11:17:01.619475Z","end":"2026-08-11T11:17:01.804192Z","steps":["trace[2129423830] 'agreement among raft nodes before linearized reading' (duration: 184.33454ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:18:37.75658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.254931ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T11:18:37.756694Z","caller":"traceutil/trace.go:171","msg":"trace[1174879048] linearizableReadLoop","detail":"{readStateIndex:1980; appliedIndex:1979; }","duration":"229.380482ms","start":"2026-08-11T11:18:37.527296Z","end":"2026-08-11T11:18:37.756676Z","steps":["trace[1174879048] 'read index received' (duration: 101.110426ms)","trace[1174879048] 'applied index is now lower than readState.Index' (duration: 128.268396ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:18:37.756777Z","caller":"traceutil/trace.go:171","msg":"trace[642515786] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"259.714183ms","start":"2026-08-11T11:18:37.49699Z","end":"2026-08-11T11:18:37.756704Z","steps":["trace[642515786] 'process raft request' (duration: 131.433296ms)","trace[642515786] 'compare' (duration: 127.082367ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:18:37.756945Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.073986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:18:37.757039Z","caller":"traceutil/trace.go:171","msg":"trace[1056737321] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1903; }","duration":"127.22366ms","start":"2026-08-11T11:18:37.629794Z","end":"2026-08-11T11:18:37.757018Z","steps":["trace[1056737321] 'agreement among raft nodes before linearized reading' (duration: 127.077576ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:18:37.757056Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.95921ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-04d12fbe-f68e-45f6-a7a4-7322bfef175a\" ","response":"range_response_count:1 size:3626"} {"level":"warn","ts":"2026-08-11T11:18:37.757044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.716741ms","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":"warn","ts":"2026-08-11T11:18:37.757091Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.952481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-08-11T11:18:37.757116Z","caller":"traceutil/trace.go:171","msg":"trace[1735586742] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-04d12fbe-f68e-45f6-a7a4-7322bfef175a; range_end:; response_count:1; response_revision:1903; }","duration":"158.071924ms","start":"2026-08-11T11:18:37.599028Z","end":"2026-08-11T11:18:37.7571Z","steps":["trace[1735586742] 'agreement among raft nodes before linearized reading' (duration: 157.801397ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:18:37.757159Z","caller":"traceutil/trace.go:171","msg":"trace[1880371135] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1903; }","duration":"229.840334ms","start":"2026-08-11T11:18:37.527286Z","end":"2026-08-11T11:18:37.757127Z","steps":["trace[1880371135] 'agreement among raft nodes before linearized reading' (duration: 229.496715ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:18:37.757184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.667965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T11:18:37.757212Z","caller":"traceutil/trace.go:171","msg":"trace[1988943601] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1903; }","duration":"227.086985ms","start":"2026-08-11T11:18:37.530084Z","end":"2026-08-11T11:18:37.757171Z","steps":["trace[1988943601] 'agreement among raft nodes before linearized reading' (duration: 226.719216ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:18:37.757262Z","caller":"traceutil/trace.go:171","msg":"trace[1050288511] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1903; }","duration":"173.792578ms","start":"2026-08-11T11:18:37.583449Z","end":"2026-08-11T11:18:37.757242Z","steps":["trace[1050288511] 'agreement among raft nodes before linearized reading' (duration: 173.43331ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:18:52.719653Z","caller":"traceutil/trace.go:171","msg":"trace[293208234] transaction","detail":"{read_only:false; response_revision:2035; number_of_response:1; }","duration":"166.176316ms","start":"2026-08-11T11:18:52.553446Z","end":"2026-08-11T11:18:52.719622Z","steps":["trace[293208234] 'process raft request' (duration: 165.888379ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:18:52.887774Z","caller":"traceutil/trace.go:171","msg":"trace[1258364228] transaction","detail":"{read_only:false; response_revision:2036; number_of_response:1; }","duration":"112.848209ms","start":"2026-08-11T11:18:52.774886Z","end":"2026-08-11T11:18:52.887734Z","steps":["trace[1258364228] 'process raft request' (duration: 88.375245ms)","trace[1258364228] 'compare' (duration: 24.30204ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:19:31.701023Z","caller":"traceutil/trace.go:171","msg":"trace[1667195532] transaction","detail":"{read_only:false; response_revision:2246; number_of_response:1; }","duration":"148.182844ms","start":"2026-08-11T11:19:31.552808Z","end":"2026-08-11T11:19:31.700991Z","steps":["trace[1667195532] 'process raft request' (duration: 147.933928ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:19:31.940338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.991787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T11:19:31.940435Z","caller":"traceutil/trace.go:171","msg":"trace[1954637999] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2246; }","duration":"126.165221ms","start":"2026-08-11T11:19:31.814248Z","end":"2026-08-11T11:19:31.940414Z","steps":["trace[1954637999] 'range keys from in-memory index tree' (duration: 125.68063ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:25:20.399068Z","caller":"traceutil/trace.go:171","msg":"trace[1050874576] linearizableReadLoop","detail":"{readStateIndex:5486; appliedIndex:5485; }","duration":"114.814438ms","start":"2026-08-11T11:25:20.284212Z","end":"2026-08-11T11:25:20.399027Z","steps":["trace[1050874576] 'read index received' (duration: 114.527781ms)","trace[1050874576] 'applied index is now lower than readState.Index' (duration: 284.927µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:25:20.39911Z","caller":"traceutil/trace.go:171","msg":"trace[1874628954] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"130.000997ms","start":"2026-08-11T11:25:20.269064Z","end":"2026-08-11T11:25:20.399065Z","steps":["trace[1874628954] 'process raft request' (duration: 129.71556ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:25:20.400444Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.194941ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:26 size:797109"} {"level":"info","ts":"2026-08-11T11:25:20.400552Z","caller":"traceutil/trace.go:171","msg":"trace[186780830] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:26; response_revision:5283; }","duration":"116.365726ms","start":"2026-08-11T11:25:20.284162Z","end":"2026-08-11T11:25:20.400528Z","steps":["trace[186780830] 'agreement among raft nodes before linearized reading' (duration: 115.027763ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:25:29.317037Z","caller":"traceutil/trace.go:171","msg":"trace[1888232712] transaction","detail":"{read_only:false; response_revision:5444; number_of_response:1; }","duration":"106.446599ms","start":"2026-08-11T11:25:29.210551Z","end":"2026-08-11T11:25:29.316997Z","steps":["trace[1888232712] 'process raft request' (duration: 106.163522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:25:29.466457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.458537ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-11T11:25:29.467101Z","caller":"traceutil/trace.go:171","msg":"trace[1711950675] transaction","detail":"{read_only:false; response_revision:5445; number_of_response:1; }","duration":"147.602844ms","start":"2026-08-11T11:25:29.319444Z","end":"2026-08-11T11:25:29.467046Z","steps":["trace[1711950675] 'process raft request' (duration: 12.44045ms)","trace[1711950675] 'compare' (duration: 134.20336ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:25:29.678852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.262214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-11T11:25:29.678937Z","caller":"traceutil/trace.go:171","msg":"trace[1251774866] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:5447; }","duration":"110.404408ms","start":"2026-08-11T11:25:29.568516Z","end":"2026-08-11T11:25:29.678921Z","steps":["trace[1251774866] 'range keys from in-memory index tree' (duration: 110.081499ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:25:38.328942Z","caller":"traceutil/trace.go:171","msg":"trace[571660674] linearizableReadLoop","detail":"{readStateIndex:5832; appliedIndex:5831; }","duration":"110.281314ms","start":"2026-08-11T11:25:38.218641Z","end":"2026-08-11T11:25:38.328922Z","steps":["trace[571660674] 'read index received' (duration: 110.081019ms)","trace[571660674] 'applied index is now lower than readState.Index' (duration: 199.785µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:25:38.329041Z","caller":"traceutil/trace.go:171","msg":"trace[997092780] transaction","detail":"{read_only:false; response_revision:5620; number_of_response:1; }","duration":"111.098155ms","start":"2026-08-11T11:25:38.217919Z","end":"2026-08-11T11:25:38.329017Z","steps":["trace[997092780] 'process raft request' (duration: 110.854389ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:25:38.329181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.517611ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-08-11T11:25:38.329224Z","caller":"traceutil/trace.go:171","msg":"trace[1646447822] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5620; }","duration":"110.608572ms","start":"2026-08-11T11:25:38.218605Z","end":"2026-08-11T11:25:38.329213Z","steps":["trace[1646447822] 'agreement among raft nodes before linearized reading' (duration: 110.424948ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:25:38.32947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.401028ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3684"} {"level":"info","ts":"2026-08-11T11:25:38.329567Z","caller":"traceutil/trace.go:171","msg":"trace[976337624] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5620; }","duration":"108.535461ms","start":"2026-08-11T11:25:38.221008Z","end":"2026-08-11T11:25:38.329544Z","steps":["trace[976337624] 'agreement among raft nodes before linearized reading' (duration: 108.242433ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:25:38.543441Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.660141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/prometheus-operated\" ","response":"range_response_count:1 size:993"} {"level":"info","ts":"2026-08-11T11:25:38.543697Z","caller":"traceutil/trace.go:171","msg":"trace[447351932] range","detail":"{range_begin:/registry/services/specs/monitoring/prometheus-operated; range_end:; response_count:1; response_revision:5623; }","duration":"179.955249ms","start":"2026-08-11T11:25:38.363699Z","end":"2026-08-11T11:25:38.543654Z","steps":["trace[447351932] 'range keys from in-memory index tree' (duration: 179.354874ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:25:38.721081Z","caller":"traceutil/trace.go:171","msg":"trace[821608741] transaction","detail":"{read_only:false; response_revision:5625; number_of_response:1; }","duration":"153.922401ms","start":"2026-08-11T11:25:38.567134Z","end":"2026-08-11T11:25:38.721057Z","steps":["trace[821608741] 'process raft request' (duration: 77.968821ms)","trace[821608741] 'compare' (duration: 75.656823ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:25:38.721037Z","caller":"traceutil/trace.go:171","msg":"trace[429076190] linearizableReadLoop","detail":"{readStateIndex:5837; appliedIndex:5836; }","duration":"134.98547ms","start":"2026-08-11T11:25:38.586023Z","end":"2026-08-11T11:25:38.721008Z","steps":["trace[429076190] 'read index received' (duration: 59.018119ms)","trace[429076190] 'applied index is now lower than readState.Index' (duration: 75.965711ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:25:38.721227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.169894ms","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-08-11T11:25:38.721282Z","caller":"traceutil/trace.go:171","msg":"trace[1462882771] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/securitypolicies/; range_end:/registry/gateway.envoyproxy.io/securitypolicies0; response_count:0; response_revision:5625; }","duration":"135.275337ms","start":"2026-08-11T11:25:38.585994Z","end":"2026-08-11T11:25:38.721269Z","steps":["trace[1462882771] 'agreement among raft nodes before linearized reading' (duration: 135.158314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:25:38.721413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.032058ms","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-08-11T11:25:38.721463Z","caller":"traceutil/trace.go:171","msg":"trace[1926826621] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5625; }","duration":"108.139361ms","start":"2026-08-11T11:25:38.613312Z","end":"2026-08-11T11:25:38.721451Z","steps":["trace[1926826621] 'agreement among raft nodes before linearized reading' (duration: 107.984977ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:26:12.976879Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2992} {"level":"info","ts":"2026-08-11T11:26:13.060627Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2992,"took":"82.104163ms","hash":1756345727,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":32555008,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-08-11T11:26:13.060816Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1756345727,"revision":2992,"compact-revision":-1} {"level":"info","ts":"2026-08-11T11:31:12.984482Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5923} {"level":"info","ts":"2026-08-11T11:31:13.068304Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5923,"took":"81.118135ms","hash":1391885362,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":25444352,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-08-11T11:31:13.068395Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1391885362,"revision":5923,"compact-revision":2992} {"level":"info","ts":"2026-08-11T11:32:00.65858Z","caller":"traceutil/trace.go:171","msg":"trace[1465908039] transaction","detail":"{read_only:false; response_revision:8528; number_of_response:1; }","duration":"112.161122ms","start":"2026-08-11T11:32:00.54639Z","end":"2026-08-11T11:32:00.658551Z","steps":["trace[1465908039] 'process raft request' (duration: 111.64558ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:12.438323Z","caller":"traceutil/trace.go:171","msg":"trace[632455901] linearizableReadLoop","detail":"{readStateIndex:8895; appliedIndex:8894; }","duration":"230.505696ms","start":"2026-08-11T11:32:12.207784Z","end":"2026-08-11T11:32:12.43829Z","steps":["trace[632455901] 'read index received' (duration: 230.292481ms)","trace[632455901] 'applied index is now lower than readState.Index' (duration: 211.995µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:32:12.438435Z","caller":"traceutil/trace.go:171","msg":"trace[193414215] transaction","detail":"{read_only:false; response_revision:8589; number_of_response:1; }","duration":"234.073903ms","start":"2026-08-11T11:32:12.204319Z","end":"2026-08-11T11:32:12.438393Z","steps":["trace[193414215] 'process raft request' (duration: 233.639463ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:32:12.438593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.767243ms","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:7"} {"level":"warn","ts":"2026-08-11T11:32:12.438662Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.887805ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-11T11:32:12.438705Z","caller":"traceutil/trace.go:171","msg":"trace[1380622745] range","detail":"{range_begin:/registry/cert-manager.io/certificates/; range_end:/registry/cert-manager.io/certificates0; response_count:0; response_revision:8589; }","duration":"230.964447ms","start":"2026-08-11T11:32:12.207717Z","end":"2026-08-11T11:32:12.438681Z","steps":["trace[1380622745] 'agreement among raft nodes before linearized reading' (duration: 230.710211ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:12.438721Z","caller":"traceutil/trace.go:171","msg":"trace[1355071086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8589; }","duration":"199.019578ms","start":"2026-08-11T11:32:12.239683Z","end":"2026-08-11T11:32:12.438702Z","steps":["trace[1355071086] 'agreement among raft nodes before linearized reading' (duration: 198.814263ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:13.233899Z","caller":"traceutil/trace.go:171","msg":"trace[538995221] linearizableReadLoop","detail":"{readStateIndex:8899; appliedIndex:8898; }","duration":"171.914868ms","start":"2026-08-11T11:32:13.061911Z","end":"2026-08-11T11:32:13.233826Z","steps":["trace[538995221] 'read index received' (duration: 170.969215ms)","trace[538995221] 'applied index is now lower than readState.Index' (duration: 944.353µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:32:13.233932Z","caller":"traceutil/trace.go:171","msg":"trace[1490132203] transaction","detail":"{read_only:false; response_revision:8593; number_of_response:1; }","duration":"251.73696ms","start":"2026-08-11T11:32:12.982151Z","end":"2026-08-11T11:32:13.233888Z","steps":["trace[1490132203] 'process raft request' (duration: 250.738706ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:32:13.23425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.302927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-08-11T11:32:13.234357Z","caller":"traceutil/trace.go:171","msg":"trace[1978911211] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8593; }","duration":"172.492812ms","start":"2026-08-11T11:32:13.061829Z","end":"2026-08-11T11:32:13.234322Z","steps":["trace[1978911211] 'agreement among raft nodes before linearized reading' (duration: 172.171924ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:37.462047Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002374.wal"} {"level":"warn","ts":"2026-08-11T11:32:41.657736Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.827332ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:29"} {"level":"info","ts":"2026-08-11T11:32:41.657939Z","caller":"traceutil/trace.go:171","msg":"trace[2087049871] linearizableReadLoop","detail":"{readStateIndex:9113; appliedIndex:9112; }","duration":"268.960227ms","start":"2026-08-11T11:32:41.388966Z","end":"2026-08-11T11:32:41.657926Z","steps":["trace[2087049871] 'read index received' (duration: 27.946231ms)","trace[2087049871] 'applied index is now lower than readState.Index' (duration: 241.013236ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:32:41.658201Z","caller":"traceutil/trace.go:171","msg":"trace[2120318030] transaction","detail":"{read_only:false; response_revision:8800; number_of_response:1; }","duration":"116.738945ms","start":"2026-08-11T11:32:41.541454Z","end":"2026-08-11T11:32:41.658193Z","steps":["trace[2120318030] 'process raft request' (duration: 116.379177ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:32:41.658218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"269.239733ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-11T11:32:41.658296Z","caller":"traceutil/trace.go:171","msg":"trace[575194122] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8799; }","duration":"269.370206ms","start":"2026-08-11T11:32:41.388907Z","end":"2026-08-11T11:32:41.658277Z","steps":["trace[575194122] 'agreement among raft nodes before linearized reading' (duration: 269.10956ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:32:41.664707Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.186464ms","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-08-11T11:32:41.664774Z","caller":"traceutil/trace.go:171","msg":"trace[654413884] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8800; }","duration":"227.265796ms","start":"2026-08-11T11:32:41.437491Z","end":"2026-08-11T11:32:41.664757Z","steps":["trace[654413884] 'agreement among raft nodes before linearized reading' (duration: 220.706295ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:45.937216Z","caller":"traceutil/trace.go:171","msg":"trace[964022183] linearizableReadLoop","detail":"{readStateIndex:9133; appliedIndex:9132; }","duration":"258.925408ms","start":"2026-08-11T11:32:45.67826Z","end":"2026-08-11T11:32:45.937185Z","steps":["trace[964022183] 'read index received' (duration: 258.743203ms)","trace[964022183] 'applied index is now lower than readState.Index' (duration: 181.045µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:32:45.937258Z","caller":"traceutil/trace.go:171","msg":"trace[1139796893] transaction","detail":"{read_only:false; response_revision:8819; number_of_response:1; }","duration":"267.426158ms","start":"2026-08-11T11:32:45.669797Z","end":"2026-08-11T11:32:45.937223Z","steps":["trace[1139796893] 'process raft request' (duration: 267.206972ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:32:45.937454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"259.175215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-11T11:32:45.937498Z","caller":"traceutil/trace.go:171","msg":"trace[1980439891] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8819; }","duration":"259.280847ms","start":"2026-08-11T11:32:45.678204Z","end":"2026-08-11T11:32:45.937485Z","steps":["trace[1980439891] 'agreement among raft nodes before linearized reading' (duration: 259.115553ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:45.943084Z","caller":"traceutil/trace.go:171","msg":"trace[1994076114] transaction","detail":"{read_only:false; response_revision:8820; number_of_response:1; }","duration":"224.056708ms","start":"2026-08-11T11:32:45.71898Z","end":"2026-08-11T11:32:45.943037Z","steps":["trace[1994076114] 'process raft request' (duration: 223.829952ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:32:45.943161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.486212ms","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-08-11T11:32:45.943219Z","caller":"traceutil/trace.go:171","msg":"trace[532871994] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8821; }","duration":"242.586085ms","start":"2026-08-11T11:32:45.700622Z","end":"2026-08-11T11:32:45.943208Z","steps":["trace[532871994] 'agreement among raft nodes before linearized reading' (duration: 242.39761ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:45.943562Z","caller":"traceutil/trace.go:171","msg":"trace[36868021] transaction","detail":"{read_only:false; response_revision:8821; number_of_response:1; }","duration":"127.577024ms","start":"2026-08-11T11:32:45.815958Z","end":"2026-08-11T11:32:45.943535Z","steps":["trace[36868021] 'process raft request' (duration: 127.005769ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:54.49273Z","caller":"traceutil/trace.go:171","msg":"trace[1396637751] linearizableReadLoop","detail":"{readStateIndex:9228; appliedIndex:9227; }","duration":"144.679554ms","start":"2026-08-11T11:32:54.348028Z","end":"2026-08-11T11:32:54.492708Z","steps":["trace[1396637751] 'read index received' (duration: 144.530931ms)","trace[1396637751] 'applied index is now lower than readState.Index' (duration: 147.823µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:32:54.492882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.463288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:32:54.492913Z","caller":"traceutil/trace.go:171","msg":"trace[1246266156] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8908; }","duration":"131.553791ms","start":"2026-08-11T11:32:54.361351Z","end":"2026-08-11T11:32:54.492904Z","steps":["trace[1246266156] 'agreement among raft nodes before linearized reading' (duration: 131.4882ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:54.492887Z","caller":"traceutil/trace.go:171","msg":"trace[1092109360] transaction","detail":"{read_only:false; response_revision:8908; number_of_response:1; }","duration":"147.645828ms","start":"2026-08-11T11:32:54.345197Z","end":"2026-08-11T11:32:54.492842Z","steps":["trace[1092109360] 'process raft request' (duration: 147.364461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:32:54.492998Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.963702ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-8q4xd\" ","response":"range_response_count:1 size:6447"} {"level":"info","ts":"2026-08-11T11:32:54.493076Z","caller":"traceutil/trace.go:171","msg":"trace[179488049] range","detail":"{range_begin:/registry/pods/openstack/keepalived-8q4xd; range_end:; response_count:1; response_revision:8908; }","duration":"145.084735ms","start":"2026-08-11T11:32:54.347974Z","end":"2026-08-11T11:32:54.493059Z","steps":["trace[179488049] 'agreement among raft nodes before linearized reading' (duration: 144.839248ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:54.724036Z","caller":"traceutil/trace.go:171","msg":"trace[1345568342] transaction","detail":"{read_only:false; response_revision:8909; number_of_response:1; }","duration":"125.03803ms","start":"2026-08-11T11:32:54.598977Z","end":"2026-08-11T11:32:54.724015Z","steps":["trace[1345568342] 'process raft request' (duration: 124.62653ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:32:55.415441Z","caller":"traceutil/trace.go:171","msg":"trace[271818778] transaction","detail":"{read_only:false; response_revision:8916; number_of_response:1; }","duration":"110.87955ms","start":"2026-08-11T11:32:55.304533Z","end":"2026-08-11T11:32:55.415413Z","steps":["trace[271818778] 'process raft request' (duration: 110.702006ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:33:08.590301Z","caller":"traceutil/trace.go:171","msg":"trace[939553252] transaction","detail":"{read_only:false; response_revision:9021; number_of_response:1; }","duration":"101.53701ms","start":"2026-08-11T11:33:08.488735Z","end":"2026-08-11T11:33:08.590272Z","steps":["trace[939553252] 'process raft request' (duration: 101.193421ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:34:10.416791Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a071a454a8148542","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-11T11:34:10.422597Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-11T11:34:10.422727Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-11T11:34:14.416629Z","caller":"traceutil/trace.go:171","msg":"trace[982592780] transaction","detail":"{read_only:false; response_revision:9676; number_of_response:1; }","duration":"128.623609ms","start":"2026-08-11T11:34:14.287972Z","end":"2026-08-11T11:34:14.416596Z","steps":["trace[982592780] 'process raft request' (duration: 128.455095ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:34:14.421739Z","caller":"traceutil/trace.go:171","msg":"trace[1472724162] transaction","detail":"{read_only:false; response_revision:9677; number_of_response:1; }","duration":"103.769665ms","start":"2026-08-11T11:34:14.317934Z","end":"2026-08-11T11:34:14.421703Z","steps":["trace[1472724162] 'process raft request' (duration: 103.465467ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:34:14.422135Z","caller":"traceutil/trace.go:171","msg":"trace[957411975] transaction","detail":"{read_only:false; response_revision:9678; number_of_response:1; }","duration":"104.022682ms","start":"2026-08-11T11:34:14.318063Z","end":"2026-08-11T11:34:14.422086Z","steps":["trace[957411975] 'process raft request' (duration: 103.474478ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:34:14.551291Z","caller":"traceutil/trace.go:171","msg":"trace[1394304717] transaction","detail":"{read_only:false; response_revision:9680; number_of_response:1; }","duration":"114.180582ms","start":"2026-08-11T11:34:14.437075Z","end":"2026-08-11T11:34:14.551256Z","steps":["trace[1394304717] 'process raft request' (duration: 113.887045ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:36:12.991617Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8078} {"level":"info","ts":"2026-08-11T11:36:13.057439Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8078,"took":"63.130027ms","hash":1601618976,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":28688384,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-11T11:36:13.0575Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1601618976,"revision":8078,"compact-revision":5923} {"level":"info","ts":"2026-08-11T11:39:51.37882Z","caller":"traceutil/trace.go:171","msg":"trace[1881565840] transaction","detail":"{read_only:false; response_revision:12100; number_of_response:1; }","duration":"118.359546ms","start":"2026-08-11T11:39:51.260432Z","end":"2026-08-11T11:39:51.378792Z","steps":["trace[1881565840] 'process raft request' (duration: 118.185342ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:39:51.421453Z","caller":"traceutil/trace.go:171","msg":"trace[2087015315] transaction","detail":"{read_only:false; response_revision:12101; number_of_response:1; }","duration":"159.372596ms","start":"2026-08-11T11:39:51.262054Z","end":"2026-08-11T11:39:51.421427Z","steps":["trace[2087015315] 'process raft request' (duration: 135.171611ms)","trace[2087015315] 'compare' (duration: 24.064142ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:39:51.453488Z","caller":"traceutil/trace.go:171","msg":"trace[413954943] linearizableReadLoop","detail":"{readStateIndex:12522; appliedIndex:12519; }","duration":"175.038543ms","start":"2026-08-11T11:39:51.27843Z","end":"2026-08-11T11:39:51.453469Z","steps":["trace[413954943] 'read index received' (duration: 100.336402ms)","trace[413954943] 'applied index is now lower than readState.Index' (duration: 74.700781ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:39:51.453658Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.195667ms","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:5"} {"level":"info","ts":"2026-08-11T11:39:51.453706Z","caller":"traceutil/trace.go:171","msg":"trace[719543997] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:12101; }","duration":"175.358231ms","start":"2026-08-11T11:39:51.278335Z","end":"2026-08-11T11:39:51.453693Z","steps":["trace[719543997] 'agreement among raft nodes before linearized reading' (duration: 175.252788ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:39:51.453865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.504438ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-storage-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:39:51.453987Z","caller":"traceutil/trace.go:171","msg":"trace[1658011044] range","detail":"{range_begin:/registry/jobs/openstack/cinder-storage-init; range_end:; response_count:0; response_revision:12101; }","duration":"111.672622ms","start":"2026-08-11T11:39:51.342265Z","end":"2026-08-11T11:39:51.453938Z","steps":["trace[1658011044] 'agreement among raft nodes before linearized reading' (duration: 111.514458ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:39:51.453999Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.246771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-endpoints\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-11T11:39:51.45409Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.353549ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:39:51.45411Z","caller":"traceutil/trace.go:171","msg":"trace[547452779] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-endpoints; range_end:; response_count:0; response_revision:12101; }","duration":"111.394434ms","start":"2026-08-11T11:39:51.342693Z","end":"2026-08-11T11:39:51.454087Z","steps":["trace[547452779] 'agreement among raft nodes before linearized reading' (duration: 111.20534ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:39:51.454139Z","caller":"traceutil/trace.go:171","msg":"trace[97220559] range","detail":"{range_begin:/registry/jobs/openstack/cinder-rabbit-init; range_end:; response_count:0; response_revision:12101; }","duration":"110.40419ms","start":"2026-08-11T11:39:51.343718Z","end":"2026-08-11T11:39:51.454122Z","steps":["trace[97220559] 'agreement among raft nodes before linearized reading' (duration: 110.355239ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:39:51.45405Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.905897ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-db-sync\" ","response":"range_response_count:1 size:5004"} {"level":"warn","ts":"2026-08-11T11:39:51.4542Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.813545ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/cinder-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-08-11T11:39:51.454242Z","caller":"traceutil/trace.go:171","msg":"trace[605933287] range","detail":"{range_begin:/registry/jobs/openstack/cinder-db-sync; range_end:; response_count:1; response_revision:12101; }","duration":"110.110413ms","start":"2026-08-11T11:39:51.344124Z","end":"2026-08-11T11:39:51.454234Z","steps":["trace[605933287] 'agreement among raft nodes before linearized reading' (duration: 109.791595ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:39:51.453864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.531924ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/cinder-ks-user\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-11T11:39:51.454254Z","caller":"traceutil/trace.go:171","msg":"trace[431274891] range","detail":"{range_begin:/registry/services/endpoints/openstack/cinder-api; range_end:; response_count:1; response_revision:12101; }","duration":"111.868826ms","start":"2026-08-11T11:39:51.342374Z","end":"2026-08-11T11:39:51.454243Z","steps":["trace[431274891] 'agreement among raft nodes before linearized reading' (duration: 111.696212ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:39:51.454289Z","caller":"traceutil/trace.go:171","msg":"trace[1988605596] range","detail":"{range_begin:/registry/jobs/openstack/cinder-ks-user; range_end:; response_count:0; response_revision:12101; }","duration":"111.018616ms","start":"2026-08-11T11:39:51.343259Z","end":"2026-08-11T11:39:51.454278Z","steps":["trace[1988605596] 'agreement among raft nodes before linearized reading' (duration: 110.492383ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:41:12.997854Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10510} {"level":"info","ts":"2026-08-11T11:41:13.078823Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10510,"took":"78.399092ms","hash":2702896295,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":25968640,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-11T11:41:13.078899Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2702896295,"revision":10510,"compact-revision":8078} {"level":"info","ts":"2026-08-11T11:46:13.004578Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12639} {"level":"info","ts":"2026-08-11T11:46:13.084997Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12639,"took":"77.992779ms","hash":2061002510,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":27418624,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-11T11:46:13.085083Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2061002510,"revision":12639,"compact-revision":10510} {"level":"warn","ts":"2026-08-11T11:46:31.643078Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.326563ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T11:46:31.644164Z","caller":"traceutil/trace.go:171","msg":"trace[1977163455] linearizableReadLoop","detail":"{readStateIndex:15289; appliedIndex:15287; }","duration":"274.343071ms","start":"2026-08-11T11:46:31.369794Z","end":"2026-08-11T11:46:31.644137Z","steps":["trace[1977163455] 'read index received' (duration: 28.893651ms)","trace[1977163455] 'applied index is now lower than readState.Index' (duration: 245.44803ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:46:31.644285Z","caller":"traceutil/trace.go:171","msg":"trace[1181734186] transaction","detail":"{read_only:false; response_revision:14771; number_of_response:1; }","duration":"322.875297ms","start":"2026-08-11T11:46:31.321395Z","end":"2026-08-11T11:46:31.64427Z","steps":["trace[1181734186] 'process raft request' (duration: 77.241571ms)","trace[1181734186] 'compare' (duration: 243.546074ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:46:31.644403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:46:31.321381Z","time spent":"322.936179ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:46:31.644829Z","caller":"traceutil/trace.go:171","msg":"trace[71641748] transaction","detail":"{read_only:false; response_revision:14772; number_of_response:1; }","duration":"322.590609ms","start":"2026-08-11T11:46:31.322226Z","end":"2026-08-11T11:46:31.644817Z","steps":["trace[71641748] 'process raft request' (duration: 321.589414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:46:31.644901Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:46:31.322214Z","time spent":"322.65052ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":11811,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T11:46:31.647948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"278.155865ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-11T11:46:31.648025Z","caller":"traceutil/trace.go:171","msg":"trace[440035239] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14772; }","duration":"278.282318ms","start":"2026-08-11T11:46:31.369726Z","end":"2026-08-11T11:46:31.648008Z","steps":["trace[440035239] 'agreement among raft nodes before linearized reading' (duration: 275.269714ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:46:31.780334Z","caller":"traceutil/trace.go:171","msg":"trace[596970378] linearizableReadLoop","detail":"{readStateIndex:15291; appliedIndex:15290; }","duration":"129.131548ms","start":"2026-08-11T11:46:31.651172Z","end":"2026-08-11T11:46:31.780304Z","steps":["trace[596970378] 'read index received' (duration: 80.115452ms)","trace[596970378] 'applied index is now lower than readState.Index' (duration: 49.014045ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:46:31.780648Z","caller":"traceutil/trace.go:171","msg":"trace[1683180288] transaction","detail":"{read_only:false; response_revision:14774; number_of_response:1; }","duration":"129.592519ms","start":"2026-08-11T11:46:31.650899Z","end":"2026-08-11T11:46:31.780491Z","steps":["trace[1683180288] 'process raft request' (duration: 129.20597ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:46:31.780788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.584899ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12212"} {"level":"info","ts":"2026-08-11T11:46:31.780887Z","caller":"traceutil/trace.go:171","msg":"trace[1546928695] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:14774; }","duration":"129.703852ms","start":"2026-08-11T11:46:31.651158Z","end":"2026-08-11T11:46:31.780862Z","steps":["trace[1546928695] 'agreement among raft nodes before linearized reading' (duration: 129.361154ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:46:54.083802Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.630617ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-11T11:46:54.084023Z","caller":"traceutil/trace.go:171","msg":"trace[640430976] transaction","detail":"{read_only:false; response_revision:15080; number_of_response:1; }","duration":"175.223393ms","start":"2026-08-11T11:46:53.908759Z","end":"2026-08-11T11:46:54.083982Z","steps":["trace[640430976] 'process raft request' (duration: 37.296459ms)","trace[640430976] 'compare' (duration: 137.195706ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:48:19.887958Z","caller":"traceutil/trace.go:171","msg":"trace[1392566723] transaction","detail":"{read_only:false; response_revision:15888; number_of_response:1; }","duration":"166.622486ms","start":"2026-08-11T11:48:19.721306Z","end":"2026-08-11T11:48:19.887929Z","steps":["trace[1392566723] 'process raft request' (duration: 166.453902ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:48:19.897652Z","caller":"traceutil/trace.go:171","msg":"trace[1911309716] linearizableReadLoop","detail":"{readStateIndex:16438; appliedIndex:16436; }","duration":"109.632345ms","start":"2026-08-11T11:48:19.787996Z","end":"2026-08-11T11:48:19.897628Z","steps":["trace[1911309716] 'read index received' (duration: 99.733612ms)","trace[1911309716] 'applied index is now lower than readState.Index' (duration: 9.897763ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:48:19.89782Z","caller":"traceutil/trace.go:171","msg":"trace[600521785] transaction","detail":"{read_only:false; response_revision:15889; number_of_response:1; }","duration":"173.7425ms","start":"2026-08-11T11:48:19.724051Z","end":"2026-08-11T11:48:19.897794Z","steps":["trace[600521785] 'process raft request' (duration: 173.435522ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:48:19.897917Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.891782ms","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-08-11T11:48:19.897963Z","caller":"traceutil/trace.go:171","msg":"trace[781522311] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:15889; }","duration":"109.970134ms","start":"2026-08-11T11:48:19.787981Z","end":"2026-08-11T11:48:19.897951Z","steps":["trace[781522311] 'agreement among raft nodes before linearized reading' (duration: 109.752679ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:51:13.011005Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14658} {"level":"info","ts":"2026-08-11T11:51:13.085281Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14658,"took":"70.825401ms","hash":1727061671,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":33939456,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-11T11:51:13.085362Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1727061671,"revision":14658,"compact-revision":12639} {"level":"info","ts":"2026-08-11T11:54:12.128813Z","caller":"traceutil/trace.go:171","msg":"trace[669453025] linearizableReadLoop","detail":"{readStateIndex:19132; appliedIndex:19131; }","duration":"171.589012ms","start":"2026-08-11T11:54:11.9572Z","end":"2026-08-11T11:54:12.128789Z","steps":["trace[669453025] 'read index received' (duration: 136.272153ms)","trace[669453025] 'applied index is now lower than readState.Index' (duration: 35.315559ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:54:12.128966Z","caller":"traceutil/trace.go:171","msg":"trace[1957403094] transaction","detail":"{read_only:false; response_revision:18496; number_of_response:1; }","duration":"202.898204ms","start":"2026-08-11T11:54:11.926009Z","end":"2026-08-11T11:54:12.128908Z","steps":["trace[1957403094] 'process raft request' (duration: 167.540063ms)","trace[1957403094] 'compare' (duration: 35.140884ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:54:12.129018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.796388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0\" ","response":"range_response_count:1 size:1866"} {"level":"info","ts":"2026-08-11T11:54:12.12908Z","caller":"traceutil/trace.go:171","msg":"trace[608733930] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-barbican-server-0; range_end:; response_count:1; response_revision:18496; }","duration":"171.909021ms","start":"2026-08-11T11:54:11.957155Z","end":"2026-08-11T11:54:12.129064Z","steps":["trace[608733930] 'agreement among raft nodes before linearized reading' (duration: 171.733886ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:54:12.717426Z","caller":"traceutil/trace.go:171","msg":"trace[1306911903] linearizableReadLoop","detail":"{readStateIndex:19134; appliedIndex:19133; }","duration":"354.517414ms","start":"2026-08-11T11:54:12.362881Z","end":"2026-08-11T11:54:12.717399Z","steps":["trace[1306911903] 'read index received' (duration: 354.231276ms)","trace[1306911903] 'applied index is now lower than readState.Index' (duration: 284.668µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:54:12.717521Z","caller":"traceutil/trace.go:171","msg":"trace[296229353] transaction","detail":"{read_only:false; response_revision:18498; number_of_response:1; }","duration":"447.335948ms","start":"2026-08-11T11:54:12.270144Z","end":"2026-08-11T11:54:12.71748Z","steps":["trace[296229353] 'process raft request' (duration: 447.054051ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:54:12.717701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.78964ms","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-08-11T11:54:12.717723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:54:12.270094Z","time spent":"447.523632ms","remote":"127.0.0.1:37630","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20781,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T11:54:12.717788Z","caller":"traceutil/trace.go:171","msg":"trace[1431262561] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:18498; }","duration":"354.958185ms","start":"2026-08-11T11:54:12.362809Z","end":"2026-08-11T11:54:12.717767Z","steps":["trace[1431262561] 'agreement among raft nodes before linearized reading' (duration: 354.702319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:54:12.717841Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T11:54:12.362781Z","time spent":"355.046166ms","remote":"127.0.0.1:37706","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-08-11T11:54:12.962671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.751073ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T11:54:12.962969Z","caller":"traceutil/trace.go:171","msg":"trace[1795474209] linearizableReadLoop","detail":"{readStateIndex:19135; appliedIndex:19134; }","duration":"220.120995ms","start":"2026-08-11T11:54:12.742829Z","end":"2026-08-11T11:54:12.96295Z","steps":["trace[1795474209] 'read index received' (duration: 39.604334ms)","trace[1795474209] 'applied index is now lower than readState.Index' (duration: 180.514381ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:54:12.963099Z","caller":"traceutil/trace.go:171","msg":"trace[609891667] transaction","detail":"{read_only:false; response_revision:18499; number_of_response:1; }","duration":"240.359054ms","start":"2026-08-11T11:54:12.722676Z","end":"2026-08-11T11:54:12.963036Z","steps":["trace[609891667] 'process raft request' (duration: 59.808442ms)","trace[609891667] 'compare' (duration: 179.127688ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:54:12.964154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.321886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:94 size:940134"} {"level":"info","ts":"2026-08-11T11:54:12.964218Z","caller":"traceutil/trace.go:171","msg":"trace[1396286474] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:94; response_revision:18499; }","duration":"221.389498ms","start":"2026-08-11T11:54:12.742815Z","end":"2026-08-11T11:54:12.964205Z","steps":["trace[1396286474] 'agreement among raft nodes before linearized reading' (duration: 220.230309ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:55:25.822243Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a071a454a8148542","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-11T11:55:25.828821Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-11T11:55:25.828904Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-11T11:56:13.017535Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17310} {"level":"info","ts":"2026-08-11T11:56:13.113156Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17310,"took":"92.579828ms","hash":1973896848,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":35164160,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-08-11T11:56:13.113216Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1973896848,"revision":17310,"compact-revision":14658} {"level":"info","ts":"2026-08-11T11:59:58.759335Z","caller":"traceutil/trace.go:171","msg":"trace[1168516021] linearizableReadLoop","detail":"{readStateIndex:21906; appliedIndex:21905; }","duration":"103.882076ms","start":"2026-08-11T11:59:58.655435Z","end":"2026-08-11T11:59:58.759317Z","steps":["trace[1168516021] 'read index received' (duration: 103.786364ms)","trace[1168516021] 'applied index is now lower than readState.Index' (duration: 95.002µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:59:58.759409Z","caller":"traceutil/trace.go:171","msg":"trace[1722250060] transaction","detail":"{read_only:false; response_revision:21182; number_of_response:1; }","duration":"245.580962ms","start":"2026-08-11T11:59:58.513788Z","end":"2026-08-11T11:59:58.759369Z","steps":["trace[1722250060] 'process raft request' (duration: 245.406668ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:59:58.759455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.02003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/horizontalpodautoscalers/\" range_end:\"/registry/horizontalpodautoscalers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T11:59:58.759701Z","caller":"traceutil/trace.go:171","msg":"trace[977700653] range","detail":"{range_begin:/registry/horizontalpodautoscalers/; range_end:/registry/horizontalpodautoscalers0; response_count:0; response_revision:21182; }","duration":"104.288346ms","start":"2026-08-11T11:59:58.655371Z","end":"2026-08-11T11:59:58.759659Z","steps":["trace[977700653] 'agreement among raft nodes before linearized reading' (duration: 104.04015ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:59:58.910666Z","caller":"traceutil/trace.go:171","msg":"trace[127496215] transaction","detail":"{read_only:false; response_revision:21183; number_of_response:1; }","duration":"237.835583ms","start":"2026-08-11T11:59:58.672767Z","end":"2026-08-11T11:59:58.910602Z","steps":["trace[127496215] 'process raft request' (duration: 204.643145ms)","trace[127496215] 'compare' (duration: 32.979172ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:59:58.910681Z","caller":"traceutil/trace.go:171","msg":"trace[668599391] linearizableReadLoop","detail":"{readStateIndex:21907; appliedIndex:21906; }","duration":"151.236251ms","start":"2026-08-11T11:59:58.759388Z","end":"2026-08-11T11:59:58.910624Z","steps":["trace[668599391] 'read index received' (duration: 118.098025ms)","trace[668599391] 'applied index is now lower than readState.Index' (duration: 33.134276ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T11:59:58.910861Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.00576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T11:59:58.910981Z","caller":"traceutil/trace.go:171","msg":"trace[2130462109] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21184; }","duration":"152.159514ms","start":"2026-08-11T11:59:58.758793Z","end":"2026-08-11T11:59:58.910953Z","steps":["trace[2130462109] 'agreement among raft nodes before linearized reading' (duration: 151.914068ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:59:58.91098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.0562ms","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-08-11T11:59:58.911051Z","caller":"traceutil/trace.go:171","msg":"trace[2059907037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:21184; }","duration":"208.178952ms","start":"2026-08-11T11:59:58.702856Z","end":"2026-08-11T11:59:58.911035Z","steps":["trace[2059907037] 'agreement among raft nodes before linearized reading' (duration: 207.899765ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:59:58.911123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.440595ms","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-08-11T11:59:58.911201Z","caller":"traceutil/trace.go:171","msg":"trace[458039948] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21184; }","duration":"103.567918ms","start":"2026-08-11T11:59:58.80761Z","end":"2026-08-11T11:59:58.911178Z","steps":["trace[458039948] 'agreement among raft nodes before linearized reading' (duration: 103.364024ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:59:58.911291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.052345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T11:59:58.91136Z","caller":"traceutil/trace.go:171","msg":"trace[2047086412] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21184; }","duration":"103.139507ms","start":"2026-08-11T11:59:58.808202Z","end":"2026-08-11T11:59:58.911341Z","steps":["trace[2047086412] 'agreement among raft nodes before linearized reading' (duration: 102.952913ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:59:59.189166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.019753ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T11:59:59.189432Z","caller":"traceutil/trace.go:171","msg":"trace[1595107733] transaction","detail":"{read_only:false; response_revision:21187; number_of_response:1; }","duration":"271.334336ms","start":"2026-08-11T11:59:58.918079Z","end":"2026-08-11T11:59:59.189414Z","steps":["trace[1595107733] 'process raft request' (duration: 271.293895ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:59:59.189558Z","caller":"traceutil/trace.go:171","msg":"trace[1152057119] transaction","detail":"{read_only:false; response_revision:21186; number_of_response:1; }","duration":"272.891806ms","start":"2026-08-11T11:59:58.916658Z","end":"2026-08-11T11:59:59.18955Z","steps":["trace[1152057119] 'process raft request' (duration: 272.616419ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:59:59.189791Z","caller":"traceutil/trace.go:171","msg":"trace[2029628440] transaction","detail":"{read_only:false; response_revision:21185; number_of_response:1; }","duration":"274.546256ms","start":"2026-08-11T11:59:58.91521Z","end":"2026-08-11T11:59:59.189756Z","steps":["trace[2029628440] 'process raft request' (duration: 114.844986ms)","trace[2029628440] 'compare' (duration: 158.687264ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:59:59.716456Z","caller":"traceutil/trace.go:171","msg":"trace[1279113039] linearizableReadLoop","detail":"{readStateIndex:21912; appliedIndex:21911; }","duration":"191.392099ms","start":"2026-08-11T11:59:59.525039Z","end":"2026-08-11T11:59:59.716431Z","steps":["trace[1279113039] 'read index received' (duration: 191.102432ms)","trace[1279113039] 'applied index is now lower than readState.Index' (duration: 288.737µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T11:59:59.716781Z","caller":"traceutil/trace.go:171","msg":"trace[125504145] transaction","detail":"{read_only:false; response_revision:21188; number_of_response:1; }","duration":"239.427521ms","start":"2026-08-11T11:59:59.47734Z","end":"2026-08-11T11:59:59.716767Z","steps":["trace[125504145] 'process raft request' (duration: 238.885158ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:59:59.717162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.101736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-11T11:59:59.717209Z","caller":"traceutil/trace.go:171","msg":"trace[1036195007] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:21188; }","duration":"192.20945ms","start":"2026-08-11T11:59:59.524986Z","end":"2026-08-11T11:59:59.717196Z","steps":["trace[1036195007] 'agreement among raft nodes before linearized reading' (duration: 192.039755ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T11:59:59.717448Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.8886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/networkpolicies/\" range_end:\"/registry/networkpolicies0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-11T11:59:59.717494Z","caller":"traceutil/trace.go:171","msg":"trace[109860415] range","detail":"{range_begin:/registry/networkpolicies/; range_end:/registry/networkpolicies0; response_count:0; response_revision:21188; }","duration":"156.940552ms","start":"2026-08-11T11:59:59.56054Z","end":"2026-08-11T11:59:59.717481Z","steps":["trace[109860415] 'agreement among raft nodes before linearized reading' (duration: 156.833319ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T11:59:59.910643Z","caller":"traceutil/trace.go:171","msg":"trace[2062705027] transaction","detail":"{read_only:false; response_revision:21189; number_of_response:1; }","duration":"189.00292ms","start":"2026-08-11T11:59:59.721612Z","end":"2026-08-11T11:59:59.910615Z","steps":["trace[2062705027] 'process raft request' (duration: 132.478999ms)","trace[2062705027] 'compare' (duration: 56.320446ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:00:00.043834Z","caller":"traceutil/trace.go:171","msg":"trace[998969251] linearizableReadLoop","detail":"{readStateIndex:21914; appliedIndex:21913; }","duration":"133.25902ms","start":"2026-08-11T11:59:59.910548Z","end":"2026-08-11T12:00:00.043807Z","steps":["trace[998969251] 'read index received' (duration: 114.655241ms)","trace[998969251] 'applied index is now lower than readState.Index' (duration: 18.600018ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:00:00.043845Z","caller":"traceutil/trace.go:171","msg":"trace[1325170008] transaction","detail":"{read_only:false; response_revision:21190; number_of_response:1; }","duration":"141.257176ms","start":"2026-08-11T11:59:59.902537Z","end":"2026-08-11T12:00:00.043794Z","steps":["trace[1325170008] 'process raft request' (duration: 122.662228ms)","trace[1325170008] 'compare' (duration: 18.365113ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:00:00.044037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.009915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-11T12:00:00.043847Z","caller":"traceutil/trace.go:171","msg":"trace[1022922091] transaction","detail":"{read_only:false; response_revision:21191; number_of_response:1; }","duration":"129.323002ms","start":"2026-08-11T11:59:59.914433Z","end":"2026-08-11T12:00:00.043756Z","steps":["trace[1022922091] 'process raft request' (duration: 129.274371ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:00:00.044148Z","caller":"traceutil/trace.go:171","msg":"trace[313996971] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:21191; }","duration":"140.187099ms","start":"2026-08-11T11:59:59.903938Z","end":"2026-08-11T12:00:00.044125Z","steps":["trace[313996971] 'agreement among raft nodes before linearized reading' (duration: 139.982594ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:00:00.307181Z","caller":"traceutil/trace.go:171","msg":"trace[1484475221] transaction","detail":"{read_only:false; response_revision:21192; number_of_response:1; }","duration":"198.274378ms","start":"2026-08-11T12:00:00.108883Z","end":"2026-08-11T12:00:00.307158Z","steps":["trace[1484475221] 'process raft request' (duration: 198.131915ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:00:00.352128Z","caller":"traceutil/trace.go:171","msg":"trace[2034983726] transaction","detail":"{read_only:false; response_revision:21195; number_of_response:1; }","duration":"243.004049ms","start":"2026-08-11T12:00:00.109097Z","end":"2026-08-11T12:00:00.352101Z","steps":["trace[2034983726] 'process raft request' (duration: 242.960978ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:00:00.352622Z","caller":"traceutil/trace.go:171","msg":"trace[1003834863] transaction","detail":"{read_only:false; response_revision:21193; number_of_response:1; }","duration":"243.701956ms","start":"2026-08-11T12:00:00.108906Z","end":"2026-08-11T12:00:00.352608Z","steps":["trace[1003834863] 'process raft request' (duration: 242.977999ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:00:00.352655Z","caller":"traceutil/trace.go:171","msg":"trace[429067112] transaction","detail":"{read_only:false; response_revision:21194; number_of_response:1; }","duration":"243.587594ms","start":"2026-08-11T12:00:00.109036Z","end":"2026-08-11T12:00:00.352623Z","steps":["trace[429067112] 'process raft request' (duration: 242.984259ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:01:13.02485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19670} {"level":"info","ts":"2026-08-11T12:01:13.144323Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19670,"took":"116.200399ms","hash":1669337392,"current-db-size-bytes":56922112,"current-db-size":"57 MB","current-db-size-in-use-bytes":30560256,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-11T12:01:13.144395Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1669337392,"revision":19670,"compact-revision":17310} {"level":"warn","ts":"2026-08-11T12:04:00.422365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.599127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-08-11T12:04:00.422463Z","caller":"traceutil/trace.go:171","msg":"trace[1239532978] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:23798; }","duration":"143.7528ms","start":"2026-08-11T12:04:00.278691Z","end":"2026-08-11T12:04:00.422444Z","steps":["trace[1239532978] 'range keys from in-memory index tree' (duration: 143.384671ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:06:13.030039Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21973} {"level":"info","ts":"2026-08-11T12:06:13.136916Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21973,"took":"102.787855ms","hash":3229792486,"current-db-size-bytes":57344000,"current-db-size":"57 MB","current-db-size-in-use-bytes":44916736,"current-db-size-in-use":"45 MB"} {"level":"info","ts":"2026-08-11T12:06:13.136972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3229792486,"revision":21973,"compact-revision":19670} {"level":"info","ts":"2026-08-11T12:07:08.561696Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-000000000000677d.wal"} {"level":"info","ts":"2026-08-11T12:07:59.86301Z","caller":"traceutil/trace.go:171","msg":"trace[1908395517] linearizableReadLoop","detail":"{readStateIndex:27027; appliedIndex:27026; }","duration":"144.543689ms","start":"2026-08-11T12:07:59.718441Z","end":"2026-08-11T12:07:59.862985Z","steps":["trace[1908395517] 'read index received' (duration: 144.320863ms)","trace[1908395517] 'applied index is now lower than readState.Index' (duration: 221.936µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:07:59.863346Z","caller":"traceutil/trace.go:171","msg":"trace[703002398] transaction","detail":"{read_only:false; response_revision:26163; number_of_response:1; }","duration":"232.746637ms","start":"2026-08-11T12:07:59.630587Z","end":"2026-08-11T12:07:59.863333Z","steps":["trace[703002398] 'process raft request' (duration: 232.242484ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:07:59.863582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.124114ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:07:59.86362Z","caller":"traceutil/trace.go:171","msg":"trace[880809371] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26163; }","duration":"145.206846ms","start":"2026-08-11T12:07:59.718404Z","end":"2026-08-11T12:07:59.863611Z","steps":["trace[880809371] 'agreement among raft nodes before linearized reading' (duration: 145.126964ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:07:59.863851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.222065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11714"} {"level":"info","ts":"2026-08-11T12:07:59.863902Z","caller":"traceutil/trace.go:171","msg":"trace[1225184146] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:26163; }","duration":"138.304467ms","start":"2026-08-11T12:07:59.725588Z","end":"2026-08-11T12:07:59.863893Z","steps":["trace[1225184146] 'agreement among raft nodes before linearized reading' (duration: 138.169703ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:00.045153Z","caller":"traceutil/trace.go:171","msg":"trace[228957192] transaction","detail":"{read_only:false; response_revision:26164; number_of_response:1; }","duration":"160.240925ms","start":"2026-08-11T12:07:59.884879Z","end":"2026-08-11T12:08:00.04512Z","steps":["trace[228957192] 'process raft request' (duration: 135.803685ms)","trace[228957192] 'compare' (duration: 24.138632ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:00.045268Z","caller":"traceutil/trace.go:171","msg":"trace[1582743849] linearizableReadLoop","detail":"{readStateIndex:27028; appliedIndex:27027; }","duration":"144.238092ms","start":"2026-08-11T12:07:59.90101Z","end":"2026-08-11T12:08:00.045248Z","steps":["trace[1582743849] 'read index received' (duration: 119.723221ms)","trace[1582743849] 'applied index is now lower than readState.Index' (duration: 24.514211ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:00.045517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.490829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T12:08:00.045548Z","caller":"traceutil/trace.go:171","msg":"trace[535698390] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26165; }","duration":"144.566581ms","start":"2026-08-11T12:07:59.900974Z","end":"2026-08-11T12:08:00.045541Z","steps":["trace[535698390] 'agreement among raft nodes before linearized reading' (duration: 144.386406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:00.045659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.594021ms","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-08-11T12:08:00.045685Z","caller":"traceutil/trace.go:171","msg":"trace[175257884] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26165; }","duration":"144.635222ms","start":"2026-08-11T12:07:59.901043Z","end":"2026-08-11T12:08:00.045678Z","steps":["trace[175257884] 'agreement among raft nodes before linearized reading' (duration: 144.56424ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:00.191357Z","caller":"traceutil/trace.go:171","msg":"trace[332291747] transaction","detail":"{read_only:false; response_revision:26166; number_of_response:1; }","duration":"141.66827ms","start":"2026-08-11T12:08:00.049649Z","end":"2026-08-11T12:08:00.191318Z","steps":["trace[332291747] 'process raft request' (duration: 127.755058ms)","trace[332291747] 'compare' (duration: 13.680426ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:00.191515Z","caller":"traceutil/trace.go:171","msg":"trace[14979723] transaction","detail":"{read_only:false; response_revision:26167; number_of_response:1; }","duration":"138.865321ms","start":"2026-08-11T12:08:00.052609Z","end":"2026-08-11T12:08:00.191475Z","steps":["trace[14979723] 'process raft request' (duration: 138.665876ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:04.425701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.440435ms","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-08-11T12:08:04.425761Z","caller":"traceutil/trace.go:171","msg":"trace[686825998] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26198; }","duration":"214.526038ms","start":"2026-08-11T12:08:04.211221Z","end":"2026-08-11T12:08:04.425747Z","steps":["trace[686825998] 'range keys from in-memory index tree' (duration: 214.336533ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:04.426061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.893446ms","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-08-11T12:08:04.426118Z","caller":"traceutil/trace.go:171","msg":"trace[230954577] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26198; }","duration":"214.986079ms","start":"2026-08-11T12:08:04.211116Z","end":"2026-08-11T12:08:04.426102Z","steps":["trace[230954577] 'range keys from in-memory index tree' (duration: 214.681562ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:04.426414Z","caller":"traceutil/trace.go:171","msg":"trace[567143077] transaction","detail":"{read_only:false; response_revision:26199; number_of_response:1; }","duration":"108.571225ms","start":"2026-08-11T12:08:04.317832Z","end":"2026-08-11T12:08:04.426404Z","steps":["trace[567143077] 'process raft request' (duration: 92.44688ms)","trace[567143077] 'compare' (duration: 14.979327ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:04.621653Z","caller":"traceutil/trace.go:171","msg":"trace[19109241] linearizableReadLoop","detail":"{readStateIndex:27065; appliedIndex:27063; }","duration":"257.979835ms","start":"2026-08-11T12:08:04.363596Z","end":"2026-08-11T12:08:04.621576Z","steps":["trace[19109241] 'read index received' (duration: 46.797499ms)","trace[19109241] 'applied index is now lower than readState.Index' (duration: 211.181656ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:04.621818Z","caller":"traceutil/trace.go:171","msg":"trace[1977418688] transaction","detail":"{read_only:false; response_revision:26200; number_of_response:1; }","duration":"302.410516ms","start":"2026-08-11T12:08:04.3194Z","end":"2026-08-11T12:08:04.621811Z","steps":["trace[1977418688] 'process raft request' (duration: 217.44459ms)","trace[1977418688] 'compare' (duration: 84.532286ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:04.621969Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:04.319391Z","time spent":"302.449298ms","remote":"127.0.0.1:37706","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-08-11T12:08:04.622057Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.445256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/openstack/rook-ceph-pdbstatemap\" ","response":"range_response_count:1 size:357"} {"level":"info","ts":"2026-08-11T12:08:04.622157Z","caller":"traceutil/trace.go:171","msg":"trace[1630236299] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:26200; }","duration":"258.59358ms","start":"2026-08-11T12:08:04.363542Z","end":"2026-08-11T12:08:04.622135Z","steps":["trace[1630236299] 'agreement among raft nodes before linearized reading' (duration: 258.283742ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:04.664463Z","caller":"traceutil/trace.go:171","msg":"trace[797041338] transaction","detail":"{read_only:false; response_revision:26201; number_of_response:1; }","duration":"234.390656ms","start":"2026-08-11T12:08:04.430048Z","end":"2026-08-11T12:08:04.664439Z","steps":["trace[797041338] 'process raft request' (duration: 234.188321ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:04.664474Z","caller":"traceutil/trace.go:171","msg":"trace[1931354846] transaction","detail":"{read_only:false; response_revision:26202; number_of_response:1; }","duration":"234.233132ms","start":"2026-08-11T12:08:04.430222Z","end":"2026-08-11T12:08:04.664455Z","steps":["trace[1931354846] 'process raft request' (duration: 234.141ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:04.664513Z","caller":"traceutil/trace.go:171","msg":"trace[812395450] transaction","detail":"{read_only:false; response_revision:26203; number_of_response:1; }","duration":"223.713563ms","start":"2026-08-11T12:08:04.440777Z","end":"2026-08-11T12:08:04.66449Z","steps":["trace[812395450] 'process raft request' (duration: 223.629451ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:04.753635Z","caller":"traceutil/trace.go:171","msg":"trace[60184323] linearizableReadLoop","detail":"{readStateIndex:27069; appliedIndex:27065; }","duration":"131.896699ms","start":"2026-08-11T12:08:04.621714Z","end":"2026-08-11T12:08:04.753611Z","steps":["trace[60184323] 'read index received' (duration: 42.629746ms)","trace[60184323] 'applied index is now lower than readState.Index' (duration: 89.266153ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:04.753681Z","caller":"traceutil/trace.go:171","msg":"trace[749478501] transaction","detail":"{read_only:false; response_revision:26204; number_of_response:1; }","duration":"196.797963ms","start":"2026-08-11T12:08:04.556844Z","end":"2026-08-11T12:08:04.753642Z","steps":["trace[749478501] 'process raft request' (duration: 182.189144ms)","trace[749478501] 'compare' (duration: 14.454435ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:04.753795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.477605ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-11T12:08:04.753837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.185269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-11T12:08:04.753875Z","caller":"traceutil/trace.go:171","msg":"trace[508651551] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26204; }","duration":"297.284061ms","start":"2026-08-11T12:08:04.45658Z","end":"2026-08-11T12:08:04.753864Z","steps":["trace[508651551] 'agreement among raft nodes before linearized reading' (duration: 297.148488ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:04.753891Z","caller":"traceutil/trace.go:171","msg":"trace[1898721957] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:26204; }","duration":"196.642659ms","start":"2026-08-11T12:08:04.557221Z","end":"2026-08-11T12:08:04.753864Z","steps":["trace[1898721957] 'agreement among raft nodes before linearized reading' (duration: 196.453804ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:04.75395Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.862142ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:04.754052Z","caller":"traceutil/trace.go:171","msg":"trace[968533253] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26204; }","duration":"123.998305ms","start":"2026-08-11T12:08:04.630037Z","end":"2026-08-11T12:08:04.754035Z","steps":["trace[968533253] 'agreement among raft nodes before linearized reading' (duration: 123.7821ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:05.060948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.673123ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:05.061196Z","caller":"traceutil/trace.go:171","msg":"trace[1615327934] transaction","detail":"{read_only:false; response_revision:26206; number_of_response:1; }","duration":"300.784136ms","start":"2026-08-11T12:08:04.760387Z","end":"2026-08-11T12:08:05.061172Z","steps":["trace[1615327934] 'process raft request' (duration: 300.693874ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:05.061286Z","caller":"traceutil/trace.go:171","msg":"trace[689917923] transaction","detail":"{read_only:false; response_revision:26205; number_of_response:1; }","duration":"302.084628ms","start":"2026-08-11T12:08:04.759173Z","end":"2026-08-11T12:08:05.061258Z","steps":["trace[689917923] 'process raft request' (duration: 145.988815ms)","trace[689917923] 'compare' (duration: 155.507639ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:05.061311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:04.760368Z","time spent":"300.891209ms","remote":"127.0.0.1:37706","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-08-11T12:08:05.061404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:04.75914Z","time spent":"302.208331ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:05.366063Z","caller":"traceutil/trace.go:171","msg":"trace[1324732445] transaction","detail":"{read_only:false; response_revision:26207; number_of_response:1; }","duration":"395.919383ms","start":"2026-08-11T12:08:04.970122Z","end":"2026-08-11T12:08:05.366041Z","steps":["trace[1324732445] 'process raft request' (duration: 390.338246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:05.366212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:04.970099Z","time spent":"396.042667ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:05.366277Z","caller":"traceutil/trace.go:171","msg":"trace[1531627726] transaction","detail":"{read_only:false; response_revision:26208; number_of_response:1; }","duration":"394.383176ms","start":"2026-08-11T12:08:04.971827Z","end":"2026-08-11T12:08:05.36621Z","steps":["trace[1531627726] 'process raft request' (duration: 394.16206ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:05.366744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:04.971819Z","time spent":"394.818126ms","remote":"127.0.0.1:37706","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-08-11T12:08:05.375709Z","caller":"traceutil/trace.go:171","msg":"trace[1879012760] transaction","detail":"{read_only:false; response_revision:26209; number_of_response:1; }","duration":"325.721099ms","start":"2026-08-11T12:08:05.049963Z","end":"2026-08-11T12:08:05.375684Z","steps":["trace[1879012760] 'process raft request' (duration: 325.523884ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:05.375852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:05.049937Z","time spent":"325.843502ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:05.376199Z","caller":"traceutil/trace.go:171","msg":"trace[886364427] transaction","detail":"{read_only:false; response_revision:26210; number_of_response:1; }","duration":"144.14446ms","start":"2026-08-11T12:08:05.232035Z","end":"2026-08-11T12:08:05.376179Z","steps":["trace[886364427] 'process raft request' (duration: 143.592996ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:06.232881Z","caller":"traceutil/trace.go:171","msg":"trace[1108383150] linearizableReadLoop","detail":"{readStateIndex:27077; appliedIndex:27076; }","duration":"137.451195ms","start":"2026-08-11T12:08:06.095405Z","end":"2026-08-11T12:08:06.232856Z","steps":["trace[1108383150] 'read index received' (duration: 137.185009ms)","trace[1108383150] 'applied index is now lower than readState.Index' (duration: 265.336µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:06.233042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.612219ms","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-08-11T12:08:06.23308Z","caller":"traceutil/trace.go:171","msg":"trace[266984014] range","detail":"{range_begin:/registry/endpointslices/magnum-system/; range_end:/registry/endpointslices/magnum-system0; response_count:0; response_revision:26212; }","duration":"137.685171ms","start":"2026-08-11T12:08:06.095382Z","end":"2026-08-11T12:08:06.233067Z","steps":["trace[266984014] 'agreement among raft nodes before linearized reading' (duration: 137.580489ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:06.233449Z","caller":"traceutil/trace.go:171","msg":"trace[1273860967] transaction","detail":"{read_only:false; response_revision:26212; number_of_response:1; }","duration":"140.573442ms","start":"2026-08-11T12:08:06.092813Z","end":"2026-08-11T12:08:06.233386Z","steps":["trace[1273860967] 'process raft request' (duration: 139.883315ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:06.537753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.178791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.65\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-08-11T12:08:06.53784Z","caller":"traceutil/trace.go:171","msg":"trace[1430227991] range","detail":"{range_begin:/registry/masterleases/199.19.213.65; range_end:; response_count:1; response_revision:26212; }","duration":"199.313295ms","start":"2026-08-11T12:08:06.338505Z","end":"2026-08-11T12:08:06.537818Z","steps":["trace[1430227991] 'range keys from in-memory index tree' (duration: 198.969947ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:06.815212Z","caller":"traceutil/trace.go:171","msg":"trace[2018779375] transaction","detail":"{read_only:false; response_revision:26213; number_of_response:1; }","duration":"382.739949ms","start":"2026-08-11T12:08:06.432442Z","end":"2026-08-11T12:08:06.815182Z","steps":["trace[2018779375] 'process raft request' (duration: 382.526314ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:06.815388Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:06.432412Z","time spent":"382.890303ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:08:07.022743Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.82327ms","expected-duration":"100ms","prefix":"","request":"header: lease_grant:","response":"size:42"} {"level":"info","ts":"2026-08-11T12:08:07.023095Z","caller":"traceutil/trace.go:171","msg":"trace[440917396] linearizableReadLoop","detail":"{readStateIndex:27079; appliedIndex:27077; }","duration":"394.353594ms","start":"2026-08-11T12:08:06.628724Z","end":"2026-08-11T12:08:07.023078Z","steps":["trace[440917396] 'read index received' (duration: 186.367836ms)","trace[440917396] 'applied index is now lower than readState.Index' (duration: 207.984578ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:07.023204Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:06.539217Z","time spent":"483.984166ms","remote":"127.0.0.1:37458","response type":"/etcdserverpb.Lease/LeaseGrant","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"info","ts":"2026-08-11T12:08:07.02333Z","caller":"traceutil/trace.go:171","msg":"trace[484016130] transaction","detail":"{read_only:false; response_revision:26214; number_of_response:1; }","duration":"392.897379ms","start":"2026-08-11T12:08:06.630419Z","end":"2026-08-11T12:08:07.023317Z","steps":["trace[484016130] 'process raft request' (duration: 392.440797ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:07.023327Z","caller":"traceutil/trace.go:171","msg":"trace[1904854480] transaction","detail":"{read_only:false; response_revision:26216; number_of_response:1; }","duration":"264.561987ms","start":"2026-08-11T12:08:06.758736Z","end":"2026-08-11T12:08:07.023298Z","steps":["trace[1904854480] 'process raft request' (duration: 264.295181ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.023412Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:06.630391Z","time spent":"392.967321ms","remote":"127.0.0.1:37706","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-08-11T12:08:07.02352Z","caller":"traceutil/trace.go:171","msg":"trace[763337100] transaction","detail":"{read_only:false; response_revision:26215; number_of_response:1; }","duration":"353.723306ms","start":"2026-08-11T12:08:06.669791Z","end":"2026-08-11T12:08:07.023514Z","steps":["trace[763337100] 'process raft request' (duration: 353.197214ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.023551Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:06.669771Z","time spent":"353.761678ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:08:07.023543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.752961ms","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-08-11T12:08:07.023612Z","caller":"traceutil/trace.go:171","msg":"trace[1763062602] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26216; }","duration":"354.869785ms","start":"2026-08-11T12:08:06.668725Z","end":"2026-08-11T12:08:07.023595Z","steps":["trace[1763062602] 'agreement among raft nodes before linearized reading' (duration: 354.593508ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.023609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.889218ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-11T12:08:07.023659Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:06.668702Z","time spent":"354.948758ms","remote":"127.0.0.1:37706","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-08-11T12:08:07.023666Z","caller":"traceutil/trace.go:171","msg":"trace[589349491] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26216; }","duration":"394.984471ms","start":"2026-08-11T12:08:06.628666Z","end":"2026-08-11T12:08:07.023651Z","steps":["trace[589349491] 'agreement among raft nodes before linearized reading' (duration: 394.893928ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.023717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.924307ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:440"} {"level":"warn","ts":"2026-08-11T12:08:07.023709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:06.628644Z","time spent":"395.057222ms","remote":"127.0.0.1:37434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-08-11T12:08:07.023733Z","caller":"traceutil/trace.go:171","msg":"trace[856938302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26216; }","duration":"354.976718ms","start":"2026-08-11T12:08:06.668752Z","end":"2026-08-11T12:08:07.023728Z","steps":["trace[856938302] 'agreement among raft nodes before linearized reading' (duration: 354.888535ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.023746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:06.668731Z","time spent":"355.011849ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-08-11T12:08:07.221366Z","caller":"traceutil/trace.go:171","msg":"trace[1931244238] linearizableReadLoop","detail":"{readStateIndex:27083; appliedIndex:27082; }","duration":"196.044605ms","start":"2026-08-11T12:08:07.025292Z","end":"2026-08-11T12:08:07.221336Z","steps":["trace[1931244238] 'read index received' (duration: 153.90739ms)","trace[1931244238] 'applied index is now lower than readState.Index' (duration: 42.135915ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:07.2215Z","caller":"traceutil/trace.go:171","msg":"trace[1751826042] transaction","detail":"{read_only:false; response_revision:26217; number_of_response:1; }","duration":"197.51422ms","start":"2026-08-11T12:08:07.023971Z","end":"2026-08-11T12:08:07.221486Z","steps":["trace[1751826042] 'process raft request' (duration: 155.259222ms)","trace[1751826042] 'compare' (duration: 41.368467ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:07.221792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.486555ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:07.22183Z","caller":"traceutil/trace.go:171","msg":"trace[238223063] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26217; }","duration":"196.555477ms","start":"2026-08-11T12:08:07.025263Z","end":"2026-08-11T12:08:07.221819Z","steps":["trace[238223063] 'agreement among raft nodes before linearized reading' (duration: 196.446624ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:07.499521Z","caller":"traceutil/trace.go:171","msg":"trace[858981994] transaction","detail":"{read_only:false; response_revision:26222; number_of_response:1; }","duration":"118.697515ms","start":"2026-08-11T12:08:07.3808Z","end":"2026-08-11T12:08:07.499498Z","steps":["trace[858981994] 'process raft request' (duration: 118.598052ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:07.499899Z","caller":"traceutil/trace.go:171","msg":"trace[95305830] transaction","detail":"{read_only:false; response_revision:26218; number_of_response:1; }","duration":"472.74124ms","start":"2026-08-11T12:08:07.027144Z","end":"2026-08-11T12:08:07.499885Z","steps":["trace[95305830] 'process raft request' (duration: 421.132722ms)","trace[95305830] 'compare' (duration: 50.633233ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:07.500007Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:07.027132Z","time spent":"472.803071ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:07.500142Z","caller":"traceutil/trace.go:171","msg":"trace[691723166] transaction","detail":"{read_only:false; response_revision:26219; number_of_response:1; }","duration":"472.657548ms","start":"2026-08-11T12:08:07.027475Z","end":"2026-08-11T12:08:07.500132Z","steps":["trace[691723166] 'process raft request' (duration: 471.799076ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.500198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:07.027469Z","time spent":"472.700969ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:07.500318Z","caller":"traceutil/trace.go:171","msg":"trace[679542939] linearizableReadLoop","detail":"{readStateIndex:27085; appliedIndex:27083; }","duration":"278.864469ms","start":"2026-08-11T12:08:07.221444Z","end":"2026-08-11T12:08:07.500308Z","steps":["trace[679542939] 'read index received' (duration: 227.000665ms)","trace[679542939] 'applied index is now lower than readState.Index' (duration: 51.862514ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:07.500381Z","caller":"traceutil/trace.go:171","msg":"trace[1079013358] transaction","detail":"{read_only:false; response_revision:26220; number_of_response:1; }","duration":"128.552698ms","start":"2026-08-11T12:08:07.371819Z","end":"2026-08-11T12:08:07.500372Z","steps":["trace[1079013358] 'process raft request' (duration: 127.507911ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:07.500663Z","caller":"traceutil/trace.go:171","msg":"trace[250104487] transaction","detail":"{read_only:false; response_revision:26221; number_of_response:1; }","duration":"128.806163ms","start":"2026-08-11T12:08:07.37184Z","end":"2026-08-11T12:08:07.500646Z","steps":["trace[250104487] 'process raft request' (duration: 127.523611ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.501081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.029004ms","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-08-11T12:08:07.501127Z","caller":"traceutil/trace.go:171","msg":"trace[1708843645] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26222; }","duration":"435.100445ms","start":"2026-08-11T12:08:07.066015Z","end":"2026-08-11T12:08:07.501115Z","steps":["trace[1708843645] 'agreement among raft nodes before linearized reading' (duration: 434.959961ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.501158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:07.066002Z","time spent":"435.150957ms","remote":"127.0.0.1:37706","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-08-11T12:08:07.501244Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"435.374292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-11T12:08:07.50126Z","caller":"traceutil/trace.go:171","msg":"trace[210724304] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26222; }","duration":"435.435743ms","start":"2026-08-11T12:08:07.06582Z","end":"2026-08-11T12:08:07.501256Z","steps":["trace[210724304] 'agreement among raft nodes before linearized reading' (duration: 435.393932ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.501272Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:07.065795Z","time spent":"435.474154ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-11T12:08:07.662546Z","caller":"traceutil/trace.go:171","msg":"trace[1299181404] linearizableReadLoop","detail":"{readStateIndex:27089; appliedIndex:27088; }","duration":"162.171683ms","start":"2026-08-11T12:08:07.500344Z","end":"2026-08-11T12:08:07.662516Z","steps":["trace[1299181404] 'read index received' (duration: 124.022836ms)","trace[1299181404] 'applied index is now lower than readState.Index' (duration: 38.147407ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:07.662578Z","caller":"traceutil/trace.go:171","msg":"trace[74825075] transaction","detail":"{read_only:false; response_revision:26223; number_of_response:1; }","duration":"203.755234ms","start":"2026-08-11T12:08:07.458782Z","end":"2026-08-11T12:08:07.662538Z","steps":["trace[74825075] 'process raft request' (duration: 166.079479ms)","trace[74825075] 'compare' (duration: 37.44373ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:07.662653Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.380354ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/certificates/\" range_end:\"/registry/secretgen.k14s.io/certificates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:07.662722Z","caller":"traceutil/trace.go:171","msg":"trace[852504218] range","detail":"{range_begin:/registry/secretgen.k14s.io/certificates/; range_end:/registry/secretgen.k14s.io/certificates0; response_count:0; response_revision:26223; }","duration":"273.503337ms","start":"2026-08-11T12:08:07.389201Z","end":"2026-08-11T12:08:07.662704Z","steps":["trace[852504218] 'agreement among raft nodes before linearized reading' (duration: 273.370444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.662782Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.640193ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-11T12:08:07.662887Z","caller":"traceutil/trace.go:171","msg":"trace[1798584514] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:26223; }","duration":"436.692814ms","start":"2026-08-11T12:08:07.226127Z","end":"2026-08-11T12:08:07.66282Z","steps":["trace[1798584514] 'agreement among raft nodes before linearized reading' (duration: 436.51974ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.663122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:07.226061Z","time spent":"436.856339ms","remote":"127.0.0.1:37612","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":446,"request content":"key:\"/registry/services/endpoints/default/kubernetes\" "} {"level":"warn","ts":"2026-08-11T12:08:07.926205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.224423ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:07.926497Z","caller":"traceutil/trace.go:171","msg":"trace[475073863] linearizableReadLoop","detail":"{readStateIndex:27091; appliedIndex:27089; }","duration":"263.819049ms","start":"2026-08-11T12:08:07.662654Z","end":"2026-08-11T12:08:07.926473Z","steps":["trace[475073863] 'read index received' (duration: 130.215747ms)","trace[475073863] 'applied index is now lower than readState.Index' (duration: 133.601642ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:07.926831Z","caller":"traceutil/trace.go:171","msg":"trace[714537885] transaction","detail":"{read_only:false; response_revision:26224; number_of_response:1; }","duration":"416.15649ms","start":"2026-08-11T12:08:07.510659Z","end":"2026-08-11T12:08:07.926816Z","steps":["trace[714537885] 'process raft request' (duration: 282.21554ms)","trace[714537885] 'compare' (duration: 133.003917ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:07.926908Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:07.510619Z","time spent":"416.249242ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:07.92712Z","caller":"traceutil/trace.go:171","msg":"trace[1830022918] transaction","detail":"{read_only:false; response_revision:26225; number_of_response:1; }","duration":"416.426777ms","start":"2026-08-11T12:08:07.510681Z","end":"2026-08-11T12:08:07.927107Z","steps":["trace[1830022918] 'process raft request' (duration: 415.642768ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.927172Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:07.510661Z","time spent":"416.483918ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:08:07.927332Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.153987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:07.92736Z","caller":"traceutil/trace.go:171","msg":"trace[19267944] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26225; }","duration":"297.231509ms","start":"2026-08-11T12:08:07.630121Z","end":"2026-08-11T12:08:07.927352Z","steps":["trace[19267944] 'agreement among raft nodes before linearized reading' (duration: 297.176328ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:07.927619Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.767253ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-08-11T12:08:07.927675Z","caller":"traceutil/trace.go:171","msg":"trace[498003147] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:26225; }","duration":"262.848745ms","start":"2026-08-11T12:08:07.664815Z","end":"2026-08-11T12:08:07.927663Z","steps":["trace[498003147] 'agreement among raft nodes before linearized reading' (duration: 262.685431ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:08.673575Z","caller":"traceutil/trace.go:171","msg":"trace[1622885217] transaction","detail":"{read_only:false; response_revision:26227; number_of_response:1; }","duration":"205.537007ms","start":"2026-08-11T12:08:08.467972Z","end":"2026-08-11T12:08:08.673509Z","steps":["trace[1622885217] 'process raft request' (duration: 203.902648ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:08.99571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.667131ms","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-08-11T12:08:08.995797Z","caller":"traceutil/trace.go:171","msg":"trace[338964594] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26227; }","duration":"216.822615ms","start":"2026-08-11T12:08:08.778953Z","end":"2026-08-11T12:08:08.995775Z","steps":["trace[338964594] 'range keys from in-memory index tree' (duration: 216.438785ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:08.995818Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.667412ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:08.995924Z","caller":"traceutil/trace.go:171","msg":"trace[1612776443] transaction","detail":"{read_only:false; response_revision:26228; number_of_response:1; }","duration":"174.529027ms","start":"2026-08-11T12:08:08.821376Z","end":"2026-08-11T12:08:08.995905Z","steps":["trace[1612776443] 'process raft request' (duration: 36.694981ms)","trace[1612776443] 'compare' (duration: 137.348724ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:09.249585Z","caller":"traceutil/trace.go:171","msg":"trace[1905789726] transaction","detail":"{read_only:false; response_revision:26229; number_of_response:1; }","duration":"222.055593ms","start":"2026-08-11T12:08:09.027499Z","end":"2026-08-11T12:08:09.249554Z","steps":["trace[1905789726] 'process raft request' (duration: 221.262824ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:09.308022Z","caller":"traceutil/trace.go:171","msg":"trace[1293184981] transaction","detail":"{read_only:false; response_revision:26230; number_of_response:1; }","duration":"279.460083ms","start":"2026-08-11T12:08:09.028534Z","end":"2026-08-11T12:08:09.307994Z","steps":["trace[1293184981] 'process raft request' (duration: 279.203227ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:09.308016Z","caller":"traceutil/trace.go:171","msg":"trace[131959223] transaction","detail":"{read_only:false; response_revision:26231; number_of_response:1; }","duration":"279.359611ms","start":"2026-08-11T12:08:09.028642Z","end":"2026-08-11T12:08:09.308002Z","steps":["trace[131959223] 'process raft request' (duration: 279.255758ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:09.308217Z","caller":"traceutil/trace.go:171","msg":"trace[281702710] linearizableReadLoop","detail":"{readStateIndex:27097; appliedIndex:27094; }","duration":"236.101259ms","start":"2026-08-11T12:08:09.072069Z","end":"2026-08-11T12:08:09.30817Z","steps":["trace[281702710] 'read index received' (duration: 176.7103ms)","trace[281702710] 'applied index is now lower than readState.Index' (duration: 59.386849ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:09.308233Z","caller":"traceutil/trace.go:171","msg":"trace[149222075] transaction","detail":"{read_only:false; response_revision:26232; number_of_response:1; }","duration":"179.003026ms","start":"2026-08-11T12:08:09.129196Z","end":"2026-08-11T12:08:09.308199Z","steps":["trace[149222075] 'process raft request' (duration: 178.74319ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:09.308383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.296643ms","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-08-11T12:08:09.308425Z","caller":"traceutil/trace.go:171","msg":"trace[1474394403] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26232; }","duration":"236.382126ms","start":"2026-08-11T12:08:09.072028Z","end":"2026-08-11T12:08:09.30841Z","steps":["trace[1474394403] 'agreement among raft nodes before linearized reading' (duration: 236.277193ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:09.496269Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.195293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-08-11T12:08:09.496382Z","caller":"traceutil/trace.go:171","msg":"trace[2121664882] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:26232; }","duration":"118.337025ms","start":"2026-08-11T12:08:09.378003Z","end":"2026-08-11T12:08:09.49634Z","steps":["trace[2121664882] 'count revisions from in-memory index tree' (duration: 118.11474ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:09.631826Z","caller":"traceutil/trace.go:171","msg":"trace[478742920] transaction","detail":"{read_only:false; response_revision:26233; number_of_response:1; }","duration":"120.817348ms","start":"2026-08-11T12:08:09.510983Z","end":"2026-08-11T12:08:09.6318Z","steps":["trace[478742920] 'process raft request' (duration: 120.657924ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:09.937802Z","caller":"traceutil/trace.go:171","msg":"trace[652176075] linearizableReadLoop","detail":"{readStateIndex:27103; appliedIndex:27099; }","duration":"395.546384ms","start":"2026-08-11T12:08:09.542237Z","end":"2026-08-11T12:08:09.937784Z","steps":["trace[652176075] 'read index received' (duration: 89.659712ms)","trace[652176075] 'applied index is now lower than readState.Index' (duration: 305.885912ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:09.937902Z","caller":"traceutil/trace.go:171","msg":"trace[1345824778] transaction","detail":"{read_only:false; response_revision:26234; number_of_response:1; }","duration":"426.858754ms","start":"2026-08-11T12:08:09.511033Z","end":"2026-08-11T12:08:09.937891Z","steps":["trace[1345824778] 'process raft request' (duration: 380.275009ms)","trace[1345824778] 'compare' (duration: 46.107413ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:09.938001Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:09.511023Z","time spent":"426.904685ms","remote":"127.0.0.1:37706","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-08-11T12:08:09.938171Z","caller":"traceutil/trace.go:171","msg":"trace[1139657035] transaction","detail":"{read_only:false; response_revision:26235; number_of_response:1; }","duration":"427.011017ms","start":"2026-08-11T12:08:09.511151Z","end":"2026-08-11T12:08:09.938162Z","steps":["trace[1139657035] 'process raft request' (duration: 426.475554ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:09.938239Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:09.511144Z","time spent":"427.049268ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:09.93826Z","caller":"traceutil/trace.go:171","msg":"trace[1950148810] transaction","detail":"{read_only:false; response_revision:26237; number_of_response:1; }","duration":"423.855849ms","start":"2026-08-11T12:08:09.514365Z","end":"2026-08-11T12:08:09.938221Z","steps":["trace[1950148810] 'process raft request' (duration: 423.391657ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:09.938465Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:09.514323Z","time spent":"424.041153ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:09.93848Z","caller":"traceutil/trace.go:171","msg":"trace[948333551] transaction","detail":"{read_only:false; response_revision:26236; number_of_response:1; }","duration":"424.69134ms","start":"2026-08-11T12:08:09.513748Z","end":"2026-08-11T12:08:09.938439Z","steps":["trace[948333551] 'process raft request' (duration: 423.914521ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:09.938657Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:09.513729Z","time spent":"424.832054ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:08:09.93873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.292612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18352"} {"level":"info","ts":"2026-08-11T12:08:09.938889Z","caller":"traceutil/trace.go:171","msg":"trace[766111041] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:26237; }","duration":"396.60512ms","start":"2026-08-11T12:08:09.542201Z","end":"2026-08-11T12:08:09.938806Z","steps":["trace[766111041] 'agreement among raft nodes before linearized reading' (duration: 396.008055ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:09.938945Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:09.542185Z","time spent":"396.745003ms","remote":"127.0.0.1:37624","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":18376,"request content":"key:\"/registry/minions/instance\" "} {"level":"info","ts":"2026-08-11T12:08:09.944553Z","caller":"traceutil/trace.go:171","msg":"trace[1871212558] transaction","detail":"{read_only:false; response_revision:26238; number_of_response:1; }","duration":"276.07188ms","start":"2026-08-11T12:08:09.668433Z","end":"2026-08-11T12:08:09.944505Z","steps":["trace[1871212558] 'process raft request' (duration: 275.66242ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:10.114198Z","caller":"traceutil/trace.go:171","msg":"trace[1865187902] transaction","detail":"{read_only:false; response_revision:26239; number_of_response:1; }","duration":"158.058942ms","start":"2026-08-11T12:08:09.956104Z","end":"2026-08-11T12:08:10.114163Z","steps":["trace[1865187902] 'process raft request' (duration: 129.731107ms)","trace[1865187902] 'compare' (duration: 28.203402ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:10.557973Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.086297ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:10.558269Z","caller":"traceutil/trace.go:171","msg":"trace[1379022732] transaction","detail":"{read_only:false; response_revision:26242; number_of_response:1; }","duration":"178.037722ms","start":"2026-08-11T12:08:10.380215Z","end":"2026-08-11T12:08:10.558252Z","steps":["trace[1379022732] 'process raft request' (duration: 177.96326ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:10.558558Z","caller":"traceutil/trace.go:171","msg":"trace[457048692] transaction","detail":"{read_only:false; response_revision:26240; number_of_response:1; }","duration":"600.138298ms","start":"2026-08-11T12:08:09.958409Z","end":"2026-08-11T12:08:10.558547Z","steps":["trace[457048692] 'process raft request' (duration: 418.350204ms)","trace[457048692] 'compare' (duration: 180.680988ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:10.558638Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:09.958398Z","time spent":"600.184929ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:10.558681Z","caller":"traceutil/trace.go:171","msg":"trace[1398538612] transaction","detail":"{read_only:false; response_revision:26241; number_of_response:1; }","duration":"413.171026ms","start":"2026-08-11T12:08:10.145476Z","end":"2026-08-11T12:08:10.558647Z","steps":["trace[1398538612] 'process raft request' (duration: 412.619052ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:10.558862Z","caller":"traceutil/trace.go:171","msg":"trace[1260566325] linearizableReadLoop","detail":"{readStateIndex:27107; appliedIndex:27105; }","duration":"315.783845ms","start":"2026-08-11T12:08:10.243069Z","end":"2026-08-11T12:08:10.558853Z","steps":["trace[1260566325] 'read index received' (duration: 133.763366ms)","trace[1260566325] 'applied index is now lower than readState.Index' (duration: 182.019629ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:10.55905Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.97694ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:10.559071Z","caller":"traceutil/trace.go:171","msg":"trace[108631908] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:26242; }","duration":"316.045912ms","start":"2026-08-11T12:08:10.243018Z","end":"2026-08-11T12:08:10.559064Z","steps":["trace[108631908] 'agreement among raft nodes before linearized reading' (duration: 315.97232ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:10.559093Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:10.242998Z","time spent":"316.089333ms","remote":"127.0.0.1:37506","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":30,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-08-11T12:08:10.559225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.915234ms","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-08-11T12:08:10.559341Z","caller":"traceutil/trace.go:171","msg":"trace[1856276015] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26242; }","duration":"214.075858ms","start":"2026-08-11T12:08:10.345236Z","end":"2026-08-11T12:08:10.559312Z","steps":["trace[1856276015] 'agreement among raft nodes before linearized reading' (duration: 213.804871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:10.559429Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:10.145451Z","time spent":"413.3349ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:08:10.81394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.637705ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:10.814057Z","caller":"traceutil/trace.go:171","msg":"trace[1118627800] linearizableReadLoop","detail":"{readStateIndex:27109; appliedIndex:27108; }","duration":"183.716632ms","start":"2026-08-11T12:08:10.630323Z","end":"2026-08-11T12:08:10.814039Z","steps":["trace[1118627800] 'read index received' (duration: 33.77709ms)","trace[1118627800] 'applied index is now lower than readState.Index' (duration: 149.938312ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:10.814123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.811374ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:10.814197Z","caller":"traceutil/trace.go:171","msg":"trace[1827194565] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26243; }","duration":"183.883476ms","start":"2026-08-11T12:08:10.630302Z","end":"2026-08-11T12:08:10.814186Z","steps":["trace[1827194565] 'agreement among raft nodes before linearized reading' (duration: 183.784374ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:10.814464Z","caller":"traceutil/trace.go:171","msg":"trace[143945381] transaction","detail":"{read_only:false; response_revision:26243; number_of_response:1; }","duration":"250.598124ms","start":"2026-08-11T12:08:10.563853Z","end":"2026-08-11T12:08:10.814451Z","steps":["trace[143945381] 'process raft request' (duration: 100.347904ms)","trace[143945381] 'compare' (duration: 149.504011ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:11.122438Z","caller":"traceutil/trace.go:171","msg":"trace[432660113] transaction","detail":"{read_only:false; response_revision:26244; number_of_response:1; }","duration":"120.688703ms","start":"2026-08-11T12:08:11.001725Z","end":"2026-08-11T12:08:11.122413Z","steps":["trace[432660113] 'process raft request' (duration: 21.471976ms)","trace[432660113] 'compare' (duration: 98.770516ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:16.07064Z","caller":"traceutil/trace.go:171","msg":"trace[1277608856] linearizableReadLoop","detail":"{readStateIndex:27148; appliedIndex:27147; }","duration":"441.443982ms","start":"2026-08-11T12:08:15.629167Z","end":"2026-08-11T12:08:16.070611Z","steps":["trace[1277608856] 'read index received' (duration: 441.336979ms)","trace[1277608856] 'applied index is now lower than readState.Index' (duration: 106.043µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:16.070759Z","caller":"traceutil/trace.go:171","msg":"trace[1660999639] transaction","detail":"{read_only:false; response_revision:26281; number_of_response:1; }","duration":"505.343689ms","start":"2026-08-11T12:08:15.565341Z","end":"2026-08-11T12:08:16.070685Z","steps":["trace[1660999639] 'process raft request' (duration: 505.091773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.070807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.628406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:16.070868Z","caller":"traceutil/trace.go:171","msg":"trace[216762235] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26281; }","duration":"441.739068ms","start":"2026-08-11T12:08:15.629114Z","end":"2026-08-11T12:08:16.070853Z","steps":["trace[216762235] 'agreement among raft nodes before linearized reading' (duration: 441.631136ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.070902Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.629092Z","time spent":"441.80181ms","remote":"127.0.0.1:37434","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":30,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-11T12:08:16.071109Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.565317Z","time spent":"505.541015ms","remote":"127.0.0.1:37706","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-08-11T12:08:16.290653Z","caller":"traceutil/trace.go:171","msg":"trace[925255243] transaction","detail":"{read_only:false; response_revision:26282; number_of_response:1; }","duration":"625.715197ms","start":"2026-08-11T12:08:15.664906Z","end":"2026-08-11T12:08:16.290621Z","steps":["trace[925255243] 'process raft request' (duration: 623.317518ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:16.290722Z","caller":"traceutil/trace.go:171","msg":"trace[1015464103] transaction","detail":"{read_only:false; response_revision:26283; number_of_response:1; }","duration":"333.270165ms","start":"2026-08-11T12:08:15.957422Z","end":"2026-08-11T12:08:16.290693Z","steps":["trace[1015464103] 'process raft request' (duration: 333.075299ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.290803Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.664882Z","time spent":"625.83564ms","remote":"127.0.0.1:37706","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-08-11T12:08:16.290918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.957392Z","time spent":"333.426999ms","remote":"127.0.0.1:37706","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-08-11T12:08:16.290947Z","caller":"traceutil/trace.go:171","msg":"trace[656101148] transaction","detail":"{read_only:false; response_revision:26284; number_of_response:1; }","duration":"333.346797ms","start":"2026-08-11T12:08:15.957558Z","end":"2026-08-11T12:08:16.290905Z","steps":["trace[656101148] 'process raft request' (duration: 333.05347ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:16.291137Z","caller":"traceutil/trace.go:171","msg":"trace[1357606930] linearizableReadLoop","detail":"{readStateIndex:27152; appliedIndex:27148; }","duration":"220.405643ms","start":"2026-08-11T12:08:16.070721Z","end":"2026-08-11T12:08:16.291127Z","steps":["trace[1357606930] 'read index received' (duration: 217.511582ms)","trace[1357606930] 'applied index is now lower than readState.Index' (duration: 2.892701ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:16.291248Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.957523Z","time spent":"333.595102ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:08:16.291321Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.781889ms","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-08-11T12:08:16.291354Z","caller":"traceutil/trace.go:171","msg":"trace[2134236209] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:26285; }","duration":"318.838361ms","start":"2026-08-11T12:08:15.972507Z","end":"2026-08-11T12:08:16.291346Z","steps":["trace[2134236209] 'agreement among raft nodes before linearized reading' (duration: 318.719168ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.291385Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.972498Z","time spent":"318.880921ms","remote":"127.0.0.1:44146","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":23,"response size":32,"request content":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true "} {"level":"warn","ts":"2026-08-11T12:08:16.291613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.128734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-11T12:08:16.291657Z","caller":"traceutil/trace.go:171","msg":"trace[854216562] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:26285; }","duration":"329.191625ms","start":"2026-08-11T12:08:15.962458Z","end":"2026-08-11T12:08:16.29165Z","steps":["trace[854216562] 'agreement among raft nodes before linearized reading' (duration: 329.056672ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:16.291649Z","caller":"traceutil/trace.go:171","msg":"trace[1014175525] transaction","detail":"{read_only:false; response_revision:26285; number_of_response:1; }","duration":"332.22369ms","start":"2026-08-11T12:08:15.959407Z","end":"2026-08-11T12:08:16.29163Z","steps":["trace[1014175525] 'process raft request' (duration: 331.42355ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.291676Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.962451Z","time spent":"329.221546ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-11T12:08:16.29176Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.959389Z","time spent":"332.313531ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-11T12:08:16.291767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.752916ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:16.291831Z","caller":"traceutil/trace.go:171","msg":"trace[1506335335] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26285; }","duration":"219.843089ms","start":"2026-08-11T12:08:16.071971Z","end":"2026-08-11T12:08:16.291814Z","steps":["trace[1506335335] 'agreement among raft nodes before linearized reading' (duration: 219.680915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.2918Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.575717ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/\" range_end:\"/registry/deployments/openstack0\" ","response":"range_response_count:32 size:272999"} {"level":"warn","ts":"2026-08-11T12:08:16.291865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"631.499908ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:16.291898Z","caller":"traceutil/trace.go:171","msg":"trace[1683913886] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:26285; }","duration":"631.56372ms","start":"2026-08-11T12:08:15.660326Z","end":"2026-08-11T12:08:16.291889Z","steps":["trace[1683913886] 'agreement among raft nodes before linearized reading' (duration: 631.508908ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.291864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.624995ms","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-08-11T12:08:16.291913Z","caller":"traceutil/trace.go:171","msg":"trace[657532587] range","detail":"{range_begin:/registry/deployments/openstack/; range_end:/registry/deployments/openstack0; response_count:32; response_revision:26285; }","duration":"242.710861ms","start":"2026-08-11T12:08:16.049176Z","end":"2026-08-11T12:08:16.291887Z","steps":["trace[657532587] 'agreement among raft nodes before linearized reading' (duration: 242.009204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.291889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.979142ms","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-08-11T12:08:16.291974Z","caller":"traceutil/trace.go:171","msg":"trace[1622505099] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26285; }","duration":"329.749368ms","start":"2026-08-11T12:08:15.962201Z","end":"2026-08-11T12:08:16.29195Z","steps":["trace[1622505099] 'agreement among raft nodes before linearized reading' (duration: 329.449961ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:16.292004Z","caller":"traceutil/trace.go:171","msg":"trace[1696316920] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26285; }","duration":"154.173926ms","start":"2026-08-11T12:08:16.137805Z","end":"2026-08-11T12:08:16.291979Z","steps":["trace[1696316920] 'agreement among raft nodes before linearized reading' (duration: 153.870949ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.292036Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.962158Z","time spent":"329.867891ms","remote":"127.0.0.1:37706","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-08-11T12:08:16.291926Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:15.660308Z","time spent":"631.612721ms","remote":"127.0.0.1:58522","response type":"/etcdserverpb.KV/Range","request count":0,"request size":90,"response count":0,"response size":30,"request content":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true "} {"level":"info","ts":"2026-08-11T12:08:16.623583Z","caller":"traceutil/trace.go:171","msg":"trace[1622370139] transaction","detail":"{read_only:false; response_revision:26286; number_of_response:1; }","duration":"326.854687ms","start":"2026-08-11T12:08:16.296706Z","end":"2026-08-11T12:08:16.623561Z","steps":["trace[1622370139] 'process raft request' (duration: 326.334414ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.623722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:16.296679Z","time spent":"326.973589ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:16.924143Z","caller":"traceutil/trace.go:171","msg":"trace[725786542] transaction","detail":"{read_only:false; response_revision:26287; number_of_response:1; }","duration":"625.626815ms","start":"2026-08-11T12:08:16.298486Z","end":"2026-08-11T12:08:16.924113Z","steps":["trace[725786542] 'process raft request' (duration: 601.216116ms)","trace[725786542] 'compare' (duration: 24.094562ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:16.924308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:16.298469Z","time spent":"625.754248ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:16.924334Z","caller":"traceutil/trace.go:171","msg":"trace[1446346842] linearizableReadLoop","detail":"{readStateIndex:27155; appliedIndex:27152; }","duration":"625.285406ms","start":"2026-08-11T12:08:16.299024Z","end":"2026-08-11T12:08:16.924309Z","steps":["trace[1446346842] 'read index received' (duration: 324.11745ms)","trace[1446346842] 'applied index is now lower than readState.Index' (duration: 301.166436ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:16.924431Z","caller":"traceutil/trace.go:171","msg":"trace[1238782278] transaction","detail":"{read_only:false; response_revision:26288; number_of_response:1; }","duration":"625.83997ms","start":"2026-08-11T12:08:16.29856Z","end":"2026-08-11T12:08:16.9244Z","steps":["trace[1238782278] 'process raft request' (duration: 625.501202ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.92452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"625.46562ms","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":"warn","ts":"2026-08-11T12:08:16.924569Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:16.298545Z","time spent":"625.942812ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:16.924578Z","caller":"traceutil/trace.go:171","msg":"trace[560304978] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:26288; }","duration":"625.576223ms","start":"2026-08-11T12:08:16.298984Z","end":"2026-08-11T12:08:16.92456Z","steps":["trace[560304978] 'agreement among raft nodes before linearized reading' (duration: 625.43561ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.924618Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:16.298973Z","time spent":"625.635994ms","remote":"127.0.0.1:37636","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":30,"request content":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" "} {"level":"warn","ts":"2026-08-11T12:08:16.924597Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.47628ms","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-08-11T12:08:16.9247Z","caller":"traceutil/trace.go:171","msg":"trace[157998401] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:26288; }","duration":"118.649024ms","start":"2026-08-11T12:08:16.80602Z","end":"2026-08-11T12:08:16.924669Z","steps":["trace[157998401] 'agreement among raft nodes before linearized reading' (duration: 118.440519ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.92472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"585.12408ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.65\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-08-11T12:08:16.924826Z","caller":"traceutil/trace.go:171","msg":"trace[1859766859] range","detail":"{range_begin:/registry/masterleases/199.19.213.65; range_end:; response_count:1; response_revision:26288; }","duration":"585.290864ms","start":"2026-08-11T12:08:16.339508Z","end":"2026-08-11T12:08:16.924799Z","steps":["trace[1859766859] 'agreement among raft nodes before linearized reading' (duration: 584.956096ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.924893Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:16.339485Z","time spent":"585.392426ms","remote":"127.0.0.1:37458","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":161,"request content":"key:\"/registry/masterleases/199.19.213.65\" "} {"level":"warn","ts":"2026-08-11T12:08:16.925025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.984884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:16.925054Z","caller":"traceutil/trace.go:171","msg":"trace[7331513] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26288; }","duration":"295.043735ms","start":"2026-08-11T12:08:16.630001Z","end":"2026-08-11T12:08:16.925045Z","steps":["trace[7331513] 'agreement among raft nodes before linearized reading' (duration: 294.965793ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.925115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.932893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-11T12:08:16.925161Z","caller":"traceutil/trace.go:171","msg":"trace[2047247766] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26288; }","duration":"341.013295ms","start":"2026-08-11T12:08:16.584134Z","end":"2026-08-11T12:08:16.925148Z","steps":["trace[2047247766] 'agreement among raft nodes before linearized reading' (duration: 340.841551ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:16.925197Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:16.584113Z","time spent":"341.076176ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":533,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-08-11T12:08:24.492643Z","caller":"traceutil/trace.go:171","msg":"trace[566360881] transaction","detail":"{read_only:false; response_revision:26400; number_of_response:1; }","duration":"171.530552ms","start":"2026-08-11T12:08:24.321088Z","end":"2026-08-11T12:08:24.492619Z","steps":["trace[566360881] 'process raft request' (duration: 171.45001ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:24.492674Z","caller":"traceutil/trace.go:171","msg":"trace[1052424207] transaction","detail":"{read_only:false; response_revision:26399; number_of_response:1; }","duration":"171.84813ms","start":"2026-08-11T12:08:24.320799Z","end":"2026-08-11T12:08:24.492647Z","steps":["trace[1052424207] 'process raft request' (duration: 171.682296ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:24.492754Z","caller":"traceutil/trace.go:171","msg":"trace[556033012] linearizableReadLoop","detail":"{readStateIndex:27270; appliedIndex:27266; }","duration":"131.190191ms","start":"2026-08-11T12:08:24.361553Z","end":"2026-08-11T12:08:24.492743Z","steps":["trace[556033012] 'read index received' (duration: 130.643658ms)","trace[556033012] 'applied index is now lower than readState.Index' (duration: 544.803µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:24.492655Z","caller":"traceutil/trace.go:171","msg":"trace[1941023433] transaction","detail":"{read_only:false; response_revision:26398; number_of_response:1; }","duration":"174.310431ms","start":"2026-08-11T12:08:24.318308Z","end":"2026-08-11T12:08:24.492619Z","steps":["trace[1941023433] 'process raft request' (duration: 173.974143ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:24.49283Z","caller":"traceutil/trace.go:171","msg":"trace[1898269176] transaction","detail":"{read_only:false; response_revision:26401; number_of_response:1; }","duration":"168.450397ms","start":"2026-08-11T12:08:24.324373Z","end":"2026-08-11T12:08:24.492823Z","steps":["trace[1898269176] 'process raft request' (duration: 168.206971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:24.492928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.336214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-11T12:08:24.492954Z","caller":"traceutil/trace.go:171","msg":"trace[1178566912] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:26401; }","duration":"131.444038ms","start":"2026-08-11T12:08:24.361502Z","end":"2026-08-11T12:08:24.492946Z","steps":["trace[1178566912] 'agreement among raft nodes before linearized reading' (duration: 131.285103ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:24.751771Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.96742ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:24.751852Z","caller":"traceutil/trace.go:171","msg":"trace[502589112] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26401; }","duration":"123.094293ms","start":"2026-08-11T12:08:24.628739Z","end":"2026-08-11T12:08:24.751833Z","steps":["trace[502589112] 'range keys from in-memory index tree' (duration: 122.894468ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:24.752227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.334059ms","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-08-11T12:08:24.752353Z","caller":"traceutil/trace.go:171","msg":"trace[1059588317] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:26401; }","duration":"137.057776ms","start":"2026-08-11T12:08:24.615269Z","end":"2026-08-11T12:08:24.752327Z","steps":["trace[1059588317] 'range keys from in-memory index tree' (duration: 136.219855ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:24.990331Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.723568ms","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-08-11T12:08:24.990438Z","caller":"traceutil/trace.go:171","msg":"trace[726962503] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26402; }","duration":"136.883382ms","start":"2026-08-11T12:08:24.853537Z","end":"2026-08-11T12:08:24.990421Z","steps":["trace[726962503] 'range keys from in-memory index tree' (duration: 136.554724ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:25.212783Z","caller":"traceutil/trace.go:171","msg":"trace[2087741397] transaction","detail":"{read_only:false; response_revision:26405; number_of_response:1; }","duration":"217.07247ms","start":"2026-08-11T12:08:24.995675Z","end":"2026-08-11T12:08:25.212747Z","steps":["trace[2087741397] 'process raft request' (duration: 216.992898ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:25.212852Z","caller":"traceutil/trace.go:171","msg":"trace[806735177] transaction","detail":"{read_only:false; response_revision:26404; number_of_response:1; }","duration":"217.377438ms","start":"2026-08-11T12:08:24.995438Z","end":"2026-08-11T12:08:25.212815Z","steps":["trace[806735177] 'process raft request' (duration: 217.012179ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:25.21296Z","caller":"traceutil/trace.go:171","msg":"trace[2044481353] linearizableReadLoop","detail":"{readStateIndex:27275; appliedIndex:27271; }","duration":"208.287866ms","start":"2026-08-11T12:08:25.004647Z","end":"2026-08-11T12:08:25.212935Z","steps":["trace[2044481353] 'read index received' (duration: 6.724016ms)","trace[2044481353] 'applied index is now lower than readState.Index' (duration: 201.56161ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:25.2131Z","caller":"traceutil/trace.go:171","msg":"trace[58800917] transaction","detail":"{read_only:false; response_revision:26406; number_of_response:1; }","duration":"217.178194ms","start":"2026-08-11T12:08:24.995906Z","end":"2026-08-11T12:08:25.213084Z","steps":["trace[58800917] 'process raft request' (duration: 216.802784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:25.213368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.866158ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:1 size:3309"} {"level":"warn","ts":"2026-08-11T12:08:25.213363Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.666995ms","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":"warn","ts":"2026-08-11T12:08:25.213385Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.446888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-535db4c3-451b-4cb9-ab1c-7c5ba6bf5ef2\" ","response":"range_response_count:1 size:3757"} {"level":"info","ts":"2026-08-11T12:08:25.21343Z","caller":"traceutil/trace.go:171","msg":"trace[1896023260] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:1; response_revision:26406; }","duration":"143.001382ms","start":"2026-08-11T12:08:25.070412Z","end":"2026-08-11T12:08:25.213413Z","steps":["trace[1896023260] 'agreement among raft nodes before linearized reading' (duration: 142.670174ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:25.213475Z","caller":"traceutil/trace.go:171","msg":"trace[1834177338] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:26406; }","duration":"208.810058ms","start":"2026-08-11T12:08:25.004634Z","end":"2026-08-11T12:08:25.213444Z","steps":["trace[1834177338] 'agreement among raft nodes before linearized reading' (duration: 208.445809ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:25.213484Z","caller":"traceutil/trace.go:171","msg":"trace[662564003] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-535db4c3-451b-4cb9-ab1c-7c5ba6bf5ef2; range_end:; response_count:1; response_revision:26406; }","duration":"109.604281ms","start":"2026-08-11T12:08:25.103854Z","end":"2026-08-11T12:08:25.213459Z","steps":["trace[662564003] 'agreement among raft nodes before linearized reading' (duration: 109.277854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:25.402941Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.141685ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:25.403245Z","caller":"traceutil/trace.go:171","msg":"trace[1218121635] transaction","detail":"{read_only:false; response_revision:26407; number_of_response:1; }","duration":"171.514622ms","start":"2026-08-11T12:08:25.231699Z","end":"2026-08-11T12:08:25.403213Z","steps":["trace[1218121635] 'process raft request' (duration: 27.985297ms)","trace[1218121635] 'compare' (duration: 142.838778ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:25.403282Z","caller":"traceutil/trace.go:171","msg":"trace[1741583536] transaction","detail":"{read_only:false; response_revision:26408; number_of_response:1; }","duration":"142.043738ms","start":"2026-08-11T12:08:25.261209Z","end":"2026-08-11T12:08:25.403252Z","steps":["trace[1741583536] 'process raft request' (duration: 141.883704ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:25.403645Z","caller":"traceutil/trace.go:171","msg":"trace[907799] linearizableReadLoop","detail":"{readStateIndex:27276; appliedIndex:27275; }","duration":"169.954924ms","start":"2026-08-11T12:08:25.233676Z","end":"2026-08-11T12:08:25.403631Z","steps":["trace[907799] 'read index received' (duration: 25.930786ms)","trace[907799] 'applied index is now lower than readState.Index' (duration: 144.022578ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:25.40382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.129959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/openstack/rabbitmq-manila-server\" ","response":"range_response_count:1 size:9604"} {"level":"info","ts":"2026-08-11T12:08:25.403866Z","caller":"traceutil/trace.go:171","msg":"trace[287636406] range","detail":"{range_begin:/registry/statefulsets/openstack/rabbitmq-manila-server; range_end:; response_count:1; response_revision:26408; }","duration":"170.21391ms","start":"2026-08-11T12:08:25.233641Z","end":"2026-08-11T12:08:25.403855Z","steps":["trace[287636406] 'agreement among raft nodes before linearized reading' (duration: 170.043526ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:25.563613Z","caller":"traceutil/trace.go:171","msg":"trace[621425851] transaction","detail":"{read_only:false; response_revision:26412; number_of_response:1; }","duration":"104.677881ms","start":"2026-08-11T12:08:25.458899Z","end":"2026-08-11T12:08:25.563577Z","steps":["trace[621425851] 'process raft request' (duration: 103.174354ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:27.414488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.232974ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:27.414641Z","caller":"traceutil/trace.go:171","msg":"trace[1911964708] transaction","detail":"{read_only:false; response_revision:26426; number_of_response:1; }","duration":"193.41293ms","start":"2026-08-11T12:08:27.221205Z","end":"2026-08-11T12:08:27.414618Z","steps":["trace[1911964708] 'process raft request' (duration: 76.93937ms)","trace[1911964708] 'compare' (duration: 116.0648ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:27.425909Z","caller":"traceutil/trace.go:171","msg":"trace[1085657069] linearizableReadLoop","detail":"{readStateIndex:27297; appliedIndex:27295; }","duration":"201.644252ms","start":"2026-08-11T12:08:27.224237Z","end":"2026-08-11T12:08:27.425882Z","steps":["trace[1085657069] 'read index received' (duration: 73.970118ms)","trace[1085657069] 'applied index is now lower than readState.Index' (duration: 127.673034ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:27.426029Z","caller":"traceutil/trace.go:171","msg":"trace[1709064019] transaction","detail":"{read_only:false; response_revision:26428; number_of_response:1; }","duration":"200.877864ms","start":"2026-08-11T12:08:27.225105Z","end":"2026-08-11T12:08:27.425983Z","steps":["trace[1709064019] 'process raft request' (duration: 200.723429ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:27.426111Z","caller":"traceutil/trace.go:171","msg":"trace[723047666] transaction","detail":"{read_only:false; response_revision:26427; number_of_response:1; }","duration":"204.043142ms","start":"2026-08-11T12:08:27.22205Z","end":"2026-08-11T12:08:27.426093Z","steps":["trace[723047666] 'process raft request' (duration: 203.60442ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:27.42616Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.899249ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-535db4c3-451b-4cb9-ab1c-7c5ba6bf5ef2\" ","response":"range_response_count:1 size:3943"} {"level":"info","ts":"2026-08-11T12:08:27.426232Z","caller":"traceutil/trace.go:171","msg":"trace[1268644289] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-535db4c3-451b-4cb9-ab1c-7c5ba6bf5ef2; range_end:; response_count:1; response_revision:26428; }","duration":"202.043482ms","start":"2026-08-11T12:08:27.22417Z","end":"2026-08-11T12:08:27.426214Z","steps":["trace[1268644289] 'agreement among raft nodes before linearized reading' (duration: 201.829317ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:30.79941Z","caller":"traceutil/trace.go:171","msg":"trace[409196205] transaction","detail":"{read_only:false; response_revision:26464; number_of_response:1; }","duration":"287.07472ms","start":"2026-08-11T12:08:30.512309Z","end":"2026-08-11T12:08:30.799383Z","steps":["trace[409196205] 'process raft request' (duration: 286.835684ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:30.799743Z","caller":"traceutil/trace.go:171","msg":"trace[541020615] transaction","detail":"{read_only:false; response_revision:26465; number_of_response:1; }","duration":"283.993304ms","start":"2026-08-11T12:08:30.515694Z","end":"2026-08-11T12:08:30.799687Z","steps":["trace[541020615] 'process raft request' (duration: 283.637076ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:30.799761Z","caller":"traceutil/trace.go:171","msg":"trace[1689415657] linearizableReadLoop","detail":"{readStateIndex:27337; appliedIndex:27334; }","duration":"171.701766ms","start":"2026-08-11T12:08:30.628027Z","end":"2026-08-11T12:08:30.799729Z","steps":["trace[1689415657] 'read index received' (duration: 171.100922ms)","trace[1689415657] 'applied index is now lower than readState.Index' (duration: 599.834µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:30.799807Z","caller":"traceutil/trace.go:171","msg":"trace[901822298] transaction","detail":"{read_only:false; response_revision:26466; number_of_response:1; }","duration":"284.025436ms","start":"2026-08-11T12:08:30.515755Z","end":"2026-08-11T12:08:30.799781Z","steps":["trace[901822298] 'process raft request' (duration: 283.847041ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:30.799938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.884781ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:30.799975Z","caller":"traceutil/trace.go:171","msg":"trace[198438614] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26466; }","duration":"171.971202ms","start":"2026-08-11T12:08:30.627991Z","end":"2026-08-11T12:08:30.799963Z","steps":["trace[198438614] 'agreement among raft nodes before linearized reading' (duration: 171.87947ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:30.814012Z","caller":"traceutil/trace.go:171","msg":"trace[816109141] transaction","detail":"{read_only:false; response_revision:26467; number_of_response:1; }","duration":"120.711434ms","start":"2026-08-11T12:08:30.693276Z","end":"2026-08-11T12:08:30.813987Z","steps":["trace[816109141] 'process raft request' (duration: 120.305555ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:30.814194Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.564498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:30.814261Z","caller":"traceutil/trace.go:171","msg":"trace[2004469909] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:26467; }","duration":"135.697212ms","start":"2026-08-11T12:08:30.678549Z","end":"2026-08-11T12:08:30.814247Z","steps":["trace[2004469909] 'agreement among raft nodes before linearized reading' (duration: 135.514487ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:31.094166Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.283649ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:31.094311Z","caller":"traceutil/trace.go:171","msg":"trace[1900198500] transaction","detail":"{read_only:false; response_revision:26468; number_of_response:1; }","duration":"217.532282ms","start":"2026-08-11T12:08:30.876753Z","end":"2026-08-11T12:08:31.094286Z","steps":["trace[1900198500] 'process raft request' (duration: 74.004438ms)","trace[1900198500] 'compare' (duration: 143.109014ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:31.165788Z","caller":"traceutil/trace.go:171","msg":"trace[618424650] transaction","detail":"{read_only:false; response_revision:26469; number_of_response:1; }","duration":"143.308049ms","start":"2026-08-11T12:08:31.022459Z","end":"2026-08-11T12:08:31.165767Z","steps":["trace[618424650] 'process raft request' (duration: 143.034442ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:31.16571Z","caller":"traceutil/trace.go:171","msg":"trace[713843514] linearizableReadLoop","detail":"{readStateIndex:27340; appliedIndex:27339; }","duration":"128.910495ms","start":"2026-08-11T12:08:31.036772Z","end":"2026-08-11T12:08:31.165683Z","steps":["trace[713843514] 'read index received' (duration: 128.741901ms)","trace[713843514] 'applied index is now lower than readState.Index' (duration: 167.714µs)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:31.166313Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.524112ms","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-08-11T12:08:31.166382Z","caller":"traceutil/trace.go:171","msg":"trace[1921586563] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26469; }","duration":"129.655335ms","start":"2026-08-11T12:08:31.036714Z","end":"2026-08-11T12:08:31.16637Z","steps":["trace[1921586563] 'agreement among raft nodes before linearized reading' (duration: 129.295006ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:55.708507Z","caller":"traceutil/trace.go:171","msg":"trace[764878949] transaction","detail":"{read_only:false; response_revision:26669; number_of_response:1; }","duration":"165.022392ms","start":"2026-08-11T12:08:55.543454Z","end":"2026-08-11T12:08:55.708476Z","steps":["trace[764878949] 'process raft request' (duration: 94.875729ms)","trace[764878949] 'compare' (duration: 69.894857ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:55.708969Z","caller":"traceutil/trace.go:171","msg":"trace[1387535303] transaction","detail":"{read_only:false; response_revision:26670; number_of_response:1; }","duration":"153.663133ms","start":"2026-08-11T12:08:55.555292Z","end":"2026-08-11T12:08:55.708955Z","steps":["trace[1387535303] 'process raft request' (duration: 153.12908ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:55.708961Z","caller":"traceutil/trace.go:171","msg":"trace[433983752] linearizableReadLoop","detail":"{readStateIndex:27546; appliedIndex:27544; }","duration":"161.324103ms","start":"2026-08-11T12:08:55.547604Z","end":"2026-08-11T12:08:55.708928Z","steps":["trace[433983752] 'read index received' (duration: 27.042495ms)","trace[433983752] 'applied index is now lower than readState.Index' (duration: 134.279988ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:55.709043Z","caller":"traceutil/trace.go:171","msg":"trace[858693601] transaction","detail":"{read_only:false; response_revision:26671; number_of_response:1; }","duration":"150.604688ms","start":"2026-08-11T12:08:55.55839Z","end":"2026-08-11T12:08:55.708995Z","steps":["trace[858693601] 'process raft request' (duration: 150.340482ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:55.709318Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.221105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:08:55.709383Z","caller":"traceutil/trace.go:171","msg":"trace[1852232022] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:26671; }","duration":"116.360428ms","start":"2026-08-11T12:08:55.593001Z","end":"2026-08-11T12:08:55.709362Z","steps":["trace[1852232022] 'agreement among raft nodes before linearized reading' (duration: 116.250766ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:55.709408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.238888ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"warn","ts":"2026-08-11T12:08:55.709386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.742893ms","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-08-11T12:08:55.709478Z","caller":"traceutil/trace.go:171","msg":"trace[1995346492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26671; }","duration":"154.402852ms","start":"2026-08-11T12:08:55.555059Z","end":"2026-08-11T12:08:55.709461Z","steps":["trace[1995346492] 'agreement among raft nodes before linearized reading' (duration: 154.147516ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:55.709509Z","caller":"traceutil/trace.go:171","msg":"trace[172777232] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26671; }","duration":"161.883606ms","start":"2026-08-11T12:08:55.547598Z","end":"2026-08-11T12:08:55.709481Z","steps":["trace[172777232] 'agreement among raft nodes before linearized reading' (duration: 161.542638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:55.709632Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.786604ms","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-08-11T12:08:55.709672Z","caller":"traceutil/trace.go:171","msg":"trace[723870133] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26671; }","duration":"148.843986ms","start":"2026-08-11T12:08:55.560816Z","end":"2026-08-11T12:08:55.70966Z","steps":["trace[723870133] 'agreement among raft nodes before linearized reading' (duration: 148.755963ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:55.938733Z","caller":"traceutil/trace.go:171","msg":"trace[1462398749] linearizableReadLoop","detail":"{readStateIndex:27550; appliedIndex:27548; }","duration":"222.847653ms","start":"2026-08-11T12:08:55.715858Z","end":"2026-08-11T12:08:55.938706Z","steps":["trace[1462398749] 'read index received' (duration: 145.591445ms)","trace[1462398749] 'applied index is now lower than readState.Index' (duration: 77.254778ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:55.939005Z","caller":"traceutil/trace.go:171","msg":"trace[1123060464] transaction","detail":"{read_only:false; response_revision:26672; number_of_response:1; }","duration":"225.048988ms","start":"2026-08-11T12:08:55.713944Z","end":"2026-08-11T12:08:55.938993Z","steps":["trace[1123060464] 'process raft request' (duration: 147.476362ms)","trace[1123060464] 'compare' (duration: 76.897518ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:55.939178Z","caller":"traceutil/trace.go:171","msg":"trace[1887831183] transaction","detail":"{read_only:false; response_revision:26673; number_of_response:1; }","duration":"223.802406ms","start":"2026-08-11T12:08:55.715365Z","end":"2026-08-11T12:08:55.939167Z","steps":["trace[1887831183] 'process raft request' (duration: 223.201351ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:55.939263Z","caller":"traceutil/trace.go:171","msg":"trace[1373488552] transaction","detail":"{read_only:false; response_revision:26674; number_of_response:1; }","duration":"222.768181ms","start":"2026-08-11T12:08:55.716487Z","end":"2026-08-11T12:08:55.939255Z","steps":["trace[1373488552] 'process raft request' (duration: 222.132746ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:55.939452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.571221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/openstack/rabbitmq-manila-default-user\" ","response":"range_response_count:1 size:1312"} {"level":"info","ts":"2026-08-11T12:08:55.939481Z","caller":"traceutil/trace.go:171","msg":"trace[894343834] range","detail":"{range_begin:/registry/secrets/openstack/rabbitmq-manila-default-user; range_end:; response_count:1; response_revision:26674; }","duration":"223.640582ms","start":"2026-08-11T12:08:55.715833Z","end":"2026-08-11T12:08:55.939474Z","steps":["trace[894343834] 'agreement among raft nodes before linearized reading' (duration: 223.502689ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:55.939795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.525595ms","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-08-11T12:08:55.939894Z","caller":"traceutil/trace.go:171","msg":"trace[372512400] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:26674; }","duration":"156.719589ms","start":"2026-08-11T12:08:55.783151Z","end":"2026-08-11T12:08:55.939871Z","steps":["trace[372512400] 'agreement among raft nodes before linearized reading' (duration: 156.414001ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:56.552155Z","caller":"traceutil/trace.go:171","msg":"trace[1274916580] linearizableReadLoop","detail":"{readStateIndex:27554; appliedIndex:27553; }","duration":"210.809847ms","start":"2026-08-11T12:08:56.341285Z","end":"2026-08-11T12:08:56.552095Z","steps":["trace[1274916580] 'read index received' (duration: 153.96254ms)","trace[1274916580] 'applied index is now lower than readState.Index' (duration: 56.845427ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:56.552465Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.161447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.65\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-08-11T12:08:56.552517Z","caller":"traceutil/trace.go:171","msg":"trace[1329966682] transaction","detail":"{read_only:false; response_revision:26677; number_of_response:1; }","duration":"323.024294ms","start":"2026-08-11T12:08:56.229465Z","end":"2026-08-11T12:08:56.55249Z","steps":["trace[1329966682] 'process raft request' (duration: 265.813698ms)","trace[1329966682] 'compare' (duration: 56.394545ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:56.552534Z","caller":"traceutil/trace.go:171","msg":"trace[861029344] range","detail":"{range_begin:/registry/masterleases/199.19.213.65; range_end:; response_count:1; response_revision:26677; }","duration":"211.27795ms","start":"2026-08-11T12:08:56.341238Z","end":"2026-08-11T12:08:56.552516Z","steps":["trace[861029344] 'agreement among raft nodes before linearized reading' (duration: 211.009073ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:56.552669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:08:56.229436Z","time spent":"323.146766ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":627,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:08:56.865898Z","caller":"traceutil/trace.go:171","msg":"trace[911293817] transaction","detail":"{read_only:false; response_revision:26679; number_of_response:1; }","duration":"193.41712ms","start":"2026-08-11T12:08:56.67244Z","end":"2026-08-11T12:08:56.865857Z","steps":["trace[911293817] 'process raft request' (duration: 109.813016ms)","trace[911293817] 'compare' (duration: 83.374097ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:57.041873Z","caller":"traceutil/trace.go:171","msg":"trace[1883780600] transaction","detail":"{read_only:false; response_revision:26681; number_of_response:1; }","duration":"105.45146ms","start":"2026-08-11T12:08:56.936392Z","end":"2026-08-11T12:08:57.041843Z","steps":["trace[1883780600] 'process raft request' (duration: 32.763965ms)","trace[1883780600] 'compare' (duration: 72.438299ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:57.267312Z","caller":"traceutil/trace.go:171","msg":"trace[867559667] transaction","detail":"{read_only:false; response_revision:26683; number_of_response:1; }","duration":"108.353272ms","start":"2026-08-11T12:08:57.158932Z","end":"2026-08-11T12:08:57.267285Z","steps":["trace[867559667] 'process raft request' (duration: 108.167567ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:57.457725Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.914782ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:57.457869Z","caller":"traceutil/trace.go:171","msg":"trace[200126767] linearizableReadLoop","detail":"{readStateIndex:27562; appliedIndex:27561; }","duration":"137.309742ms","start":"2026-08-11T12:08:57.320534Z","end":"2026-08-11T12:08:57.457844Z","steps":["trace[200126767] 'read index received' (duration: 7.101194ms)","trace[200126767] 'applied index is now lower than readState.Index' (duration: 130.206988ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:57.457933Z","caller":"traceutil/trace.go:171","msg":"trace[809944433] transaction","detail":"{read_only:false; response_revision:26684; number_of_response:1; }","duration":"186.184923ms","start":"2026-08-11T12:08:57.27169Z","end":"2026-08-11T12:08:57.457875Z","steps":["trace[809944433] 'process raft request' (duration: 56.002865ms)","trace[809944433] 'compare' (duration: 129.713087ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:57.458099Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.557428ms","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-08-11T12:08:57.458159Z","caller":"traceutil/trace.go:171","msg":"trace[117818360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:26684; }","duration":"137.645571ms","start":"2026-08-11T12:08:57.320497Z","end":"2026-08-11T12:08:57.458143Z","steps":["trace[117818360] 'agreement among raft nodes before linearized reading' (duration: 137.412735ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:57.680476Z","caller":"traceutil/trace.go:171","msg":"trace[893435112] transaction","detail":"{read_only:false; response_revision:26686; number_of_response:1; }","duration":"100.022346ms","start":"2026-08-11T12:08:57.580418Z","end":"2026-08-11T12:08:57.68044Z","steps":["trace[893435112] 'process raft request' (duration: 30.641153ms)","trace[893435112] 'compare' (duration: 68.87791ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:57.902742Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.71278ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:57.902987Z","caller":"traceutil/trace.go:171","msg":"trace[408933496] transaction","detail":"{read_only:false; response_revision:26688; number_of_response:1; }","duration":"186.758307ms","start":"2026-08-11T12:08:57.716184Z","end":"2026-08-11T12:08:57.902942Z","steps":["trace[408933496] 'process raft request' (duration: 66.718559ms)","trace[408933496] 'compare' (duration: 119.531326ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:57.9034Z","caller":"traceutil/trace.go:171","msg":"trace[1515660347] transaction","detail":"{read_only:false; response_revision:26689; number_of_response:1; }","duration":"184.562703ms","start":"2026-08-11T12:08:57.718813Z","end":"2026-08-11T12:08:57.903376Z","steps":["trace[1515660347] 'process raft request' (duration: 184.074741ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:58.07853Z","caller":"traceutil/trace.go:171","msg":"trace[1406254873] linearizableReadLoop","detail":"{readStateIndex:27569; appliedIndex:27567; }","duration":"125.85254ms","start":"2026-08-11T12:08:57.952636Z","end":"2026-08-11T12:08:58.078489Z","steps":["trace[1406254873] 'read index received' (duration: 42.609596ms)","trace[1406254873] 'applied index is now lower than readState.Index' (duration: 83.241084ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:58.078543Z","caller":"traceutil/trace.go:171","msg":"trace[982402462] transaction","detail":"{read_only:false; response_revision:26691; number_of_response:1; }","duration":"128.528585ms","start":"2026-08-11T12:08:57.949979Z","end":"2026-08-11T12:08:58.078507Z","steps":["trace[982402462] 'process raft request' (duration: 70.777748ms)","trace[982402462] 'compare' (duration: 57.46647ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:08:58.078785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.141388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-11T12:08:58.078873Z","caller":"traceutil/trace.go:171","msg":"trace[2093236629] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:26691; }","duration":"126.293633ms","start":"2026-08-11T12:08:57.952568Z","end":"2026-08-11T12:08:58.078861Z","steps":["trace[2093236629] 'agreement among raft nodes before linearized reading' (duration: 126.067466ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:58.327594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.878722ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:08:58.327842Z","caller":"traceutil/trace.go:171","msg":"trace[1407779766] transaction","detail":"{read_only:false; response_revision:26692; number_of_response:1; }","duration":"246.529214ms","start":"2026-08-11T12:08:58.081274Z","end":"2026-08-11T12:08:58.327804Z","steps":["trace[1407779766] 'process raft request' (duration: 133.335545ms)","trace[1407779766] 'compare' (duration: 112.467222ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:58.32787Z","caller":"traceutil/trace.go:171","msg":"trace[205297924] transaction","detail":"{read_only:false; response_revision:26693; number_of_response:1; }","duration":"245.270143ms","start":"2026-08-11T12:08:58.08258Z","end":"2026-08-11T12:08:58.32785Z","steps":["trace[205297924] 'process raft request' (duration: 245.127519ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:59.075549Z","caller":"traceutil/trace.go:171","msg":"trace[319434637] linearizableReadLoop","detail":"{readStateIndex:27574; appliedIndex:27573; }","duration":"105.595312ms","start":"2026-08-11T12:08:58.969932Z","end":"2026-08-11T12:08:59.075528Z","steps":["trace[319434637] 'read index received' (duration: 105.48778ms)","trace[319434637] 'applied index is now lower than readState.Index' (duration: 106.652µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:59.075634Z","caller":"traceutil/trace.go:171","msg":"trace[1550607353] transaction","detail":"{read_only:false; response_revision:26696; number_of_response:1; }","duration":"130.566836ms","start":"2026-08-11T12:08:58.945024Z","end":"2026-08-11T12:08:59.075591Z","steps":["trace[1550607353] 'process raft request' (duration: 130.33383ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:08:59.075764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.847638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-08-11T12:08:59.075788Z","caller":"traceutil/trace.go:171","msg":"trace[1232282085] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:26696; }","duration":"105.934621ms","start":"2026-08-11T12:08:58.969846Z","end":"2026-08-11T12:08:59.07578Z","steps":["trace[1232282085] 'agreement among raft nodes before linearized reading' (duration: 105.793167ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:08:59.629914Z","caller":"traceutil/trace.go:171","msg":"trace[27031467] transaction","detail":"{read_only:false; response_revision:26700; number_of_response:1; }","duration":"140.956591ms","start":"2026-08-11T12:08:59.488921Z","end":"2026-08-11T12:08:59.629877Z","steps":["trace[27031467] 'process raft request' (duration: 75.34643ms)","trace[27031467] 'compare' (duration: 65.245332ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:59.838061Z","caller":"traceutil/trace.go:171","msg":"trace[2117398015] transaction","detail":"{read_only:false; response_revision:26701; number_of_response:1; }","duration":"149.02697ms","start":"2026-08-11T12:08:59.688996Z","end":"2026-08-11T12:08:59.838022Z","steps":["trace[2117398015] 'process raft request' (duration: 86.921975ms)","trace[2117398015] 'compare' (duration: 61.954741ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:08:59.907508Z","caller":"traceutil/trace.go:171","msg":"trace[1811904144] transaction","detail":"{read_only:false; response_revision:26702; number_of_response:1; }","duration":"142.612152ms","start":"2026-08-11T12:08:59.764855Z","end":"2026-08-11T12:08:59.907467Z","steps":["trace[1811904144] 'process raft request' (duration: 142.327986ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:09:00.118315Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.014432ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:09:00.11852Z","caller":"traceutil/trace.go:171","msg":"trace[422113901] linearizableReadLoop","detail":"{readStateIndex:27582; appliedIndex:27580; }","duration":"194.506158ms","start":"2026-08-11T12:08:59.923996Z","end":"2026-08-11T12:09:00.118502Z","steps":["trace[422113901] 'read index received' (duration: 40.310511ms)","trace[422113901] 'applied index is now lower than readState.Index' (duration: 154.194457ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:09:00.118602Z","caller":"traceutil/trace.go:171","msg":"trace[667028182] transaction","detail":"{read_only:false; response_revision:26703; number_of_response:1; }","duration":"209.624708ms","start":"2026-08-11T12:08:59.908969Z","end":"2026-08-11T12:09:00.118594Z","steps":["trace[667028182] 'process raft request' (duration: 55.229386ms)","trace[667028182] 'compare' (duration: 153.872649ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:09:00.118936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.288945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0\" ","response":"range_response_count:1 size:1634"} {"level":"info","ts":"2026-08-11T12:09:00.118909Z","caller":"traceutil/trace.go:171","msg":"trace[218469351] transaction","detail":"{read_only:false; response_revision:26704; number_of_response:1; }","duration":"209.642559ms","start":"2026-08-11T12:08:59.90923Z","end":"2026-08-11T12:09:00.118872Z","steps":["trace[218469351] 'process raft request' (duration: 209.223148ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:00.118966Z","caller":"traceutil/trace.go:171","msg":"trace[939713323] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/valkey-data-valkey-node-0; range_end:; response_count:1; response_revision:26704; }","duration":"186.345787ms","start":"2026-08-11T12:08:59.932611Z","end":"2026-08-11T12:09:00.118957Z","steps":["trace[939713323] 'agreement among raft nodes before linearized reading' (duration: 186.200663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:09:00.119167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.880705ms","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-08-11T12:09:00.119251Z","caller":"traceutil/trace.go:171","msg":"trace[789192477] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26704; }","duration":"118.224143ms","start":"2026-08-11T12:09:00.001003Z","end":"2026-08-11T12:09:00.119227Z","steps":["trace[789192477] 'agreement among raft nodes before linearized reading' (duration: 117.905876ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:09:00.119681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.669735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:09:00.119773Z","caller":"traceutil/trace.go:171","msg":"trace[459077832] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:26704; }","duration":"195.83444ms","start":"2026-08-11T12:08:59.923916Z","end":"2026-08-11T12:09:00.11975Z","steps":["trace[459077832] 'agreement among raft nodes before linearized reading' (duration: 194.686392ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:00.257779Z","caller":"traceutil/trace.go:171","msg":"trace[209195531] transaction","detail":"{read_only:false; response_revision:26706; number_of_response:1; }","duration":"131.236092ms","start":"2026-08-11T12:09:00.126481Z","end":"2026-08-11T12:09:00.257717Z","steps":["trace[209195531] 'process raft request' (duration: 113.085036ms)","trace[209195531] 'compare' (duration: 17.91656ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:09:00.50479Z","caller":"traceutil/trace.go:171","msg":"trace[857661390] transaction","detail":"{read_only:false; response_revision:26707; number_of_response:1; }","duration":"170.2058ms","start":"2026-08-11T12:09:00.334548Z","end":"2026-08-11T12:09:00.504754Z","steps":["trace[857661390] 'process raft request' (duration: 149.792548ms)","trace[857661390] 'compare' (duration: 20.279438ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:09:11.082472Z","caller":"traceutil/trace.go:171","msg":"trace[2052240659] linearizableReadLoop","detail":"{readStateIndex:27671; appliedIndex:27670; }","duration":"198.886525ms","start":"2026-08-11T12:09:10.883557Z","end":"2026-08-11T12:09:11.082443Z","steps":["trace[2052240659] 'read index received' (duration: 198.654229ms)","trace[2052240659] 'applied index is now lower than readState.Index' (duration: 230.976µs)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:09:11.082553Z","caller":"traceutil/trace.go:171","msg":"trace[949014251] transaction","detail":"{read_only:false; response_revision:26791; number_of_response:1; }","duration":"310.169466ms","start":"2026-08-11T12:09:10.772338Z","end":"2026-08-11T12:09:11.082507Z","steps":["trace[949014251] 'process raft request' (duration: 309.89257ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:09:11.082702Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"199.09771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-11T12:09:11.082748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-11T12:09:10.772296Z","time spent":"310.33945ms","remote":"127.0.0.1:37706","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":42,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-11T12:09:11.082805Z","caller":"traceutil/trace.go:171","msg":"trace[1517821751] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:26791; }","duration":"199.272235ms","start":"2026-08-11T12:09:10.883508Z","end":"2026-08-11T12:09:11.08278Z","steps":["trace[1517821751] 'agreement among raft nodes before linearized reading' (duration: 199.048989ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:11.104221Z","caller":"traceutil/trace.go:171","msg":"trace[1519615477] transaction","detail":"{read_only:false; response_revision:26792; number_of_response:1; }","duration":"150.037364ms","start":"2026-08-11T12:09:10.954159Z","end":"2026-08-11T12:09:11.104196Z","steps":["trace[1519615477] 'process raft request' (duration: 149.772398ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:09:11.104452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.711975ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:9"} {"level":"info","ts":"2026-08-11T12:09:11.10458Z","caller":"traceutil/trace.go:171","msg":"trace[1206338451] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:26792; }","duration":"105.90798ms","start":"2026-08-11T12:09:10.998645Z","end":"2026-08-11T12:09:11.104553Z","steps":["trace[1206338451] 'agreement among raft nodes before linearized reading' (duration: 105.50902ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:11.296931Z","caller":"traceutil/trace.go:171","msg":"trace[190982997] transaction","detail":"{read_only:false; response_revision:26793; number_of_response:1; }","duration":"121.744489ms","start":"2026-08-11T12:09:11.175161Z","end":"2026-08-11T12:09:11.296906Z","steps":["trace[190982997] 'process raft request' (duration: 39.599722ms)","trace[190982997] 'compare' (duration: 81.567103ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:09:11.368051Z","caller":"traceutil/trace.go:171","msg":"trace[758308551] transaction","detail":"{read_only:false; response_revision:26795; number_of_response:1; }","duration":"136.728157ms","start":"2026-08-11T12:09:11.23129Z","end":"2026-08-11T12:09:11.368018Z","steps":["trace[758308551] 'process raft request' (duration: 136.308437ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:11.368399Z","caller":"traceutil/trace.go:171","msg":"trace[881797219] transaction","detail":"{read_only:false; response_revision:26796; number_of_response:1; }","duration":"134.083181ms","start":"2026-08-11T12:09:11.234241Z","end":"2026-08-11T12:09:11.368324Z","steps":["trace[881797219] 'process raft request' (duration: 133.656451ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:11.368418Z","caller":"traceutil/trace.go:171","msg":"trace[900204006] transaction","detail":"{read_only:false; response_revision:26797; number_of_response:1; }","duration":"113.808564ms","start":"2026-08-11T12:09:11.254571Z","end":"2026-08-11T12:09:11.36838Z","steps":["trace[900204006] 'process raft request' (duration: 113.65548ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:22.022701Z","caller":"traceutil/trace.go:171","msg":"trace[2140718541] transaction","detail":"{read_only:false; response_revision:26873; number_of_response:1; }","duration":"110.216087ms","start":"2026-08-11T12:09:21.912455Z","end":"2026-08-11T12:09:22.022671Z","steps":["trace[2140718541] 'process raft request' (duration: 109.55706ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:09:22.500568Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.215748ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-11T12:09:22.500675Z","caller":"traceutil/trace.go:171","msg":"trace[512432367] linearizableReadLoop","detail":"{readStateIndex:27759; appliedIndex:27758; }","duration":"201.713913ms","start":"2026-08-11T12:09:22.298944Z","end":"2026-08-11T12:09:22.500658Z","steps":["trace[512432367] 'read index received' (duration: 73.29473ms)","trace[512432367] 'applied index is now lower than readState.Index' (duration: 128.416763ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:09:22.500762Z","caller":"traceutil/trace.go:171","msg":"trace[2119911941] transaction","detail":"{read_only:false; response_revision:26876; number_of_response:1; }","duration":"296.091312ms","start":"2026-08-11T12:09:22.20466Z","end":"2026-08-11T12:09:22.500751Z","steps":["trace[2119911941] 'process raft request' (duration: 167.607027ms)","trace[2119911941] 'compare' (duration: 127.974942ms)"],"step_count":2} {"level":"warn","ts":"2026-08-11T12:09:22.50107Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.203935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-08-11T12:09:22.50113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.189456ms","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-08-11T12:09:22.501165Z","caller":"traceutil/trace.go:171","msg":"trace[1377944600] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:26876; }","duration":"202.263718ms","start":"2026-08-11T12:09:22.298889Z","end":"2026-08-11T12:09:22.501153Z","steps":["trace[1377944600] 'agreement among raft nodes before linearized reading' (duration: 202.159675ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:22.501149Z","caller":"traceutil/trace.go:171","msg":"trace[1630216495] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:26876; }","duration":"136.325149ms","start":"2026-08-11T12:09:22.364811Z","end":"2026-08-11T12:09:22.501136Z","steps":["trace[1630216495] 'agreement among raft nodes before linearized reading' (duration: 136.115703ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:22.71548Z","caller":"traceutil/trace.go:171","msg":"trace[421179417] transaction","detail":"{read_only:false; response_revision:26877; number_of_response:1; }","duration":"209.67584ms","start":"2026-08-11T12:09:22.505786Z","end":"2026-08-11T12:09:22.715462Z","steps":["trace[421179417] 'process raft request' (duration: 209.556307ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:22.737976Z","caller":"traceutil/trace.go:171","msg":"trace[636977857] transaction","detail":"{read_only:false; response_revision:26878; number_of_response:1; }","duration":"230.706655ms","start":"2026-08-11T12:09:22.507243Z","end":"2026-08-11T12:09:22.73795Z","steps":["trace[636977857] 'process raft request' (duration: 230.51728ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:22.738142Z","caller":"traceutil/trace.go:171","msg":"trace[206030232] linearizableReadLoop","detail":"{readStateIndex:27762; appliedIndex:27759; }","duration":"110.535885ms","start":"2026-08-11T12:09:22.627572Z","end":"2026-08-11T12:09:22.738108Z","steps":["trace[206030232] 'read index received' (duration: 87.758106ms)","trace[206030232] 'applied index is now lower than readState.Index' (duration: 22.775019ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:09:22.738283Z","caller":"traceutil/trace.go:171","msg":"trace[1854983150] transaction","detail":"{read_only:false; response_revision:26879; number_of_response:1; }","duration":"199.610862ms","start":"2026-08-11T12:09:22.538639Z","end":"2026-08-11T12:09:22.73825Z","steps":["trace[1854983150] 'process raft request' (duration: 199.271284ms)"],"step_count":1} {"level":"warn","ts":"2026-08-11T12:09:22.738572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.962525ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-11T12:09:22.738685Z","caller":"traceutil/trace.go:171","msg":"trace[1892418552] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:26879; }","duration":"111.119339ms","start":"2026-08-11T12:09:22.627531Z","end":"2026-08-11T12:09:22.738651Z","steps":["trace[1892418552] 'agreement among raft nodes before linearized reading' (duration: 110.778401ms)"],"step_count":1} {"level":"info","ts":"2026-08-11T12:09:22.966651Z","caller":"traceutil/trace.go:171","msg":"trace[403255599] transaction","detail":"{read_only:false; response_revision:26880; number_of_response:1; }","duration":"223.763195ms","start":"2026-08-11T12:09:22.74286Z","end":"2026-08-11T12:09:22.966624Z","steps":["trace[403255599] 'process raft request' (duration: 134.059792ms)","trace[403255599] 'compare' (duration: 89.57872ms)"],"step_count":2} {"level":"info","ts":"2026-08-11T12:11:13.042375Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25173} {"level":"info","ts":"2026-08-11T12:11:13.199534Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25173,"took":"152.076389ms","hash":73867829,"current-db-size-bytes":59875328,"current-db-size":"60 MB","current-db-size-in-use-bytes":37593088,"current-db-size-in-use":"38 MB"} {"level":"info","ts":"2026-08-11T12:11:13.19959Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":73867829,"revision":25173,"compact-revision":21973} {"level":"info","ts":"2026-08-11T12:12:55.711703Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a071a454a8148542","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-11T12:12:55.717115Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-08-11T12:12:55.717234Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-08-11T12:16:13.052165Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28007} {"level":"info","ts":"2026-08-11T12:16:13.189902Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28007,"took":"133.820222ms","hash":1100893096,"current-db-size-bytes":59875328,"current-db-size":"60 MB","current-db-size-in-use-bytes":35164160,"current-db-size-in-use":"35 MB"} {"level":"info","ts":"2026-08-11T12:16:13.189972Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1100893096,"revision":28007,"compact-revision":25173} {"level":"info","ts":"2026-08-11T12:21:13.058829Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30608} {"level":"info","ts":"2026-08-11T12:21:13.196312Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30608,"took":"133.184574ms","hash":355247370,"current-db-size-bytes":59875328,"current-db-size":"60 MB","current-db-size-in-use-bytes":32129024,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-11T12:21:13.196392Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":355247370,"revision":30608,"compact-revision":28007} {"level":"info","ts":"2026-08-11T12:26:13.065395Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":32863} {"level":"info","ts":"2026-08-11T12:26:13.215584Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":32863,"took":"146.45179ms","hash":3663485025,"current-db-size-bytes":60919808,"current-db-size":"61 MB","current-db-size-in-use-bytes":31789056,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-11T12:26:13.215649Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3663485025,"revision":32863,"compact-revision":30608} {"level":"info","ts":"2026-08-11T12:31:13.070354Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35097} {"level":"info","ts":"2026-08-11T12:31:13.224232Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35097,"took":"149.108505ms","hash":690731364,"current-db-size-bytes":60919808,"current-db-size":"61 MB","current-db-size-in-use-bytes":31768576,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-11T12:31:13.224294Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":690731364,"revision":35097,"compact-revision":32863} {"level":"info","ts":"2026-08-11T12:34:17.092804Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"a071a454a8148542","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-11T12:34:17.102464Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-08-11T12:34:17.102588Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-08-11T12:36:13.076401Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37397} {"level":"info","ts":"2026-08-11T12:36:13.190881Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37397,"took":"110.605181ms","hash":573079675,"current-db-size-bytes":60919808,"current-db-size":"61 MB","current-db-size-in-use-bytes":32772096,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-08-11T12:36:13.190941Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":573079675,"revision":37397,"compact-revision":35097} {"level":"info","ts":"2026-08-11T12:41:13.08888Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":39675} {"level":"info","ts":"2026-08-11T12:41:13.222958Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":39675,"took":"130.834456ms","hash":2307904255,"current-db-size-bytes":60919808,"current-db-size":"61 MB","current-db-size-in-use-bytes":32296960,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-11T12:41:13.223027Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2307904255,"revision":39675,"compact-revision":37397}