{"level":"warn","ts":"2026-08-26T07:03:04.392819Z","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-26T07:03:04.392946Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.175: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://162.253.55.175:2380","--initial-cluster=instance=https://162.253.55.175:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.175:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.175: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-26T07:03:04.393059Z","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-26T07:03:04.393084Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.175:2380"]} {"level":"info","ts":"2026-08-26T07:03:04.393113Z","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-26T07:03:04.39428Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.175:2379"]} {"level":"info","ts":"2026-08-26T07:03:04.394424Z","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://162.253.55.175:2380"],"listen-peer-urls":["https://162.253.55.175:2380"],"advertise-client-urls":["https://162.253.55.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.175: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-26T07:03:04.399258Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.402883ms"} {"level":"info","ts":"2026-08-26T07:03:04.405421Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5420a740f4813dc9","cluster-id":"5ecb181dc9675400"} {"level":"info","ts":"2026-08-26T07:03:04.405525Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 switched to configuration voters=()"} {"level":"info","ts":"2026-08-26T07:03:04.405561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became follower at term 0"} {"level":"info","ts":"2026-08-26T07:03:04.40559Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5420a740f4813dc9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-26T07:03:04.405605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became follower at term 1"} {"level":"info","ts":"2026-08-26T07:03:04.405669Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 switched to configuration voters=(6062028995862543817)"} {"level":"warn","ts":"2026-08-26T07:03:04.418284Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-26T07:03:04.420077Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-26T07:03:04.421696Z","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-26T07:03:04.425071Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5420a740f4813dc9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-26T07:03:04.425237Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5420a740f4813dc9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-26T07:03:04.425347Z","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-26T07:03:04.425382Z","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-26T07:03:04.425391Z","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-26T07:03:04.426233Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 switched to configuration voters=(6062028995862543817)"} {"level":"info","ts":"2026-08-26T07:03:04.427883Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"5ecb181dc9675400","local-member-id":"5420a740f4813dc9","added-peer-id":"5420a740f4813dc9","added-peer-peer-urls":["https://162.253.55.175:2380"]} {"level":"info","ts":"2026-08-26T07:03:04.430634Z","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-26T07:03:04.430742Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.175:2380"} {"level":"info","ts":"2026-08-26T07:03:04.430793Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.175:2380"} {"level":"info","ts":"2026-08-26T07:03:04.431018Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5420a740f4813dc9","initial-advertise-peer-urls":["https://162.253.55.175:2380"],"listen-peer-urls":["https://162.253.55.175:2380"],"advertise-client-urls":["https://162.253.55.175:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.175:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-26T07:03:04.431105Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-26T07:03:05.006305Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 is starting a new election at term 1"} {"level":"info","ts":"2026-08-26T07:03:05.006386Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became pre-candidate at term 1"} {"level":"info","ts":"2026-08-26T07:03:05.00643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 received MsgPreVoteResp from 5420a740f4813dc9 at term 1"} {"level":"info","ts":"2026-08-26T07:03:05.006451Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became candidate at term 2"} {"level":"info","ts":"2026-08-26T07:03:05.006462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 received MsgVoteResp from 5420a740f4813dc9 at term 2"} {"level":"info","ts":"2026-08-26T07:03:05.006478Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5420a740f4813dc9 became leader at term 2"} {"level":"info","ts":"2026-08-26T07:03:05.006491Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5420a740f4813dc9 elected leader 5420a740f4813dc9 at term 2"} {"level":"info","ts":"2026-08-26T07:03:05.007319Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5420a740f4813dc9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.175:2379]}","request-path":"/0/members/5420a740f4813dc9/attributes","cluster-id":"5ecb181dc9675400","publish-timeout":"7s"} {"level":"info","ts":"2026-08-26T07:03:05.007373Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T07:03:05.007539Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T07:03:05.0074Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-26T07:03:05.007771Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-26T07:03:05.00795Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-26T07:03:05.011697Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-26T07:03:05.011707Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.175:2379"} {"level":"info","ts":"2026-08-26T07:03:05.011841Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"5ecb181dc9675400","local-member-id":"5420a740f4813dc9","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T07:03:05.011966Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T07:03:05.012007Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-26T07:03:39.485722Z","caller":"traceutil/trace.go:171","msg":"trace[2092313842] transaction","detail":"{read_only:false; number_of_response:1; response_revision:493; }","duration":"122.921092ms","start":"2026-08-26T07:03:39.362768Z","end":"2026-08-26T07:03:39.485689Z","steps":["trace[2092313842] 'process raft request' (duration: 122.886311ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.485903Z","caller":"traceutil/trace.go:171","msg":"trace[1537716538] transaction","detail":"{read_only:false; response_revision:492; number_of_response:1; }","duration":"125.004351ms","start":"2026-08-26T07:03:39.360873Z","end":"2026-08-26T07:03:39.485878Z","steps":["trace[1537716538] 'process raft request' (duration: 124.485826ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.485948Z","caller":"traceutil/trace.go:171","msg":"trace[1789709025] transaction","detail":"{read_only:false; response_revision:493; number_of_response:1; }","duration":"124.211148ms","start":"2026-08-26T07:03:39.36173Z","end":"2026-08-26T07:03:39.485941Z","steps":["trace[1789709025] 'process raft request' (duration: 123.878769ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.501866Z","caller":"traceutil/trace.go:171","msg":"trace[1856935325] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"108.597815ms","start":"2026-08-26T07:03:39.393249Z","end":"2026-08-26T07:03:39.501847Z","steps":["trace[1856935325] 'process raft request' (duration: 108.210994ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.501992Z","caller":"traceutil/trace.go:171","msg":"trace[816250946] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"103.585325ms","start":"2026-08-26T07:03:39.398401Z","end":"2026-08-26T07:03:39.501987Z","steps":["trace[816250946] 'process raft request' (duration: 103.148283ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.502187Z","caller":"traceutil/trace.go:171","msg":"trace[1190878042] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"117.930284ms","start":"2026-08-26T07:03:39.384245Z","end":"2026-08-26T07:03:39.502175Z","steps":["trace[1190878042] 'process raft request' (duration: 117.058569ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.501877Z","caller":"traceutil/trace.go:171","msg":"trace[1985064762] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"106.941529ms","start":"2026-08-26T07:03:39.394916Z","end":"2026-08-26T07:03:39.501857Z","steps":["trace[1985064762] 'process raft request' (duration: 106.562498ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.502345Z","caller":"traceutil/trace.go:171","msg":"trace[1671014697] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"116.02036ms","start":"2026-08-26T07:03:39.386317Z","end":"2026-08-26T07:03:39.502337Z","steps":["trace[1671014697] 'process raft request' (duration: 115.080344ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.502529Z","caller":"traceutil/trace.go:171","msg":"trace[1482349286] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"113.261874ms","start":"2026-08-26T07:03:39.38926Z","end":"2026-08-26T07:03:39.502522Z","steps":["trace[1482349286] 'process raft request' (duration: 112.162474ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:39.501939Z","caller":"traceutil/trace.go:171","msg":"trace[184145177] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"104.160671ms","start":"2026-08-26T07:03:39.397773Z","end":"2026-08-26T07:03:39.501933Z","steps":["trace[184145177] 'process raft request' (duration: 103.741479ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:45.430598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.309266ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:03:45.430629Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.254987ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:03:45.43068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.325301ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:45.430687Z","caller":"traceutil/trace.go:171","msg":"trace[1025067696] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"116.33728ms","start":"2026-08-26T07:03:45.314336Z","end":"2026-08-26T07:03:45.430673Z","steps":["trace[1025067696] 'count revisions from in-memory index tree' (duration: 116.153655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:45.430869Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.410773ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:45.430897Z","caller":"traceutil/trace.go:171","msg":"trace[1024204947] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:587; }","duration":"142.451215ms","start":"2026-08-26T07:03:45.28844Z","end":"2026-08-26T07:03:45.430891Z","steps":["trace[1024204947] 'count revisions from in-memory index tree' (duration: 142.385703ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:45.43052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.083223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/backendtlspolicies/\" range_end:\"/registry/gateway.networking.k8s.io/backendtlspolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:45.431043Z","caller":"traceutil/trace.go:171","msg":"trace[1374043972] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/backendtlspolicies/; range_end:/registry/gateway.networking.k8s.io/backendtlspolicies0; response_count:0; response_revision:587; }","duration":"116.621647ms","start":"2026-08-26T07:03:45.314398Z","end":"2026-08-26T07:03:45.43102Z","steps":["trace[1374043972] 'range keys from in-memory index tree' (duration: 116.047131ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:45.43116Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.211027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/httproutefilters/\" range_end:\"/registry/gateway.envoyproxy.io/httproutefilters0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:45.431201Z","caller":"traceutil/trace.go:171","msg":"trace[381246689] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:587; }","duration":"142.363412ms","start":"2026-08-26T07:03:45.28883Z","end":"2026-08-26T07:03:45.431194Z","steps":["trace[381246689] 'range keys from in-memory index tree' (duration: 142.183377ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:45.430571Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.519513ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:45.431317Z","caller":"traceutil/trace.go:171","msg":"trace[490399881] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"167.270023ms","start":"2026-08-26T07:03:45.264034Z","end":"2026-08-26T07:03:45.431304Z","steps":["trace[490399881] 'count revisions from in-memory index tree' (duration: 166.486351ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:45.430585Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.608305ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:45.430698Z","caller":"traceutil/trace.go:171","msg":"trace[54120742] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/httproutefilters/; range_end:/registry/gateway.envoyproxy.io/httproutefilters0; response_count:0; response_revision:587; }","duration":"142.353391ms","start":"2026-08-26T07:03:45.288339Z","end":"2026-08-26T07:03:45.430693Z","steps":["trace[54120742] 'range keys from in-memory index tree' (duration: 142.29769ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:45.430647Z","caller":"traceutil/trace.go:171","msg":"trace[1440187405] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"166.364458ms","start":"2026-08-26T07:03:45.264272Z","end":"2026-08-26T07:03:45.430637Z","steps":["trace[1440187405] 'range keys from in-memory index tree' (duration: 166.281735ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:45.431492Z","caller":"traceutil/trace.go:171","msg":"trace[1769785740] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:587; }","duration":"167.50656ms","start":"2026-08-26T07:03:45.263972Z","end":"2026-08-26T07:03:45.431478Z","steps":["trace[1769785740] 'range keys from in-memory index tree' (duration: 166.481351ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:45.681976Z","caller":"traceutil/trace.go:171","msg":"trace[1954204100] transaction","detail":"{read_only:false; response_revision:588; number_of_response:1; }","duration":"139.923884ms","start":"2026-08-26T07:03:45.542024Z","end":"2026-08-26T07:03:45.681948Z","steps":["trace[1954204100] 'process raft request' (duration: 139.240095ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.211343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"436.853006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T07:03:46.211669Z","caller":"traceutil/trace.go:171","msg":"trace[822346677] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"489.355264ms","start":"2026-08-26T07:03:45.722284Z","end":"2026-08-26T07:03:46.211639Z","steps":["trace[822346677] 'process raft request' (duration: 51.660004ms)","trace[822346677] 'compare' (duration: 436.735783ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:03:46.211747Z","caller":"traceutil/trace.go:171","msg":"trace[849819694] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:613; }","duration":"479.224592ms","start":"2026-08-26T07:03:45.732499Z","end":"2026-08-26T07:03:46.211723Z","steps":["trace[849819694] 'read index received' (duration: 41.44099ms)","trace[849819694] 'applied index is now lower than readState.Index' (duration: 437.781482ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:03:46.211815Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.72223Z","time spent":"489.505728ms","remote":"127.0.0.1:56314","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T07:03:46.211942Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.394727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.211986Z","caller":"traceutil/trace.go:171","msg":"trace[1472971312] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"479.50439ms","start":"2026-08-26T07:03:45.732471Z","end":"2026-08-26T07:03:46.211976Z","steps":["trace[1472971312] 'agreement among raft nodes before linearized reading' (duration: 479.367207ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212021Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.732458Z","time spent":"479.553771ms","remote":"127.0.0.1:36466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:10000 "} {"level":"info","ts":"2026-08-26T07:03:46.211711Z","caller":"traceutil/trace.go:171","msg":"trace[146764348] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"466.86145ms","start":"2026-08-26T07:03:45.744834Z","end":"2026-08-26T07:03:46.211695Z","steps":["trace[146764348] 'process raft request' (duration: 466.800338ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.902724ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:03:46.21228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.7423ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.212313Z","caller":"traceutil/trace.go:171","msg":"trace[1302713524] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"134.974256ms","start":"2026-08-26T07:03:46.077327Z","end":"2026-08-26T07:03:46.212301Z","steps":["trace[1302713524] 'agreement among raft nodes before linearized reading' (duration: 134.921625ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.346273ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.212391Z","caller":"traceutil/trace.go:171","msg":"trace[1830213985] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:590; }","duration":"409.441836ms","start":"2026-08-26T07:03:45.802938Z","end":"2026-08-26T07:03:46.21238Z","steps":["trace[1830213985] 'agreement among raft nodes before linearized reading' (duration: 409.351843ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.21243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.802917Z","time spent":"409.504018ms","remote":"127.0.0.1:36496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:03:46.212477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.290152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.212515Z","caller":"traceutil/trace.go:171","msg":"trace[554892513] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:590; }","duration":"453.344654ms","start":"2026-08-26T07:03:45.75916Z","end":"2026-08-26T07:03:46.212505Z","steps":["trace[554892513] 'agreement among raft nodes before linearized reading' (duration: 453.291573ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.759153Z","time spent":"453.388625ms","remote":"127.0.0.1:36480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:03:46.212596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.370877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.212635Z","caller":"traceutil/trace.go:171","msg":"trace[1251596595] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"251.441899ms","start":"2026-08-26T07:03:45.961184Z","end":"2026-08-26T07:03:46.212626Z","steps":["trace[1251596595] 'agreement among raft nodes before linearized reading' (duration: 251.385738ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.723885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.212721Z","caller":"traceutil/trace.go:171","msg":"trace[1284927852] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:590; }","duration":"453.775576ms","start":"2026-08-26T07:03:45.758937Z","end":"2026-08-26T07:03:46.212713Z","steps":["trace[1284927852] 'agreement among raft nodes before linearized reading' (duration: 453.726725ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212749Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.75893Z","time spent":"453.811597ms","remote":"127.0.0.1:36480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":131,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:03:46.21278Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"251.855881ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.212817Z","caller":"traceutil/trace.go:171","msg":"trace[2136471336] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"251.916693ms","start":"2026-08-26T07:03:45.960892Z","end":"2026-08-26T07:03:46.212809Z","steps":["trace[2136471336] 'agreement among raft nodes before linearized reading' (duration: 251.858451ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"453.946021ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.212902Z","caller":"traceutil/trace.go:171","msg":"trace[338895916] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/; range_end:/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0; response_count:0; response_revision:590; }","duration":"454.020703ms","start":"2026-08-26T07:03:45.758873Z","end":"2026-08-26T07:03:46.212894Z","steps":["trace[338895916] 'agreement among raft nodes before linearized reading' (duration: 453.973362ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.21293Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.758856Z","time spent":"454.065674ms","remote":"127.0.0.1:36480","response type":"/etcdserverpb.KV/Range","request count":0,"request size":130,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies/\" range_end:\"/registry/gateway.networking.x-k8s.io/xbackendtrafficpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:03:46.212983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"409.562539ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.213022Z","caller":"traceutil/trace.go:171","msg":"trace[1859371385] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:590; }","duration":"409.61383ms","start":"2026-08-26T07:03:45.803399Z","end":"2026-08-26T07:03:46.213012Z","steps":["trace[1859371385] 'agreement among raft nodes before linearized reading' (duration: 409.522998ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.213057Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.803391Z","time spent":"409.657591ms","remote":"127.0.0.1:36496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":117,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:03:46.213065Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.941642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.213094Z","caller":"traceutil/trace.go:171","msg":"trace[1558619225] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"479.981893ms","start":"2026-08-26T07:03:45.733104Z","end":"2026-08-26T07:03:46.213086Z","steps":["trace[1558619225] 'agreement among raft nodes before linearized reading' (duration: 479.938582ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.213128Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.733099Z","time spent":"480.020844ms","remote":"127.0.0.1:36466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":99,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:03:46.213185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"410.179186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.213221Z","caller":"traceutil/trace.go:171","msg":"trace[577029906] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:590; }","duration":"410.239788ms","start":"2026-08-26T07:03:45.802972Z","end":"2026-08-26T07:03:46.213212Z","steps":["trace[577029906] 'agreement among raft nodes before linearized reading' (duration: 410.191046ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.213253Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.802955Z","time spent":"410.287479ms","remote":"127.0.0.1:36496","response type":"/etcdserverpb.KV/Range","request count":0,"request size":116,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:03:46.212699Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.74481Z","time spent":"467.464727ms","remote":"127.0.0.1:56372","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-26T07:03:46.212346Z","caller":"traceutil/trace.go:171","msg":"trace[297484176] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"134.833013ms","start":"2026-08-26T07:03:46.077493Z","end":"2026-08-26T07:03:46.212326Z","steps":["trace[297484176] 'agreement among raft nodes before linearized reading' (duration: 134.72563ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.212225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"479.670655ms","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-26T07:03:46.213644Z","caller":"traceutil/trace.go:171","msg":"trace[883202339] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:590; }","duration":"481.092784ms","start":"2026-08-26T07:03:45.732534Z","end":"2026-08-26T07:03:46.213627Z","steps":["trace[883202339] 'agreement among raft nodes before linearized reading' (duration: 479.661134ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.213808Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.777599ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:03:46.213848Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.107569ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.213893Z","caller":"traceutil/trace.go:171","msg":"trace[295559123] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:590; }","duration":"135.886442ms","start":"2026-08-26T07:03:46.07799Z","end":"2026-08-26T07:03:46.213877Z","steps":["trace[295559123] 'agreement among raft nodes before linearized reading' (duration: 135.772209ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.213961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.310235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:03:46.213929Z","caller":"traceutil/trace.go:171","msg":"trace[495979627] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:590; }","duration":"113.233813ms","start":"2026-08-26T07:03:46.100677Z","end":"2026-08-26T07:03:46.213911Z","steps":["trace[495979627] 'agreement among raft nodes before linearized reading' (duration: 113.081929ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:03:46.214007Z","caller":"traceutil/trace.go:171","msg":"trace[794561587] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:590; }","duration":"113.374898ms","start":"2026-08-26T07:03:46.100622Z","end":"2026-08-26T07:03:46.213997Z","steps":["trace[794561587] 'agreement among raft nodes before linearized reading' (duration: 113.306326ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:03:46.214192Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:03:45.73253Z","time spent":"481.642999ms","remote":"127.0.0.1:36466","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"info","ts":"2026-08-26T07:05:18.16702Z","caller":"traceutil/trace.go:171","msg":"trace[1663523033] linearizableReadLoop","detail":"{readStateIndex:1895; appliedIndex:1894; }","duration":"110.14901ms","start":"2026-08-26T07:05:18.056843Z","end":"2026-08-26T07:05:18.166992Z","steps":["trace[1663523033] 'read index received' (duration: 109.965285ms)","trace[1663523033] 'applied index is now lower than readState.Index' (duration: 182.765µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:05:18.167134Z","caller":"traceutil/trace.go:171","msg":"trace[2106736483] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"193.155837ms","start":"2026-08-26T07:05:17.9739Z","end":"2026-08-26T07:05:18.167056Z","steps":["trace[2106736483] 'process raft request' (duration: 192.925871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:05:18.167348Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.48647ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.175\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-26T07:05:18.16741Z","caller":"traceutil/trace.go:171","msg":"trace[544536442] range","detail":"{range_begin:/registry/masterleases/162.253.55.175; range_end:; response_count:1; response_revision:1824; }","duration":"110.598674ms","start":"2026-08-26T07:05:18.056798Z","end":"2026-08-26T07:05:18.167397Z","steps":["trace[544536442] 'agreement among raft nodes before linearized reading' (duration: 110.353417ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:06:09.452421Z","caller":"traceutil/trace.go:171","msg":"trace[1004919261] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"231.889371ms","start":"2026-08-26T07:06:09.220497Z","end":"2026-08-26T07:06:09.452386Z","steps":["trace[1004919261] 'process raft request' (duration: 181.126425ms)","trace[1004919261] 'compare' (duration: 50.463527ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:06:09.725245Z","caller":"traceutil/trace.go:171","msg":"trace[848094143] linearizableReadLoop","detail":"{readStateIndex:2236; appliedIndex:2235; }","duration":"169.524471ms","start":"2026-08-26T07:06:09.555694Z","end":"2026-08-26T07:06:09.725218Z","steps":["trace[848094143] 'read index received' (duration: 169.329275ms)","trace[848094143] 'applied index is now lower than readState.Index' (duration: 193.956µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:06:09.725356Z","caller":"traceutil/trace.go:171","msg":"trace[1786631609] transaction","detail":"{read_only:false; response_revision:2154; number_of_response:1; }","duration":"267.978415ms","start":"2026-08-26T07:06:09.457356Z","end":"2026-08-26T07:06:09.725335Z","steps":["trace[1786631609] 'process raft request' (duration: 267.722298ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:06:09.725552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.844739ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-26T07:06:09.725616Z","caller":"traceutil/trace.go:171","msg":"trace[872180004] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2154; }","duration":"169.965562ms","start":"2026-08-26T07:06:09.555634Z","end":"2026-08-26T07:06:09.7256Z","steps":["trace[872180004] 'agreement among raft nodes before linearized reading' (duration: 169.751296ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:07:03.392814Z","caller":"traceutil/trace.go:171","msg":"trace[181416836] linearizableReadLoop","detail":"{readStateIndex:2714; appliedIndex:2713; }","duration":"200.550507ms","start":"2026-08-26T07:07:03.192235Z","end":"2026-08-26T07:07:03.392786Z","steps":["trace[181416836] 'read index received' (duration: 187.826768ms)","trace[181416836] 'applied index is now lower than readState.Index' (duration: 12.721469ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:07:03.392986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.725552ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:07:03.393081Z","caller":"traceutil/trace.go:171","msg":"trace[701758977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2614; }","duration":"200.876386ms","start":"2026-08-26T07:07:03.192186Z","end":"2026-08-26T07:07:03.393062Z","steps":["trace[701758977] 'agreement among raft nodes before linearized reading' (duration: 200.697011ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:09:58.793354Z","caller":"traceutil/trace.go:171","msg":"trace[1247051543] linearizableReadLoop","detail":"{readStateIndex:3913; appliedIndex:3912; }","duration":"125.71704ms","start":"2026-08-26T07:09:58.667617Z","end":"2026-08-26T07:09:58.793335Z","steps":["trace[1247051543] 'read index received' (duration: 125.587067ms)","trace[1247051543] 'applied index is now lower than readState.Index' (duration: 129.093µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:09:58.793423Z","caller":"traceutil/trace.go:171","msg":"trace[2100602756] transaction","detail":"{read_only:false; response_revision:3769; number_of_response:1; }","duration":"152.307069ms","start":"2026-08-26T07:09:58.641079Z","end":"2026-08-26T07:09:58.793386Z","steps":["trace[2100602756] 'process raft request' (duration: 152.132734ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:09:58.793522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.901915ms","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-26T07:09:58.793553Z","caller":"traceutil/trace.go:171","msg":"trace[1951297354] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3769; }","duration":"125.986177ms","start":"2026-08-26T07:09:58.667558Z","end":"2026-08-26T07:09:58.793545Z","steps":["trace[1951297354] 'agreement among raft nodes before linearized reading' (duration: 125.873074ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:09:58.963911Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.989406ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T07:09:58.964046Z","caller":"traceutil/trace.go:171","msg":"trace[1735676497] linearizableReadLoop","detail":"{readStateIndex:3914; appliedIndex:3913; }","duration":"151.231719ms","start":"2026-08-26T07:09:58.812794Z","end":"2026-08-26T07:09:58.964025Z","steps":["trace[1735676497] 'read index received' (duration: 32.933215ms)","trace[1735676497] 'applied index is now lower than readState.Index' (duration: 118.296784ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:09:58.964143Z","caller":"traceutil/trace.go:171","msg":"trace[1503459127] transaction","detail":"{read_only:false; response_revision:3770; number_of_response:1; }","duration":"166.910203ms","start":"2026-08-26T07:09:58.797198Z","end":"2026-08-26T07:09:58.964108Z","steps":["trace[1503459127] 'process raft request' (duration: 48.599388ms)","trace[1503459127] 'compare' (duration: 117.848632ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:09:58.964236Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.442964ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-08-26T07:09:58.964288Z","caller":"traceutil/trace.go:171","msg":"trace[604523969] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:3770; }","duration":"151.512807ms","start":"2026-08-26T07:09:58.812758Z","end":"2026-08-26T07:09:58.964271Z","steps":["trace[604523969] 'agreement among raft nodes before linearized reading' (duration: 151.374053ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:09:58.964447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.902264ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hk79\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-26T07:09:58.964532Z","caller":"traceutil/trace.go:171","msg":"trace[1830248441] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hk79; range_end:; response_count:1; response_revision:3770; }","duration":"140.022617ms","start":"2026-08-26T07:09:58.824491Z","end":"2026-08-26T07:09:58.964513Z","steps":["trace[1830248441] 'agreement among raft nodes before linearized reading' (duration: 139.671898ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:09:58.964604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.113535ms","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-26T07:09:58.964656Z","caller":"traceutil/trace.go:171","msg":"trace[1455538296] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:3770; }","duration":"111.193397ms","start":"2026-08-26T07:09:58.853449Z","end":"2026-08-26T07:09:58.964642Z","steps":["trace[1455538296] 'agreement among raft nodes before linearized reading' (duration: 110.751885ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:09:58.964671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.196597ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-26T07:09:58.964917Z","caller":"traceutil/trace.go:171","msg":"trace[1741252340] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:3770; }","duration":"129.447724ms","start":"2026-08-26T07:09:58.835378Z","end":"2026-08-26T07:09:58.964826Z","steps":["trace[1741252340] 'agreement among raft nodes before linearized reading' (duration: 128.847307ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:17.190979Z","caller":"traceutil/trace.go:171","msg":"trace[947607632] linearizableReadLoop","detail":"{readStateIndex:4951; appliedIndex:4950; }","duration":"113.415023ms","start":"2026-08-26T07:11:17.077531Z","end":"2026-08-26T07:11:17.190946Z","steps":["trace[947607632] 'read index received' (duration: 18.024493ms)","trace[947607632] 'applied index is now lower than readState.Index' (duration: 95.38962ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:11:17.19119Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.64426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:11:17.191245Z","caller":"traceutil/trace.go:171","msg":"trace[1494798159] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-tls-assets-1; range_end:; response_count:0; response_revision:4771; }","duration":"113.725722ms","start":"2026-08-26T07:11:17.077507Z","end":"2026-08-26T07:11:17.191232Z","steps":["trace[1494798159] 'agreement among raft nodes before linearized reading' (duration: 113.606849ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:17.19101Z","caller":"traceutil/trace.go:171","msg":"trace[301624111] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"114.191955ms","start":"2026-08-26T07:11:17.076785Z","end":"2026-08-26T07:11:17.190977Z","steps":["trace[301624111] 'process raft request' (duration: 18.813345ms)","trace[301624111] 'compare' (duration: 95.225746ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:11:17.381027Z","caller":"traceutil/trace.go:171","msg":"trace[1578936729] linearizableReadLoop","detail":"{readStateIndex:4963; appliedIndex:4962; }","duration":"107.939781ms","start":"2026-08-26T07:11:17.273055Z","end":"2026-08-26T07:11:17.380995Z","steps":["trace[1578936729] 'read index received' (duration: 107.712744ms)","trace[1578936729] 'applied index is now lower than readState.Index' (duration: 225.427µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:11:17.38116Z","caller":"traceutil/trace.go:171","msg":"trace[681419209] transaction","detail":"{read_only:false; response_revision:4783; number_of_response:1; }","duration":"111.932242ms","start":"2026-08-26T07:11:17.269217Z","end":"2026-08-26T07:11:17.381149Z","steps":["trace[681419209] 'process raft request' (duration: 111.602493ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:11:17.381357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.28547ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-8q8lg-tls\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:11:17.381402Z","caller":"traceutil/trace.go:171","msg":"trace[742826696] range","detail":"{range_begin:/registry/secrets/monitoring/kube-prometheus-stack-prometheus-node-exporter-8q8lg-tls; range_end:; response_count:0; response_revision:4783; }","duration":"108.377663ms","start":"2026-08-26T07:11:17.273014Z","end":"2026-08-26T07:11:17.381392Z","steps":["trace[742826696] 'agreement among raft nodes before linearized reading' (duration: 108.2957ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:17.38967Z","caller":"traceutil/trace.go:171","msg":"trace[340012627] transaction","detail":"{read_only:false; response_revision:4784; number_of_response:1; }","duration":"110.180494ms","start":"2026-08-26T07:11:17.279458Z","end":"2026-08-26T07:11:17.389639Z","steps":["trace[340012627] 'process raft request' (duration: 109.004941ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:21.321266Z","caller":"traceutil/trace.go:171","msg":"trace[1482996849] transaction","detail":"{read_only:false; response_revision:4929; number_of_response:1; }","duration":"106.560242ms","start":"2026-08-26T07:11:21.214679Z","end":"2026-08-26T07:11:21.321239Z","steps":["trace[1482996849] 'process raft request' (duration: 106.378197ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:23.165521Z","caller":"traceutil/trace.go:171","msg":"trace[1658289182] transaction","detail":"{read_only:false; response_revision:4966; number_of_response:1; }","duration":"145.353135ms","start":"2026-08-26T07:11:23.020144Z","end":"2026-08-26T07:11:23.165497Z","steps":["trace[1658289182] 'process raft request' (duration: 132.740203ms)","trace[1658289182] 'compare' (duration: 12.507109ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:11:33.196433Z","caller":"traceutil/trace.go:171","msg":"trace[61063738] linearizableReadLoop","detail":"{readStateIndex:5356; appliedIndex:5354; }","duration":"137.272869ms","start":"2026-08-26T07:11:33.059141Z","end":"2026-08-26T07:11:33.196413Z","steps":["trace[61063738] 'read index received' (duration: 122.27849ms)","trace[61063738] 'applied index is now lower than readState.Index' (duration: 14.993309ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:11:33.196466Z","caller":"traceutil/trace.go:171","msg":"trace[191147637] transaction","detail":"{read_only:false; response_revision:5162; number_of_response:1; }","duration":"144.84077ms","start":"2026-08-26T07:11:33.051578Z","end":"2026-08-26T07:11:33.196419Z","steps":["trace[191147637] 'process raft request' (duration: 129.838981ms)","trace[191147637] 'compare' (duration: 14.510855ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:11:33.196681Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.529407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/openstack/\" range_end:\"/registry/limitranges/openstack0\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:11:33.196681Z","caller":"traceutil/trace.go:171","msg":"trace[1322157803] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"135.026946ms","start":"2026-08-26T07:11:33.061627Z","end":"2026-08-26T07:11:33.196654Z","steps":["trace[1322157803] 'process raft request' (duration: 134.738328ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:33.196746Z","caller":"traceutil/trace.go:171","msg":"trace[261494661] range","detail":"{range_begin:/registry/limitranges/openstack/; range_end:/registry/limitranges/openstack0; response_count:0; response_revision:5164; }","duration":"137.621249ms","start":"2026-08-26T07:11:33.059107Z","end":"2026-08-26T07:11:33.196728Z","steps":["trace[261494661] 'agreement among raft nodes before linearized reading' (duration: 137.508615ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:33.196756Z","caller":"traceutil/trace.go:171","msg":"trace[737823840] transaction","detail":"{read_only:false; response_revision:5163; number_of_response:1; }","duration":"139.166042ms","start":"2026-08-26T07:11:33.057541Z","end":"2026-08-26T07:11:33.196707Z","steps":["trace[737823840] 'process raft request' (duration: 138.766331ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:34.220709Z","caller":"traceutil/trace.go:171","msg":"trace[2100507984] transaction","detail":"{read_only:false; response_revision:5188; number_of_response:1; }","duration":"111.48023ms","start":"2026-08-26T07:11:34.109206Z","end":"2026-08-26T07:11:34.220686Z","steps":["trace[2100507984] 'process raft request' (duration: 89.241029ms)","trace[2100507984] 'compare' (duration: 22.103277ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:11:34.229214Z","caller":"traceutil/trace.go:171","msg":"trace[707559026] transaction","detail":"{read_only:false; response_revision:5189; number_of_response:1; }","duration":"112.739434ms","start":"2026-08-26T07:11:34.116441Z","end":"2026-08-26T07:11:34.229181Z","steps":["trace[707559026] 'process raft request' (duration: 112.540599ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:11:42.314126Z","caller":"traceutil/trace.go:171","msg":"trace[395877769] linearizableReadLoop","detail":"{readStateIndex:5593; appliedIndex:5592; }","duration":"122.324022ms","start":"2026-08-26T07:11:42.191768Z","end":"2026-08-26T07:11:42.314092Z","steps":["trace[395877769] 'read index received' (duration: 122.144577ms)","trace[395877769] 'applied index is now lower than readState.Index' (duration: 178.175µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:11:42.314363Z","caller":"traceutil/trace.go:171","msg":"trace[71627422] transaction","detail":"{read_only:false; response_revision:5395; number_of_response:1; }","duration":"153.242984ms","start":"2026-08-26T07:11:42.161108Z","end":"2026-08-26T07:11:42.314351Z","steps":["trace[71627422] 'process raft request' (duration: 152.827253ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:11:42.314519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.741053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:11:42.31462Z","caller":"traceutil/trace.go:171","msg":"trace[241001264] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5395; }","duration":"122.886998ms","start":"2026-08-26T07:11:42.191708Z","end":"2026-08-26T07:11:42.314595Z","steps":["trace[241001264] 'agreement among raft nodes before linearized reading' (duration: 122.743974ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:13:05.03749Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2975} {"level":"info","ts":"2026-08-26T07:13:05.11034Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2975,"took":"71.406401ms","hash":3865063796,"current-db-size-bytes":59940864,"current-db-size":"60 MB","current-db-size-in-use-bytes":34508800,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-26T07:13:05.110395Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3865063796,"revision":2975,"compact-revision":-1} {"level":"info","ts":"2026-08-26T07:17:47.546394Z","caller":"traceutil/trace.go:171","msg":"trace[1801412581] transaction","detail":"{read_only:false; response_revision:8186; number_of_response:1; }","duration":"271.226442ms","start":"2026-08-26T07:17:47.275144Z","end":"2026-08-26T07:17:47.54637Z","steps":["trace[1801412581] 'process raft request' (duration: 271.065978ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:17:47.709024Z","caller":"traceutil/trace.go:171","msg":"trace[769072102] linearizableReadLoop","detail":"{readStateIndex:8472; appliedIndex:8469; }","duration":"424.080358ms","start":"2026-08-26T07:17:47.284922Z","end":"2026-08-26T07:17:47.709002Z","steps":["trace[769072102] 'read index received' (duration: 261.240774ms)","trace[769072102] 'applied index is now lower than readState.Index' (duration: 162.838494ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:17:47.709328Z","caller":"traceutil/trace.go:171","msg":"trace[753676330] transaction","detail":"{read_only:false; response_revision:8187; number_of_response:1; }","duration":"433.022949ms","start":"2026-08-26T07:17:47.276292Z","end":"2026-08-26T07:17:47.709315Z","steps":["trace[753676330] 'process raft request' (duration: 432.441423ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.709433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.276274Z","time spent":"433.092071ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T07:17:47.709553Z","caller":"traceutil/trace.go:171","msg":"trace[1811718132] transaction","detail":"{read_only:false; response_revision:8188; number_of_response:1; }","duration":"432.604848ms","start":"2026-08-26T07:17:47.276939Z","end":"2026-08-26T07:17:47.709544Z","steps":["trace[1811718132] 'process raft request' (duration: 431.983141ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.709609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.276908Z","time spent":"432.67341ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T07:17:47.709713Z","caller":"traceutil/trace.go:171","msg":"trace[842500201] transaction","detail":"{read_only:false; response_revision:8189; number_of_response:1; }","duration":"301.316103ms","start":"2026-08-26T07:17:47.408388Z","end":"2026-08-26T07:17:47.709705Z","steps":["trace[842500201] 'process raft request' (duration: 300.571463ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.709768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.408367Z","time spent":"301.376985ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T07:17:47.709884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"424.942212ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.709915Z","caller":"traceutil/trace.go:171","msg":"trace[1128420450] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8189; }","duration":"425.009894ms","start":"2026-08-26T07:17:47.284896Z","end":"2026-08-26T07:17:47.709906Z","steps":["trace[1128420450] 'agreement among raft nodes before linearized reading' (duration: 424.930622ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.709943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.284881Z","time spent":"425.054675ms","remote":"127.0.0.1:53860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:17:47.710142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"425.141998ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.710179Z","caller":"traceutil/trace.go:171","msg":"trace[1342710826] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8189; }","duration":"425.200389ms","start":"2026-08-26T07:17:47.28497Z","end":"2026-08-26T07:17:47.71017Z","steps":["trace[1342710826] 'agreement among raft nodes before linearized reading' (duration: 425.147627ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.710208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.284963Z","time spent":"425.23743ms","remote":"127.0.0.1:53860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":87,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:17:47.710259Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.662085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:17:47.710342Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.86503ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.710371Z","caller":"traceutil/trace.go:171","msg":"trace[1605856176] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8189; }","duration":"323.790709ms","start":"2026-08-26T07:17:47.386562Z","end":"2026-08-26T07:17:47.710353Z","steps":["trace[1605856176] 'agreement among raft nodes before linearized reading' (duration: 323.607854ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.710431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.386516Z","time spent":"323.903632ms","remote":"127.0.0.1:53918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:17:47.710492Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.743331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-08-26T07:17:47.710524Z","caller":"traceutil/trace.go:171","msg":"trace[2117210584] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8189; }","duration":"328.804253ms","start":"2026-08-26T07:17:47.381712Z","end":"2026-08-26T07:17:47.710517Z","steps":["trace[2117210584] 'agreement among raft nodes before linearized reading' (duration: 328.68773ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.710581Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.381692Z","time spent":"328.880016ms","remote":"127.0.0.1:56314","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-08-26T07:17:47.710772Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.628357ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:17:47.71081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.347217ms","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-26T07:17:47.710845Z","caller":"traceutil/trace.go:171","msg":"trace[2095307043] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8189; }","duration":"196.413299ms","start":"2026-08-26T07:17:47.514422Z","end":"2026-08-26T07:17:47.710836Z","steps":["trace[2095307043] 'agreement among raft nodes before linearized reading' (duration: 196.283105ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.710882Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.214672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.710914Z","caller":"traceutil/trace.go:171","msg":"trace[864070411] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"346.245683ms","start":"2026-08-26T07:17:47.36466Z","end":"2026-08-26T07:17:47.710906Z","steps":["trace[864070411] 'agreement among raft nodes before linearized reading' (duration: 346.205722ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.710949Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.364626Z","time spent":"346.313175ms","remote":"127.0.0.1:53902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:17:47.711029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.113078ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hk79\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-26T07:17:47.711073Z","caller":"traceutil/trace.go:171","msg":"trace[1991511660] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hk79; range_end:; response_count:1; response_revision:8189; }","duration":"210.18749ms","start":"2026-08-26T07:17:47.500873Z","end":"2026-08-26T07:17:47.71106Z","steps":["trace[1991511660] 'agreement among raft nodes before linearized reading' (duration: 210.091047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.711126Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.587475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.711164Z","caller":"traceutil/trace.go:171","msg":"trace[1743342774] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8189; }","duration":"358.646547ms","start":"2026-08-26T07:17:47.352509Z","end":"2026-08-26T07:17:47.711155Z","steps":["trace[1743342774] 'agreement among raft nodes before linearized reading' (duration: 358.592816ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.711198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.352501Z","time spent":"358.689688ms","remote":"127.0.0.1:53896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:17:47.71128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.232469ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.711319Z","caller":"traceutil/trace.go:171","msg":"trace[1082066892] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8189; }","duration":"246.290201ms","start":"2026-08-26T07:17:47.465017Z","end":"2026-08-26T07:17:47.711307Z","steps":["trace[1082066892] 'agreement among raft nodes before linearized reading' (duration: 246.23682ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.711364Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.88298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.711404Z","caller":"traceutil/trace.go:171","msg":"trace[2075767102] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8189; }","duration":"359.954552ms","start":"2026-08-26T07:17:47.351438Z","end":"2026-08-26T07:17:47.711392Z","steps":["trace[2075767102] 'agreement among raft nodes before linearized reading' (duration: 359.88971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.71144Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.35141Z","time spent":"360.019344ms","remote":"127.0.0.1:53896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":97,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:17:47.711477Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.252568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.711515Z","caller":"traceutil/trace.go:171","msg":"trace[665019724] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8189; }","duration":"247.308319ms","start":"2026-08-26T07:17:47.464196Z","end":"2026-08-26T07:17:47.711504Z","steps":["trace[665019724] 'agreement among raft nodes before linearized reading' (duration: 247.257747ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.711576Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.203168ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.711607Z","caller":"traceutil/trace.go:171","msg":"trace[2074096577] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemmirrors/; range_end:/registry/ceph.rook.io/cephfilesystemmirrors0; response_count:0; response_revision:8189; }","duration":"360.24733ms","start":"2026-08-26T07:17:47.351351Z","end":"2026-08-26T07:17:47.711598Z","steps":["trace[2074096577] 'agreement among raft nodes before linearized reading' (duration: 360.202919ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.711634Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.351342Z","time spent":"360.284421ms","remote":"127.0.0.1:53896","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephfilesystemmirrors/\" range_end:\"/registry/ceph.rook.io/cephfilesystemmirrors0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:17:47.711645Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.576096ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.711673Z","caller":"traceutil/trace.go:171","msg":"trace[747085152] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:8189; }","duration":"247.620037ms","start":"2026-08-26T07:17:47.464046Z","end":"2026-08-26T07:17:47.711666Z","steps":["trace[747085152] 'agreement among raft nodes before linearized reading' (duration: 247.574936ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.71176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.556852ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:17:47.711792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.040565ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.711798Z","caller":"traceutil/trace.go:171","msg":"trace[49182993] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"378.602854ms","start":"2026-08-26T07:17:47.333184Z","end":"2026-08-26T07:17:47.711786Z","steps":["trace[49182993] 'agreement among raft nodes before linearized reading' (duration: 378.554043ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:17:47.71182Z","caller":"traceutil/trace.go:171","msg":"trace[198297913] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"262.089957ms","start":"2026-08-26T07:17:47.449722Z","end":"2026-08-26T07:17:47.711812Z","steps":["trace[198297913] 'agreement among raft nodes before linearized reading' (duration: 262.048526ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.711831Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.333178Z","time spent":"378.645735ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:17:47.71197Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.339214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712006Z","caller":"traceutil/trace.go:171","msg":"trace[1163297315] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"379.426246ms","start":"2026-08-26T07:17:47.332571Z","end":"2026-08-26T07:17:47.711998Z","steps":["trace[1163297315] 'agreement among raft nodes before linearized reading' (duration: 379.375765ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.33255Z","time spent":"379.482208ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:17:47.712048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"282.404884ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712077Z","caller":"traceutil/trace.go:171","msg":"trace[1073689462] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8189; }","duration":"282.464645ms","start":"2026-08-26T07:17:47.429605Z","end":"2026-08-26T07:17:47.712069Z","steps":["trace[1073689462] 'agreement among raft nodes before linearized reading' (duration: 282.423264ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"379.55289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712206Z","caller":"traceutil/trace.go:171","msg":"trace[1950849061] range","detail":"{range_begin:/registry/ceph.rook.io/cephbucketnotifications/; range_end:/registry/ceph.rook.io/cephbucketnotifications0; response_count:0; response_revision:8189; }","duration":"379.618021ms","start":"2026-08-26T07:17:47.33258Z","end":"2026-08-26T07:17:47.712198Z","steps":["trace[1950849061] 'agreement among raft nodes before linearized reading' (duration: 379.57112ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.332561Z","time spent":"379.670082ms","remote":"127.0.0.1:53884","response type":"/etcdserverpb.KV/Range","request count":0,"request size":101,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephbucketnotifications/\" range_end:\"/registry/ceph.rook.io/cephbucketnotifications0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:17:47.712272Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.132843ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712305Z","caller":"traceutil/trace.go:171","msg":"trace[1070077904] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8189; }","duration":"283.164904ms","start":"2026-08-26T07:17:47.429132Z","end":"2026-08-26T07:17:47.712297Z","steps":["trace[1070077904] 'agreement among raft nodes before linearized reading' (duration: 283.123973ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712367Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"395.188131ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712403Z","caller":"traceutil/trace.go:171","msg":"trace[820357602] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8189; }","duration":"395.321225ms","start":"2026-08-26T07:17:47.317074Z","end":"2026-08-26T07:17:47.712395Z","steps":["trace[820357602] 'agreement among raft nodes before linearized reading' (duration: 395.271633ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.71244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.317047Z","time spent":"395.382066ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:17:47.712478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.159504ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712511Z","caller":"traceutil/trace.go:171","msg":"trace[985119121] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8189; }","duration":"306.206885ms","start":"2026-08-26T07:17:47.406296Z","end":"2026-08-26T07:17:47.712503Z","steps":["trace[985119121] 'agreement among raft nodes before linearized reading' (duration: 306.162323ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.406288Z","time spent":"306.250387ms","remote":"127.0.0.1:53922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:17:47.712593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.298221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712629Z","caller":"traceutil/trace.go:171","msg":"trace[1073337956] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8189; }","duration":"396.350562ms","start":"2026-08-26T07:17:47.31627Z","end":"2026-08-26T07:17:47.712621Z","steps":["trace[1073337956] 'agreement among raft nodes before linearized reading' (duration: 396.3007ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712656Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.316264Z","time spent":"396.385284ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":82,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:17:47.712697Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"306.38858ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712732Z","caller":"traceutil/trace.go:171","msg":"trace[730079896] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8189; }","duration":"306.446282ms","start":"2026-08-26T07:17:47.406278Z","end":"2026-08-26T07:17:47.712724Z","steps":["trace[730079896] 'agreement among raft nodes before linearized reading' (duration: 306.39663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712766Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.406265Z","time spent":"306.493453ms","remote":"127.0.0.1:53922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:17:47.712784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"396.689051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712819Z","caller":"traceutil/trace.go:171","msg":"trace[1133186629] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpools/; range_end:/registry/ceph.rook.io/cephblockpools0; response_count:0; response_revision:8189; }","duration":"396.727012ms","start":"2026-08-26T07:17:47.316084Z","end":"2026-08-26T07:17:47.712811Z","steps":["trace[1133186629] 'agreement among raft nodes before linearized reading' (duration: 396.676991ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712852Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.316047Z","time spent":"396.797764ms","remote":"127.0.0.1:53880","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephblockpools/\" range_end:\"/registry/ceph.rook.io/cephblockpools0\" limit:10000 "} {"level":"warn","ts":"2026-08-26T07:17:47.712889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.994298ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.712925Z","caller":"traceutil/trace.go:171","msg":"trace[392286883] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8189; }","duration":"326.052199ms","start":"2026-08-26T07:17:47.386865Z","end":"2026-08-26T07:17:47.712917Z","steps":["trace[392286883] 'agreement among raft nodes before linearized reading' (duration: 326.003947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712957Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.386854Z","time spent":"326.095451ms","remote":"127.0.0.1:53918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":85,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:17:47.712982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.185705ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.713019Z","caller":"traceutil/trace.go:171","msg":"trace[1975253777] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8189; }","duration":"413.238846ms","start":"2026-08-26T07:17:47.29977Z","end":"2026-08-26T07:17:47.713009Z","steps":["trace[1975253777] 'agreement among raft nodes before linearized reading' (duration: 413.190395ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:17:47.71038Z","caller":"traceutil/trace.go:171","msg":"trace[1137421851] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzones/; range_end:/registry/ceph.rook.io/cephobjectzones0; response_count:0; response_revision:8189; }","duration":"323.913841ms","start":"2026-08-26T07:17:47.386458Z","end":"2026-08-26T07:17:47.710372Z","steps":["trace[1137421851] 'agreement among raft nodes before linearized reading' (duration: 323.8604ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.713089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.585746ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.713122Z","caller":"traceutil/trace.go:171","msg":"trace[988850127] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8189; }","duration":"413.638777ms","start":"2026-08-26T07:17:47.299476Z","end":"2026-08-26T07:17:47.713115Z","steps":["trace[988850127] 'agreement among raft nodes before linearized reading' (duration: 413.594016ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.713154Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.299465Z","time spent":"413.682259ms","remote":"127.0.0.1:53870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:10000 "} {"level":"info","ts":"2026-08-26T07:17:47.710813Z","caller":"traceutil/trace.go:171","msg":"trace[446443592] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"345.691518ms","start":"2026-08-26T07:17:47.365112Z","end":"2026-08-26T07:17:47.710804Z","steps":["trace[446443592] 'agreement among raft nodes before linearized reading' (duration: 345.629506ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.713265Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.365102Z","time spent":"348.152684ms","remote":"127.0.0.1:53902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:17:47.713351Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"413.853693ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.713387Z","caller":"traceutil/trace.go:171","msg":"trace[903397514] range","detail":"{range_begin:/registry/ceph.rook.io/cephblockpoolradosnamespaces/; range_end:/registry/ceph.rook.io/cephblockpoolradosnamespaces0; response_count:0; response_revision:8189; }","duration":"413.912215ms","start":"2026-08-26T07:17:47.299467Z","end":"2026-08-26T07:17:47.713379Z","steps":["trace[903397514] 'agreement among raft nodes before linearized reading' (duration: 413.855444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.710849Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.14436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.713422Z","caller":"traceutil/trace.go:171","msg":"trace[932066291] range","detail":"{range_begin:/registry/ceph.rook.io/cephclients/; range_end:/registry/ceph.rook.io/cephclients0; response_count:0; response_revision:8189; }","duration":"348.74078ms","start":"2026-08-26T07:17:47.364674Z","end":"2026-08-26T07:17:47.713415Z","steps":["trace[932066291] 'agreement among raft nodes before linearized reading' (duration: 346.156581ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.713455Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.364657Z","time spent":"348.789771ms","remote":"127.0.0.1:53902","response type":"/etcdserverpb.KV/Range","request count":0,"request size":76,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephclients/\" range_end:\"/registry/ceph.rook.io/cephclients0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:17:47.713593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"428.522669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.713626Z","caller":"traceutil/trace.go:171","msg":"trace[120148141] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:8189; }","duration":"428.615581ms","start":"2026-08-26T07:17:47.285003Z","end":"2026-08-26T07:17:47.713619Z","steps":["trace[120148141] 'agreement among raft nodes before linearized reading' (duration: 428.569089ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.713658Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.284983Z","time spent":"428.667933ms","remote":"127.0.0.1:53860","response type":"/etcdserverpb.KV/Range","request count":0,"request size":86,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectstores/\" range_end:\"/registry/ceph.rook.io/cephobjectstores0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:17:47.713052Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.299762Z","time spent":"413.282848ms","remote":"127.0.0.1:53870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":111,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" limit:500 "} {"level":"warn","ts":"2026-08-26T07:17:47.711975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"262.881308ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.714244Z","caller":"traceutil/trace.go:171","msg":"trace[160925786] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"265.148409ms","start":"2026-08-26T07:17:47.449082Z","end":"2026-08-26T07:17:47.714231Z","steps":["trace[160925786] 'agreement among raft nodes before linearized reading' (duration: 262.866478ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.712012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.054053ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephbuckettopics/\" range_end:\"/registry/ceph.rook.io/cephbuckettopics0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:17:47.713088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.386452Z","time spent":"326.626775ms","remote":"127.0.0.1:53918","response type":"/etcdserverpb.KV/Range","request count":0,"request size":84,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectzones/\" range_end:\"/registry/ceph.rook.io/cephobjectzones0\" count_only:true "} {"level":"warn","ts":"2026-08-26T07:17:47.712237Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"283.059491ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups/\" range_end:\"/registry/ceph.rook.io/cephfilesystemsubvolumegroups0\" limit:10000 ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-26T07:17:47.712438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"305.487326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:47.714536Z","caller":"traceutil/trace.go:171","msg":"trace[1919813415] range","detail":"{range_begin:/registry/ceph.rook.io/cephfilesystemsubvolumegroups/; range_end:/registry/ceph.rook.io/cephfilesystemsubvolumegroups0; response_count:0; response_revision:8189; }","duration":"285.357113ms","start":"2026-08-26T07:17:47.42914Z","end":"2026-08-26T07:17:47.714497Z","steps":["trace[1919813415] 'agreement among raft nodes before linearized reading' (duration: 283.069902ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.714552Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.299452Z","time spent":"415.065356ms","remote":"127.0.0.1:53870","response type":"/etcdserverpb.KV/Range","request count":0,"request size":110,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces/\" range_end:\"/registry/ceph.rook.io/cephblockpoolradosnamespaces0\" count_only:true "} {"level":"info","ts":"2026-08-26T07:17:47.714596Z","caller":"traceutil/trace.go:171","msg":"trace[1757903311] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectzonegroups/; range_end:/registry/ceph.rook.io/cephobjectzonegroups0; response_count:0; response_revision:8189; }","duration":"307.652724ms","start":"2026-08-26T07:17:47.406925Z","end":"2026-08-26T07:17:47.714578Z","steps":["trace[1757903311] 'agreement among raft nodes before linearized reading' (duration: 305.491775ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:47.714667Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:17:47.406915Z","time spent":"307.726556ms","remote":"127.0.0.1:53922","response type":"/etcdserverpb.KV/Range","request count":0,"request size":95,"response count":0,"response size":27,"request content":"key:\"/registry/ceph.rook.io/cephobjectzonegroups/\" range_end:\"/registry/ceph.rook.io/cephobjectzonegroups0\" limit:500 "} {"level":"info","ts":"2026-08-26T07:17:47.714341Z","caller":"traceutil/trace.go:171","msg":"trace[101176726] range","detail":"{range_begin:/registry/ceph.rook.io/cephbuckettopics/; range_end:/registry/ceph.rook.io/cephbuckettopics0; response_count:0; response_revision:8189; }","duration":"265.384486ms","start":"2026-08-26T07:17:47.448949Z","end":"2026-08-26T07:17:47.714333Z","steps":["trace[101176726] 'agreement among raft nodes before linearized reading' (duration: 263.044533ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:17:59.300881Z","caller":"traceutil/trace.go:171","msg":"trace[309469388] linearizableReadLoop","detail":"{readStateIndex:8538; appliedIndex:8537; }","duration":"155.802317ms","start":"2026-08-26T07:17:59.145045Z","end":"2026-08-26T07:17:59.300848Z","steps":["trace[309469388] 'read index received' (duration: 155.437827ms)","trace[309469388] 'applied index is now lower than readState.Index' (duration: 363.23µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:17:59.300986Z","caller":"traceutil/trace.go:171","msg":"trace[1954768604] transaction","detail":"{read_only:false; response_revision:8250; number_of_response:1; }","duration":"205.602403ms","start":"2026-08-26T07:17:59.095316Z","end":"2026-08-26T07:17:59.300919Z","steps":["trace[1954768604] 'process raft request' (duration: 205.193772ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:59.301134Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.081304ms","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-26T07:17:59.301176Z","caller":"traceutil/trace.go:171","msg":"trace[821178468] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8250; }","duration":"156.186898ms","start":"2026-08-26T07:17:59.144977Z","end":"2026-08-26T07:17:59.301164Z","steps":["trace[821178468] 'agreement among raft nodes before linearized reading' (duration: 156.015353ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:17:59.301599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.032585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:17:59.301702Z","caller":"traceutil/trace.go:171","msg":"trace[128032691] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8250; }","duration":"109.56347ms","start":"2026-08-26T07:17:59.192115Z","end":"2026-08-26T07:17:59.301678Z","steps":["trace[128032691] 'agreement among raft nodes before linearized reading' (duration: 108.972864ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:00.066431Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.78006ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T07:18:00.066607Z","caller":"traceutil/trace.go:171","msg":"trace[1763941981] linearizableReadLoop","detail":"{readStateIndex:8544; appliedIndex:8542; }","duration":"237.281305ms","start":"2026-08-26T07:17:59.829309Z","end":"2026-08-26T07:18:00.066591Z","steps":["trace[1763941981] 'read index received' (duration: 4.259079ms)","trace[1763941981] 'applied index is now lower than readState.Index' (duration: 233.021346ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:18:00.066754Z","caller":"traceutil/trace.go:171","msg":"trace[647022841] transaction","detail":"{read_only:false; response_revision:8256; number_of_response:1; }","duration":"237.884222ms","start":"2026-08-26T07:17:59.82883Z","end":"2026-08-26T07:18:00.066714Z","steps":["trace[647022841] 'process raft request' (duration: 237.705447ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:00.066785Z","caller":"traceutil/trace.go:171","msg":"trace[506484363] transaction","detail":"{read_only:false; response_revision:8255; number_of_response:1; }","duration":"251.784679ms","start":"2026-08-26T07:17:59.814974Z","end":"2026-08-26T07:18:00.066759Z","steps":["trace[506484363] 'process raft request' (duration: 18.584627ms)","trace[506484363] 'compare' (duration: 232.681467ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:18:00.066953Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.644355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:222805"} {"level":"info","ts":"2026-08-26T07:18:00.066994Z","caller":"traceutil/trace.go:171","msg":"trace[1817386394] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8256; }","duration":"237.709787ms","start":"2026-08-26T07:17:59.829273Z","end":"2026-08-26T07:18:00.066983Z","steps":["trace[1817386394] 'agreement among raft nodes before linearized reading' (duration: 237.363177ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:00.929873Z","caller":"traceutil/trace.go:171","msg":"trace[2094208815] transaction","detail":"{read_only:false; response_revision:8257; number_of_response:1; }","duration":"123.56571ms","start":"2026-08-26T07:18:00.80627Z","end":"2026-08-26T07:18:00.929836Z","steps":["trace[2094208815] 'process raft request' (duration: 123.361934ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:00.970748Z","caller":"traceutil/trace.go:171","msg":"trace[1603286849] transaction","detail":"{read_only:false; response_revision:8258; number_of_response:1; }","duration":"115.505396ms","start":"2026-08-26T07:18:00.855215Z","end":"2026-08-26T07:18:00.970721Z","steps":["trace[1603286849] 'process raft request' (duration: 115.325631ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:05.04434Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6111} {"level":"info","ts":"2026-08-26T07:18:05.144878Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6111,"took":"98.243604ms","hash":3092948225,"current-db-size-bytes":59940864,"current-db-size":"60 MB","current-db-size-in-use-bytes":23273472,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-26T07:18:05.144981Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3092948225,"revision":6111,"compact-revision":2975} {"level":"info","ts":"2026-08-26T07:18:28.393473Z","caller":"traceutil/trace.go:171","msg":"trace[1245308162] linearizableReadLoop","detail":"{readStateIndex:8754; appliedIndex:8753; }","duration":"457.079937ms","start":"2026-08-26T07:18:27.936367Z","end":"2026-08-26T07:18:28.393447Z","steps":["trace[1245308162] 'read index received' (duration: 456.984564ms)","trace[1245308162] 'applied index is now lower than readState.Index' (duration: 94.002µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:18:28.393859Z","caller":"traceutil/trace.go:171","msg":"trace[558846614] transaction","detail":"{read_only:false; response_revision:8458; number_of_response:1; }","duration":"476.915559ms","start":"2026-08-26T07:18:27.916907Z","end":"2026-08-26T07:18:28.393822Z","steps":["trace[558846614] 'process raft request' (duration: 476.375204ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:28.393952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.57029ms","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-26T07:18:28.394029Z","caller":"traceutil/trace.go:171","msg":"trace[926829398] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8458; }","duration":"457.706764ms","start":"2026-08-26T07:18:27.936306Z","end":"2026-08-26T07:18:28.394012Z","steps":["trace[926829398] 'agreement among raft nodes before linearized reading' (duration: 457.473308ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:28.394069Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:18:27.936271Z","time spent":"457.788697ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-26T07:18:28.394091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:18:27.91685Z","time spent":"477.105644ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T07:18:28.39565Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"313.703385ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:19533"} {"level":"info","ts":"2026-08-26T07:18:28.395703Z","caller":"traceutil/trace.go:171","msg":"trace[1149220202] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:8459; }","duration":"313.795727ms","start":"2026-08-26T07:18:28.081894Z","end":"2026-08-26T07:18:28.395689Z","steps":["trace[1149220202] 'agreement among raft nodes before linearized reading' (duration: 313.616762ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:28.395746Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:18:28.081871Z","time spent":"313.867659ms","remote":"127.0.0.1:56298","response type":"/etcdserverpb.KV/Range","request count":0,"request size":28,"response count":1,"response size":19555,"request content":"key:\"/registry/minions/instance\" "} {"level":"warn","ts":"2026-08-26T07:18:28.395741Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.359198ms","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-26T07:18:28.395833Z","caller":"traceutil/trace.go:171","msg":"trace[1478457220] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8459; }","duration":"191.464201ms","start":"2026-08-26T07:18:28.204346Z","end":"2026-08-26T07:18:28.39581Z","steps":["trace[1478457220] 'agreement among raft nodes before linearized reading' (duration: 191.196444ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:28.395922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.637476ms","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-26T07:18:28.395991Z","caller":"traceutil/trace.go:171","msg":"trace[1161375394] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8459; }","duration":"191.76682ms","start":"2026-08-26T07:18:28.204208Z","end":"2026-08-26T07:18:28.395974Z","steps":["trace[1161375394] 'agreement among raft nodes before linearized reading' (duration: 191.576925ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:28.396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"294.187531ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/162.253.55.175\" ","response":"range_response_count:1 size:135"} {"level":"info","ts":"2026-08-26T07:18:28.396034Z","caller":"traceutil/trace.go:171","msg":"trace[2061351284] range","detail":"{range_begin:/registry/masterleases/162.253.55.175; range_end:; response_count:1; response_revision:8459; }","duration":"294.263023ms","start":"2026-08-26T07:18:28.101762Z","end":"2026-08-26T07:18:28.396025Z","steps":["trace[2061351284] 'agreement among raft nodes before linearized reading' (duration: 294.174871ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:28.396185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.306121ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hk79\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-26T07:18:28.396242Z","caller":"traceutil/trace.go:171","msg":"trace[2049448342] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hk79; range_end:; response_count:1; response_revision:8459; }","duration":"147.415425ms","start":"2026-08-26T07:18:28.24881Z","end":"2026-08-26T07:18:28.396225Z","steps":["trace[2049448342] 'agreement among raft nodes before linearized reading' (duration: 147.2235ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:28.396672Z","caller":"traceutil/trace.go:171","msg":"trace[884030734] transaction","detail":"{read_only:false; response_revision:8459; number_of_response:1; }","duration":"366.643569ms","start":"2026-08-26T07:18:28.030013Z","end":"2026-08-26T07:18:28.396656Z","steps":["trace[884030734] 'process raft request' (duration: 365.338263ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:28.396895Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:18:28.029979Z","time spent":"366.729151ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T07:18:30.519317Z","caller":"traceutil/trace.go:171","msg":"trace[1790443573] linearizableReadLoop","detail":"{readStateIndex:8766; appliedIndex:8765; }","duration":"115.28063ms","start":"2026-08-26T07:18:30.404012Z","end":"2026-08-26T07:18:30.519293Z","steps":["trace[1790443573] 'read index received' (duration: 115.061584ms)","trace[1790443573] 'applied index is now lower than readState.Index' (duration: 218.186µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:18:30.519389Z","caller":"traceutil/trace.go:171","msg":"trace[1057800938] transaction","detail":"{read_only:false; response_revision:8469; number_of_response:1; }","duration":"120.519146ms","start":"2026-08-26T07:18:30.398838Z","end":"2026-08-26T07:18:30.519357Z","steps":["trace[1057800938] 'process raft request' (duration: 120.30993ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:30.519558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.524057ms","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-26T07:18:30.519594Z","caller":"traceutil/trace.go:171","msg":"trace[966368293] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8469; }","duration":"115.613769ms","start":"2026-08-26T07:18:30.40397Z","end":"2026-08-26T07:18:30.519583Z","steps":["trace[966368293] 'agreement among raft nodes before linearized reading' (duration: 115.465435ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:30.519669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.343222ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-08-26T07:18:30.519698Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.240548ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hk79\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-26T07:18:30.519748Z","caller":"traceutil/trace.go:171","msg":"trace[640506367] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8469; }","duration":"115.458945ms","start":"2026-08-26T07:18:30.404267Z","end":"2026-08-26T07:18:30.519726Z","steps":["trace[640506367] 'agreement among raft nodes before linearized reading' (duration: 115.216198ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:30.519772Z","caller":"traceutil/trace.go:171","msg":"trace[1844720739] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hk79; range_end:; response_count:1; response_revision:8469; }","duration":"111.33875ms","start":"2026-08-26T07:18:30.408416Z","end":"2026-08-26T07:18:30.519754Z","steps":["trace[1844720739] 'agreement among raft nodes before linearized reading' (duration: 111.129184ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:30.519745Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.732505ms","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-26T07:18:30.519929Z","caller":"traceutil/trace.go:171","msg":"trace[1848633338] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8469; }","duration":"114.91221ms","start":"2026-08-26T07:18:30.404978Z","end":"2026-08-26T07:18:30.51989Z","steps":["trace[1848633338] 'agreement among raft nodes before linearized reading' (duration: 114.586401ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:38.730293Z","caller":"traceutil/trace.go:171","msg":"trace[690324392] linearizableReadLoop","detail":"{readStateIndex:8814; appliedIndex:8813; }","duration":"122.603374ms","start":"2026-08-26T07:18:38.607657Z","end":"2026-08-26T07:18:38.730261Z","steps":["trace[690324392] 'read index received' (duration: 119.573929ms)","trace[690324392] 'applied index is now lower than readState.Index' (duration: 3.028085ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:18:38.730429Z","caller":"traceutil/trace.go:171","msg":"trace[1307150413] transaction","detail":"{read_only:false; response_revision:8515; number_of_response:1; }","duration":"152.610959ms","start":"2026-08-26T07:18:38.577803Z","end":"2026-08-26T07:18:38.730414Z","steps":["trace[1307150413] 'process raft request' (duration: 149.442031ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:38.7308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.432459ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-08-26T07:18:38.73083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.161659ms","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-26T07:18:38.730869Z","caller":"traceutil/trace.go:171","msg":"trace[829199212] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8515; }","duration":"122.542792ms","start":"2026-08-26T07:18:38.608311Z","end":"2026-08-26T07:18:38.730853Z","steps":["trace[829199212] 'agreement among raft nodes before linearized reading' (duration: 122.369487ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:18:38.730887Z","caller":"traceutil/trace.go:171","msg":"trace[1099760034] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8515; }","duration":"123.257882ms","start":"2026-08-26T07:18:38.607614Z","end":"2026-08-26T07:18:38.730872Z","steps":["trace[1099760034] 'agreement among raft nodes before linearized reading' (duration: 123.100867ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:38.730891Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.518842ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-5hk79\" ","response":"range_response_count:1 size:6445"} {"level":"info","ts":"2026-08-26T07:18:38.730948Z","caller":"traceutil/trace.go:171","msg":"trace[285871839] range","detail":"{range_begin:/registry/pods/openstack/keepalived-5hk79; range_end:; response_count:1; response_revision:8515; }","duration":"117.609894ms","start":"2026-08-26T07:18:38.613323Z","end":"2026-08-26T07:18:38.730933Z","steps":["trace[285871839] 'agreement among raft nodes before linearized reading' (duration: 117.394638ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:18:40.804058Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.978957ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T07:18:40.805006Z","caller":"traceutil/trace.go:171","msg":"trace[105627581] transaction","detail":"{read_only:false; response_revision:8534; number_of_response:1; }","duration":"212.858846ms","start":"2026-08-26T07:18:40.592111Z","end":"2026-08-26T07:18:40.80497Z","steps":["trace[105627581] 'process raft request' (duration: 94.855821ms)","trace[105627581] 'compare' (duration: 116.867584ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:18:56.601178Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002328.wal"} {"level":"info","ts":"2026-08-26T07:20:03.360825Z","caller":"traceutil/trace.go:171","msg":"trace[1600449680] linearizableReadLoop","detail":"{readStateIndex:9668; appliedIndex:9667; }","duration":"116.574616ms","start":"2026-08-26T07:20:03.244227Z","end":"2026-08-26T07:20:03.360801Z","steps":["trace[1600449680] 'read index received' (duration: 116.36784ms)","trace[1600449680] 'applied index is now lower than readState.Index' (duration: 202.846µs)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:20:03.361239Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.998027ms","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-26T07:20:03.361309Z","caller":"traceutil/trace.go:171","msg":"trace[359559886] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:9346; }","duration":"117.10346ms","start":"2026-08-26T07:20:03.244187Z","end":"2026-08-26T07:20:03.361291Z","steps":["trace[359559886] 'agreement among raft nodes before linearized reading' (duration: 116.930976ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:20:03.361295Z","caller":"traceutil/trace.go:171","msg":"trace[1601876798] transaction","detail":"{read_only:false; response_revision:9346; number_of_response:1; }","duration":"118.838399ms","start":"2026-08-26T07:20:03.242425Z","end":"2026-08-26T07:20:03.361263Z","steps":["trace[1601876798] 'process raft request' (duration: 118.224862ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:20:03.361303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.536139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-08-26T07:20:03.361442Z","caller":"traceutil/trace.go:171","msg":"trace[1279816483] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:9346; }","duration":"114.731425ms","start":"2026-08-26T07:20:03.246688Z","end":"2026-08-26T07:20:03.361419Z","steps":["trace[1279816483] 'agreement among raft nodes before linearized reading' (duration: 114.426977ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:20:03.628306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"228.601404ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T07:20:03.628476Z","caller":"traceutil/trace.go:171","msg":"trace[399408767] linearizableReadLoop","detail":"{readStateIndex:9670; appliedIndex:9668; }","duration":"262.483128ms","start":"2026-08-26T07:20:03.365977Z","end":"2026-08-26T07:20:03.62846Z","steps":["trace[399408767] 'read index received' (duration: 33.658867ms)","trace[399408767] 'applied index is now lower than readState.Index' (duration: 228.823141ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:20:03.628641Z","caller":"traceutil/trace.go:171","msg":"trace[858954234] transaction","detail":"{read_only:false; response_revision:9347; number_of_response:1; }","duration":"262.783747ms","start":"2026-08-26T07:20:03.365805Z","end":"2026-08-26T07:20:03.628588Z","steps":["trace[858954234] 'process raft request' (duration: 33.819082ms)","trace[858954234] 'compare' (duration: 228.487811ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:20:03.62888Z","caller":"traceutil/trace.go:171","msg":"trace[1756774109] transaction","detail":"{read_only:false; response_revision:9348; number_of_response:1; }","duration":"262.676333ms","start":"2026-08-26T07:20:03.365903Z","end":"2026-08-26T07:20:03.62858Z","steps":["trace[1756774109] 'process raft request' (duration: 262.505659ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:20:03.629192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.158067ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:31 size:289864"} {"level":"info","ts":"2026-08-26T07:20:03.629286Z","caller":"traceutil/trace.go:171","msg":"trace[1823096132] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:31; response_revision:9348; }","duration":"263.331242ms","start":"2026-08-26T07:20:03.365933Z","end":"2026-08-26T07:20:03.629264Z","steps":["trace[1823096132] 'agreement among raft nodes before linearized reading' (duration: 262.661733ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:20:03.649944Z","caller":"traceutil/trace.go:171","msg":"trace[1176768008] transaction","detail":"{read_only:false; response_revision:9349; number_of_response:1; }","duration":"206.311535ms","start":"2026-08-26T07:20:03.443612Z","end":"2026-08-26T07:20:03.649923Z","steps":["trace[1176768008] 'process raft request' (duration: 206.030867ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:20:03.649986Z","caller":"traceutil/trace.go:171","msg":"trace[1339795122] transaction","detail":"{read_only:false; response_revision:9350; number_of_response:1; }","duration":"201.340736ms","start":"2026-08-26T07:20:03.448612Z","end":"2026-08-26T07:20:03.649952Z","steps":["trace[1339795122] 'process raft request' (duration: 201.228192ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:20:47.874521Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5420a740f4813dc9","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-26T07:20:47.880271Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-26T07:20:47.880426Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-26T07:23:05.051045Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8285} {"level":"info","ts":"2026-08-26T07:23:05.126378Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8285,"took":"73.09804ms","hash":487627915,"current-db-size-bytes":59940864,"current-db-size":"60 MB","current-db-size-in-use-bytes":25481216,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-26T07:23:05.126446Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":487627915,"revision":8285,"compact-revision":6111} {"level":"info","ts":"2026-08-26T07:28:05.058778Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10767} {"level":"info","ts":"2026-08-26T07:28:05.139476Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10767,"took":"78.08813ms","hash":1081331731,"current-db-size-bytes":59940864,"current-db-size":"60 MB","current-db-size-in-use-bytes":27758592,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-26T07:28:05.139529Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1081331731,"revision":10767,"compact-revision":8285} {"level":"info","ts":"2026-08-26T07:30:29.367616Z","caller":"traceutil/trace.go:171","msg":"trace[1240303271] transaction","detail":"{read_only:false; response_revision:13874; number_of_response:1; }","duration":"286.925403ms","start":"2026-08-26T07:30:29.08066Z","end":"2026-08-26T07:30:29.367585Z","steps":["trace[1240303271] 'process raft request' (duration: 286.755668ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:30:29.402123Z","caller":"traceutil/trace.go:171","msg":"trace[794015540] linearizableReadLoop","detail":"{readStateIndex:14347; appliedIndex:14345; }","duration":"210.449387ms","start":"2026-08-26T07:30:29.191646Z","end":"2026-08-26T07:30:29.402096Z","steps":["trace[794015540] 'read index received' (duration: 175.752654ms)","trace[794015540] 'applied index is now lower than readState.Index' (duration: 34.695783ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:30:29.402253Z","caller":"traceutil/trace.go:171","msg":"trace[2096970080] transaction","detail":"{read_only:false; response_revision:13875; number_of_response:1; }","duration":"248.609998ms","start":"2026-08-26T07:30:29.153633Z","end":"2026-08-26T07:30:29.402243Z","steps":["trace[2096970080] 'process raft request' (duration: 247.772754ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:30:29.402344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.42594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/namespaces/\" range_end:\"/registry/namespaces0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-26T07:30:29.402436Z","caller":"traceutil/trace.go:171","msg":"trace[2020067287] range","detail":"{range_begin:/registry/namespaces/; range_end:/registry/namespaces0; response_count:0; response_revision:13875; }","duration":"208.546654ms","start":"2026-08-26T07:30:29.19387Z","end":"2026-08-26T07:30:29.402416Z","steps":["trace[2020067287] 'agreement among raft nodes before linearized reading' (duration: 208.40503ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:30:29.402649Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.536286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/alertmanagers/\" range_end:\"/registry/monitoring.coreos.com/alertmanagers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-26T07:30:29.402709Z","caller":"traceutil/trace.go:171","msg":"trace[1584254366] range","detail":"{range_begin:/registry/monitoring.coreos.com/alertmanagers/; range_end:/registry/monitoring.coreos.com/alertmanagers0; response_count:0; response_revision:13875; }","duration":"108.646819ms","start":"2026-08-26T07:30:29.294047Z","end":"2026-08-26T07:30:29.402694Z","steps":["trace[1584254366] 'agreement among raft nodes before linearized reading' (duration: 108.540486ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:30:29.402758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.103785ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:30:29.402818Z","caller":"traceutil/trace.go:171","msg":"trace[1571112222] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:13875; }","duration":"211.192888ms","start":"2026-08-26T07:30:29.191614Z","end":"2026-08-26T07:30:29.402807Z","steps":["trace[1571112222] 'agreement among raft nodes before linearized reading' (duration: 211.111176ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:30:39.049276Z","caller":"traceutil/trace.go:171","msg":"trace[799266306] linearizableReadLoop","detail":"{readStateIndex:14516; appliedIndex:14515; }","duration":"242.234931ms","start":"2026-08-26T07:30:38.807018Z","end":"2026-08-26T07:30:39.049253Z","steps":["trace[799266306] 'read index received' (duration: 241.962273ms)","trace[799266306] 'applied index is now lower than readState.Index' (duration: 271.978µs)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:30:39.049804Z","caller":"traceutil/trace.go:171","msg":"trace[676865086] transaction","detail":"{read_only:false; response_revision:14040; number_of_response:1; }","duration":"247.297271ms","start":"2026-08-26T07:30:38.802497Z","end":"2026-08-26T07:30:39.049794Z","steps":["trace[676865086] 'process raft request' (duration: 246.585631ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:30:39.050054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.997512ms","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-26T07:30:39.050171Z","caller":"traceutil/trace.go:171","msg":"trace[294192555] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:14040; }","duration":"243.173677ms","start":"2026-08-26T07:30:38.80697Z","end":"2026-08-26T07:30:39.050144Z","steps":["trace[294192555] 'agreement among raft nodes before linearized reading' (duration: 242.813027ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:31:43.771927Z","caller":"traceutil/trace.go:171","msg":"trace[1852346779] transaction","detail":"{read_only:false; response_revision:14941; number_of_response:1; }","duration":"111.573058ms","start":"2026-08-26T07:31:43.660314Z","end":"2026-08-26T07:31:43.771887Z","steps":["trace[1852346779] 'process raft request' (duration: 51.752827ms)","trace[1852346779] 'compare' (duration: 59.574595ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:32:06.355598Z","caller":"traceutil/trace.go:171","msg":"trace[1209625660] transaction","detail":"{read_only:false; response_revision:15063; number_of_response:1; }","duration":"214.093266ms","start":"2026-08-26T07:32:06.141476Z","end":"2026-08-26T07:32:06.355569Z","steps":["trace[1209625660] 'process raft request' (duration: 213.912881ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:32:06.833386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.878965ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-26T07:32:06.833652Z","caller":"traceutil/trace.go:171","msg":"trace[1358828814] linearizableReadLoop","detail":"{readStateIndex:15571; appliedIndex:15569; }","duration":"629.312526ms","start":"2026-08-26T07:32:06.204317Z","end":"2026-08-26T07:32:06.83363Z","steps":["trace[1358828814] 'read index received' (duration: 151.354533ms)","trace[1358828814] 'applied index is now lower than readState.Index' (duration: 477.956983ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:32:06.833781Z","caller":"traceutil/trace.go:171","msg":"trace[1227115020] transaction","detail":"{read_only:false; response_revision:15064; number_of_response:1; }","duration":"658.383914ms","start":"2026-08-26T07:32:06.175382Z","end":"2026-08-26T07:32:06.833766Z","steps":["trace[1227115020] 'process raft request' (duration: 505.046796ms)","trace[1227115020] 'compare' (duration: 152.576327ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:32:06.833872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:32:06.175357Z","time spent":"658.466896ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-26T07:32:06.833897Z","caller":"traceutil/trace.go:171","msg":"trace[364318504] transaction","detail":"{read_only:false; response_revision:15066; number_of_response:1; }","duration":"515.720781ms","start":"2026-08-26T07:32:06.318139Z","end":"2026-08-26T07:32:06.83386Z","steps":["trace[364318504] 'process raft request' (duration: 515.433673ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:32:06.8341Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:32:06.318113Z","time spent":"515.875536ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T07:32:06.834155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"629.83037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-26T07:32:06.834199Z","caller":"traceutil/trace.go:171","msg":"trace[1926343439] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15066; }","duration":"629.908813ms","start":"2026-08-26T07:32:06.204278Z","end":"2026-08-26T07:32:06.834186Z","steps":["trace[1926343439] 'agreement among raft nodes before linearized reading' (duration: 629.81562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:32:06.834235Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:32:06.204262Z","time spent":"629.965735ms","remote":"127.0.0.1:56372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":0,"response size":27,"request content":"key:\"/registry/jobs/openstack/nova-rabbit-init\" "} {"level":"warn","ts":"2026-08-26T07:32:06.834507Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"627.961029ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-08-26T07:32:06.834547Z","caller":"traceutil/trace.go:171","msg":"trace[361147536] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15066; }","duration":"628.02073ms","start":"2026-08-26T07:32:06.206517Z","end":"2026-08-26T07:32:06.834537Z","steps":["trace[361147536] 'agreement among raft nodes before linearized reading' (duration: 627.901047ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:32:06.83458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:32:06.206507Z","time spent":"628.066921ms","remote":"127.0.0.1:56288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":49,"response count":1,"response size":690,"request content":"key:\"/registry/services/endpoints/openstack/nova-api\" "} {"level":"info","ts":"2026-08-26T07:32:06.834582Z","caller":"traceutil/trace.go:171","msg":"trace[1331102729] transaction","detail":"{read_only:false; response_revision:15065; number_of_response:1; }","duration":"647.706087ms","start":"2026-08-26T07:32:06.186859Z","end":"2026-08-26T07:32:06.834565Z","steps":["trace[1331102729] 'process raft request' (duration: 646.644968ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:32:06.834691Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:32:06.186834Z","time spent":"647.80523ms","remote":"127.0.0.1:56404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":474,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-26T07:32:06.834852Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"626.302893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5448"} {"level":"info","ts":"2026-08-26T07:32:06.834901Z","caller":"traceutil/trace.go:171","msg":"trace[1192861464] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15066; }","duration":"626.367234ms","start":"2026-08-26T07:32:06.208521Z","end":"2026-08-26T07:32:06.834889Z","steps":["trace[1192861464] 'agreement among raft nodes before linearized reading' (duration: 626.269311ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:32:06.834943Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-26T07:32:06.208511Z","time spent":"626.418396ms","remote":"127.0.0.1:56372","response type":"/etcdserverpb.KV/Range","request count":0,"request size":39,"response count":1,"response size":5470,"request content":"key:\"/registry/jobs/openstack/nova-db-sync\" "} {"level":"info","ts":"2026-08-26T07:33:05.064014Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12945} {"level":"info","ts":"2026-08-26T07:33:05.138728Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12945,"took":"71.827575ms","hash":3969258063,"current-db-size-bytes":59940864,"current-db-size":"60 MB","current-db-size-in-use-bytes":31072256,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-26T07:33:05.138793Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3969258063,"revision":12945,"compact-revision":10767} {"level":"info","ts":"2026-08-26T07:38:02.312541Z","caller":"traceutil/trace.go:171","msg":"trace[1408696843] linearizableReadLoop","detail":"{readStateIndex:18266; appliedIndex:18265; }","duration":"200.810651ms","start":"2026-08-26T07:38:02.111703Z","end":"2026-08-26T07:38:02.312514Z","steps":["trace[1408696843] 'read index received' (duration: 143.240181ms)","trace[1408696843] 'applied index is now lower than readState.Index' (duration: 57.56942ms)"],"step_count":2} {"level":"info","ts":"2026-08-26T07:38:02.312883Z","caller":"traceutil/trace.go:171","msg":"trace[1846548580] transaction","detail":"{read_only:false; response_revision:17674; number_of_response:1; }","duration":"265.399575ms","start":"2026-08-26T07:38:02.047468Z","end":"2026-08-26T07:38:02.312867Z","steps":["trace[1846548580] 'process raft request' (duration: 207.431334ms)","trace[1846548580] 'compare' (duration: 57.505639ms)"],"step_count":2} {"level":"warn","ts":"2026-08-26T07:38:02.313037Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.338186ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/bindings/\" range_end:\"/registry/rabbitmq.com/bindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-26T07:38:02.313098Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.006031ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:1 size:4521"} {"level":"warn","ts":"2026-08-26T07:38:02.3131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.374286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/cluster-admin\" ","response":"range_response_count:1 size:554"} {"level":"info","ts":"2026-08-26T07:38:02.313188Z","caller":"traceutil/trace.go:171","msg":"trace[802563291] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:1; response_revision:17674; }","duration":"185.146385ms","start":"2026-08-26T07:38:02.128021Z","end":"2026-08-26T07:38:02.313167Z","steps":["trace[802563291] 'agreement among raft nodes before linearized reading' (duration: 184.898998ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:38:02.313201Z","caller":"traceutil/trace.go:171","msg":"trace[2144387025] range","detail":"{range_begin:/registry/clusterroles/cluster-admin; range_end:; response_count:1; response_revision:17674; }","duration":"201.51119ms","start":"2026-08-26T07:38:02.111666Z","end":"2026-08-26T07:38:02.313177Z","steps":["trace[2144387025] 'agreement among raft nodes before linearized reading' (duration: 201.250053ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:38:02.313242Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.246678ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-26T07:38:02.313281Z","caller":"traceutil/trace.go:171","msg":"trace[68546992] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:17674; }","duration":"180.309441ms","start":"2026-08-26T07:38:02.132961Z","end":"2026-08-26T07:38:02.31327Z","steps":["trace[68546992] 'agreement among raft nodes before linearized reading' (duration: 180.248129ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:38:02.313126Z","caller":"traceutil/trace.go:171","msg":"trace[994242741] range","detail":"{range_begin:/registry/rabbitmq.com/bindings/; range_end:/registry/rabbitmq.com/bindings0; response_count:0; response_revision:17674; }","duration":"128.47514ms","start":"2026-08-26T07:38:02.18463Z","end":"2026-08-26T07:38:02.313105Z","steps":["trace[994242741] 'agreement among raft nodes before linearized reading' (duration: 128.326306ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:38:02.637353Z","caller":"traceutil/trace.go:171","msg":"trace[711889266] transaction","detail":"{read_only:false; response_revision:17675; number_of_response:1; }","duration":"115.082868ms","start":"2026-08-26T07:38:02.522228Z","end":"2026-08-26T07:38:02.637311Z","steps":["trace[711889266] 'process raft request' (duration: 114.887232ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:38:03.135488Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.489368ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-26T07:38:03.13555Z","caller":"traceutil/trace.go:171","msg":"trace[370596791] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17676; }","duration":"125.579299ms","start":"2026-08-26T07:38:03.009956Z","end":"2026-08-26T07:38:03.135535Z","steps":["trace[370596791] 'range keys from in-memory index tree' (duration: 125.422305ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:38:03.135913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.902314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/kube-prometheus-stack-kube-state-metrics\" ","response":"range_response_count:1 size:2308"} {"level":"info","ts":"2026-08-26T07:38:03.136052Z","caller":"traceutil/trace.go:171","msg":"trace[1964493432] range","detail":"{range_begin:/registry/clusterroles/kube-prometheus-stack-kube-state-metrics; range_end:; response_count:1; response_revision:17676; }","duration":"205.10873ms","start":"2026-08-26T07:38:02.930916Z","end":"2026-08-26T07:38:03.136024Z","steps":["trace[1964493432] 'range keys from in-memory index tree' (duration: 204.701849ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:38:03.136206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.010757ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/kube-prometheus-stack-grafana-clusterrole\" ","response":"range_response_count:1 size:959"} {"level":"info","ts":"2026-08-26T07:38:03.136277Z","caller":"traceutil/trace.go:171","msg":"trace[504613161] range","detail":"{range_begin:/registry/clusterroles/kube-prometheus-stack-grafana-clusterrole; range_end:; response_count:1; response_revision:17676; }","duration":"205.10385ms","start":"2026-08-26T07:38:02.931155Z","end":"2026-08-26T07:38:03.136259Z","steps":["trace[504613161] 'range keys from in-memory index tree' (duration: 204.862123ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:38:03.374836Z","caller":"traceutil/trace.go:171","msg":"trace[1647444300] transaction","detail":"{read_only:false; response_revision:17679; number_of_response:1; }","duration":"141.047288ms","start":"2026-08-26T07:38:03.233769Z","end":"2026-08-26T07:38:03.374816Z","steps":["trace[1647444300] 'process raft request' (duration: 140.901434ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:38:03.37513Z","caller":"traceutil/trace.go:171","msg":"trace[580146324] transaction","detail":"{read_only:false; response_revision:17680; number_of_response:1; }","duration":"141.225883ms","start":"2026-08-26T07:38:03.23381Z","end":"2026-08-26T07:38:03.375036Z","steps":["trace[580146324] 'process raft request' (duration: 140.965536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-26T07:38:03.375183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.588307ms","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-26T07:38:03.3754Z","caller":"traceutil/trace.go:171","msg":"trace[1885792400] range","detail":"{range_begin:/registry/configmaps/openstack/rook-ceph-pdbstatemap; range_end:; response_count:1; response_revision:17680; }","duration":"108.801853ms","start":"2026-08-26T07:38:03.26657Z","end":"2026-08-26T07:38:03.375372Z","steps":["trace[1885792400] 'agreement among raft nodes before linearized reading' (duration: 108.447023ms)"],"step_count":1} {"level":"info","ts":"2026-08-26T07:38:05.072352Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15429} {"level":"info","ts":"2026-08-26T07:38:05.173333Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15429,"took":"98.647261ms","hash":985730831,"current-db-size-bytes":59940864,"current-db-size":"60 MB","current-db-size-in-use-bytes":31981568,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-26T07:38:05.17345Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":985730831,"revision":15429,"compact-revision":12945}