{"level":"warn","ts":"2026-06-02T06:55:43.692459Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:55:43.692536Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.38:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.38:2380","--initial-cluster=instance=https://199.204.45.38:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.38:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.38:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-02T06:55:43.692597Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-02T06:55:43.692605Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-06-02T06:55:43.69262Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T06:55:43.693298Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"]} {"level":"info","ts":"2026-06-02T06:55:43.693376Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.38:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-02T06:55:43.697932Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.314734ms"} {"level":"info","ts":"2026-06-02T06:55:43.70381Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"331455d6226d3423","cluster-id":"25c7803fb83a1455"} {"level":"info","ts":"2026-06-02T06:55:43.703885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=()"} {"level":"info","ts":"2026-06-02T06:55:43.703903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 0"} {"level":"info","ts":"2026-06-02T06:55:43.703917Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 331455d6226d3423 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-02T06:55:43.703931Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became follower at term 1"} {"level":"info","ts":"2026-06-02T06:55:43.703971Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"warn","ts":"2026-06-02T06:55:43.711608Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-02T06:55:43.713844Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-02T06:55:43.715686Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-02T06:55:43.718143Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"331455d6226d3423","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-02T06:55:43.718607Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"331455d6226d3423","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-02T06:55:43.718731Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T06:55:43.718791Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T06:55:43.718803Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-02T06:55:43.719463Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 switched to configuration voters=(3680661173657482275)"} {"level":"info","ts":"2026-06-02T06:55:43.719584Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","added-peer-id":"331455d6226d3423","added-peer-peer-urls":["https://199.204.45.38:2380"]} {"level":"info","ts":"2026-06-02T06:55:43.722467Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-02T06:55:43.722591Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-06-02T06:55:43.722626Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.38:2380"} {"level":"info","ts":"2026-06-02T06:55:43.722819Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"331455d6226d3423","initial-advertise-peer-urls":["https://199.204.45.38:2380"],"listen-peer-urls":["https://199.204.45.38:2380"],"advertise-client-urls":["https://199.204.45.38:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.38:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-02T06:55:43.722855Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-02T06:55:44.204464Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 is starting a new election at term 1"} {"level":"info","ts":"2026-06-02T06:55:44.204535Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-02T06:55:44.204576Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgPreVoteResp from 331455d6226d3423 at term 1"} {"level":"info","ts":"2026-06-02T06:55:44.204594Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became candidate at term 2"} {"level":"info","ts":"2026-06-02T06:55:44.204605Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 received MsgVoteResp from 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-06-02T06:55:44.204621Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"331455d6226d3423 became leader at term 2"} {"level":"info","ts":"2026-06-02T06:55:44.204634Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 331455d6226d3423 elected leader 331455d6226d3423 at term 2"} {"level":"info","ts":"2026-06-02T06:55:44.207621Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:55:44.208693Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:55:44.208687Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"331455d6226d3423","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.38:2379]}","request-path":"/0/members/331455d6226d3423/attributes","cluster-id":"25c7803fb83a1455","publish-timeout":"7s"} {"level":"info","ts":"2026-06-02T06:55:44.20875Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-02T06:55:44.209119Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-02T06:55:44.20921Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-02T06:55:44.210428Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"25c7803fb83a1455","local-member-id":"331455d6226d3423","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:55:44.210573Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:55:44.210618Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-02T06:55:44.211051Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-02T06:55:44.215201Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.38:2379"} {"level":"info","ts":"2026-06-02T06:55:46.808961Z","caller":"traceutil/trace.go:171","msg":"trace[1618749159] transaction","detail":"{read_only:false; response_revision:102; number_of_response:1; }","duration":"114.917081ms","start":"2026-06-02T06:55:46.694017Z","end":"2026-06-02T06:55:46.808935Z","steps":["trace[1618749159] 'process raft request' (duration: 105.614513ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:59.206729Z","caller":"traceutil/trace.go:171","msg":"trace[1294320805] transaction","detail":"{read_only:false; response_revision:368; number_of_response:1; }","duration":"162.564215ms","start":"2026-06-02T06:55:59.044134Z","end":"2026-06-02T06:55:59.206698Z","steps":["trace[1294320805] 'process raft request' (duration: 162.376571ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:59.206738Z","caller":"traceutil/trace.go:171","msg":"trace[106418712] linearizableReadLoop","detail":"{readStateIndex:381; appliedIndex:380; }","duration":"156.694622ms","start":"2026-06-02T06:55:59.050017Z","end":"2026-06-02T06:55:59.206712Z","steps":["trace[106418712] 'read index received' (duration: 156.55816ms)","trace[106418712] 'applied index is now lower than readState.Index' (duration: 135.192µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:55:59.2069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.863625ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-06-02T06:55:59.207001Z","caller":"traceutil/trace.go:171","msg":"trace[947929220] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:368; }","duration":"156.998628ms","start":"2026-06-02T06:55:59.049974Z","end":"2026-06-02T06:55:59.206973Z","steps":["trace[947929220] 'agreement among raft nodes before linearized reading' (duration: 156.828765ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:55:59.318076Z","caller":"traceutil/trace.go:171","msg":"trace[704355928] transaction","detail":"{read_only:false; response_revision:369; number_of_response:1; }","duration":"106.855807ms","start":"2026-06-02T06:55:59.211181Z","end":"2026-06-02T06:55:59.318037Z","steps":["trace[704355928] 'process raft request' (duration: 87.586239ms)","trace[704355928] 'compare' (duration: 19.049464ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:55:59.31823Z","caller":"traceutil/trace.go:171","msg":"trace[1479066958] transaction","detail":"{read_only:false; response_revision:370; number_of_response:1; }","duration":"100.450453ms","start":"2026-06-02T06:55:59.217748Z","end":"2026-06-02T06:55:59.318198Z","steps":["trace[1479066958] 'process raft request' (duration: 100.25436ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.565793Z","caller":"traceutil/trace.go:171","msg":"trace[1300417334] transaction","detail":"{read_only:false; response_revision:494; number_of_response:1; }","duration":"102.167537ms","start":"2026-06-02T06:56:22.463598Z","end":"2026-06-02T06:56:22.565766Z","steps":["trace[1300417334] 'process raft request' (duration: 102.007444ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.628699Z","caller":"traceutil/trace.go:171","msg":"trace[851194894] transaction","detail":"{read_only:false; response_revision:495; number_of_response:1; }","duration":"162.012035ms","start":"2026-06-02T06:56:22.466653Z","end":"2026-06-02T06:56:22.628665Z","steps":["trace[851194894] 'process raft request' (duration: 150.380911ms)","trace[851194894] 'compare' (duration: 11.346727ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:22.629529Z","caller":"traceutil/trace.go:171","msg":"trace[2078703762] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"156.444957ms","start":"2026-06-02T06:56:22.472983Z","end":"2026-06-02T06:56:22.629428Z","steps":["trace[2078703762] 'process raft request' (duration: 155.604661ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.62976Z","caller":"traceutil/trace.go:171","msg":"trace[1593612909] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"154.831876ms","start":"2026-06-02T06:56:22.474909Z","end":"2026-06-02T06:56:22.629741Z","steps":["trace[1593612909] 'process raft request' (duration: 154.485079ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.629852Z","caller":"traceutil/trace.go:171","msg":"trace[1190180870] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"154.929318ms","start":"2026-06-02T06:56:22.474908Z","end":"2026-06-02T06:56:22.629837Z","steps":["trace[1190180870] 'process raft request' (duration: 154.378257ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.629913Z","caller":"traceutil/trace.go:171","msg":"trace[1469558884] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"112.340473ms","start":"2026-06-02T06:56:22.517547Z","end":"2026-06-02T06:56:22.629887Z","steps":["trace[1469558884] 'process raft request' (duration: 112.273441ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.629984Z","caller":"traceutil/trace.go:171","msg":"trace[989765811] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"152.773936ms","start":"2026-06-02T06:56:22.477197Z","end":"2026-06-02T06:56:22.629971Z","steps":["trace[989765811] 'process raft request' (duration: 152.44801ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.630003Z","caller":"traceutil/trace.go:171","msg":"trace[1568408510] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"141.927529ms","start":"2026-06-02T06:56:22.488047Z","end":"2026-06-02T06:56:22.629975Z","steps":["trace[1568408510] 'process raft request' (duration: 141.650944ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.630032Z","caller":"traceutil/trace.go:171","msg":"trace[2122363120] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"154.360017ms","start":"2026-06-02T06:56:22.47566Z","end":"2026-06-02T06:56:22.63002Z","steps":["trace[2122363120] 'process raft request' (duration: 153.880588ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.630074Z","caller":"traceutil/trace.go:171","msg":"trace[640412695] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"140.821088ms","start":"2026-06-02T06:56:22.489239Z","end":"2026-06-02T06:56:22.63006Z","steps":["trace[640412695] 'process raft request' (duration: 140.518172ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.630097Z","caller":"traceutil/trace.go:171","msg":"trace[408453087] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"152.920809ms","start":"2026-06-02T06:56:22.477164Z","end":"2026-06-02T06:56:22.630085Z","steps":["trace[408453087] 'process raft request' (duration: 152.43176ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.971479Z","caller":"traceutil/trace.go:171","msg":"trace[1153500665] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"336.610927ms","start":"2026-06-02T06:56:22.634822Z","end":"2026-06-02T06:56:22.971433Z","steps":["trace[1153500665] 'process raft request' (duration: 335.938754ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.971147Z","caller":"traceutil/trace.go:171","msg":"trace[1348372359] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"342.581401ms","start":"2026-06-02T06:56:22.628264Z","end":"2026-06-02T06:56:22.970845Z","steps":["trace[1348372359] 'process raft request' (duration: 305.493793ms)","trace[1348372359] 'compare' (duration: 35.65505ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:22.971648Z","caller":"traceutil/trace.go:171","msg":"trace[987971055] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"332.893886ms","start":"2026-06-02T06:56:22.638689Z","end":"2026-06-02T06:56:22.971583Z","steps":["trace[987971055] 'process raft request' (duration: 332.252303ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.971659Z","caller":"traceutil/trace.go:171","msg":"trace[639656003] transaction","detail":"{read_only:false; response_revision:508; number_of_response:1; }","duration":"337.114335ms","start":"2026-06-02T06:56:22.634405Z","end":"2026-06-02T06:56:22.971519Z","steps":["trace[639656003] 'process raft request' (duration: 336.189257ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.971772Z","caller":"traceutil/trace.go:171","msg":"trace[1033934538] transaction","detail":"{read_only:false; response_revision:511; number_of_response:1; }","duration":"329.828197ms","start":"2026-06-02T06:56:22.641819Z","end":"2026-06-02T06:56:22.971647Z","steps":["trace[1033934538] 'process raft request' (duration: 329.416099ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.972358Z","caller":"traceutil/trace.go:171","msg":"trace[271839415] transaction","detail":"{read_only:false; response_revision:512; number_of_response:1; }","duration":"324.681408ms","start":"2026-06-02T06:56:22.647152Z","end":"2026-06-02T06:56:22.971833Z","steps":["trace[271839415] 'process raft request' (duration: 324.23604ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:22.973345Z","caller":"traceutil/trace.go:171","msg":"trace[1740706336] transaction","detail":"{read_only:false; response_revision:513; number_of_response:1; }","duration":"324.850682ms","start":"2026-06-02T06:56:22.648462Z","end":"2026-06-02T06:56:22.973312Z","steps":["trace[1740706336] 'process raft request' (duration: 324.597307ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:22.973796Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.634805Z","time spent":"336.751869ms","remote":"127.0.0.1:44646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":980,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:56:22.973846Z","caller":"traceutil/trace.go:171","msg":"trace[1029552470] transaction","detail":"{read_only:false; response_revision:514; number_of_response:1; }","duration":"320.945318ms","start":"2026-06-02T06:56:22.652878Z","end":"2026-06-02T06:56:22.973823Z","steps":["trace[1029552470] 'process raft request' (duration: 320.456809ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:22.974108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.628236Z","time spent":"343.330276ms","remote":"127.0.0.1:44104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:56:22.974236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.652863Z","time spent":"321.04203ms","remote":"127.0.0.1:44104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30393,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:22.97433Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.638648Z","time spent":"333.076969ms","remote":"127.0.0.1:44104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":10063,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:56:22.974464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.647137Z","time spent":"325.411872ms","remote":"127.0.0.1:44646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:56:22.97453Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.648442Z","time spent":"324.976174ms","remote":"127.0.0.1:44104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":30374,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:56:22.975521Z","caller":"traceutil/trace.go:171","msg":"trace[53262545] transaction","detail":"{read_only:false; response_revision:515; number_of_response:1; }","duration":"320.918967ms","start":"2026-06-02T06:56:22.654571Z","end":"2026-06-02T06:56:22.97549Z","steps":["trace[53262545] 'process raft request' (duration: 319.096862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:22.974872Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.634384Z","time spent":"337.357211ms","remote":"127.0.0.1:44646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1004,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:56:22.975688Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.654545Z","time spent":"321.054561ms","remote":"127.0.0.1:44104","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28739,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T06:56:22.9756Z","caller":"traceutil/trace.go:171","msg":"trace[1377104663] transaction","detail":"{read_only:false; response_revision:516; number_of_response:1; }","duration":"298.692242ms","start":"2026-06-02T06:56:22.676866Z","end":"2026-06-02T06:56:22.975558Z","steps":["trace[1377104663] 'process raft request' (duration: 297.136322ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:56:22.976022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:22.641794Z","time spent":"330.009981ms","remote":"127.0.0.1:44646","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":998,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-06-02T06:56:22.976092Z","caller":"traceutil/trace.go:171","msg":"trace[100131007] transaction","detail":"{read_only:false; response_revision:517; number_of_response:1; }","duration":"288.302454ms","start":"2026-06-02T06:56:22.687767Z","end":"2026-06-02T06:56:22.976069Z","steps":["trace[100131007] 'process raft request' (duration: 286.344695ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:29.33412Z","caller":"traceutil/trace.go:171","msg":"trace[2019741580] linearizableReadLoop","detail":"{readStateIndex:613; appliedIndex:612; }","duration":"178.77231ms","start":"2026-06-02T06:56:29.155318Z","end":"2026-06-02T06:56:29.33409Z","steps":["trace[2019741580] 'read index received' (duration: 120.719047ms)","trace[2019741580] 'applied index is now lower than readState.Index' (duration: 58.052223ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:56:29.334189Z","caller":"traceutil/trace.go:171","msg":"trace[848546855] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"425.09613ms","start":"2026-06-02T06:56:28.909032Z","end":"2026-06-02T06:56:29.334128Z","steps":["trace[848546855] 'process raft request' (duration: 367.089719ms)","trace[848546855] 'compare' (duration: 57.646784ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:56:29.334365Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:56:28.909009Z","time spent":"425.268414ms","remote":"127.0.0.1:44258","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":818,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-06-02T06:56:29.334346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.015935ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-md8hr\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-06-02T06:56:29.334596Z","caller":"traceutil/trace.go:171","msg":"trace[1662737552] range","detail":"{range_begin:/registry/pods/kube-system/cilium-md8hr; range_end:; response_count:1; response_revision:591; }","duration":"179.29527ms","start":"2026-06-02T06:56:29.155263Z","end":"2026-06-02T06:56:29.334559Z","steps":["trace[1662737552] 'agreement among raft nodes before linearized reading' (duration: 178.932573ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:30.38606Z","caller":"traceutil/trace.go:171","msg":"trace[1586473466] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"103.251763ms","start":"2026-06-02T06:56:30.282764Z","end":"2026-06-02T06:56:30.386016Z","steps":["trace[1586473466] 'process raft request' (duration: 96.348337ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:56:44.788703Z","caller":"traceutil/trace.go:171","msg":"trace[1672361412] transaction","detail":"{read_only:false; response_revision:765; number_of_response:1; }","duration":"143.291271ms","start":"2026-06-02T06:56:44.64538Z","end":"2026-06-02T06:56:44.788671Z","steps":["trace[1672361412] 'process raft request' (duration: 143.034916ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:10.634535Z","caller":"traceutil/trace.go:171","msg":"trace[874022839] transaction","detail":"{read_only:false; response_revision:1153; number_of_response:1; }","duration":"121.799888ms","start":"2026-06-02T06:57:10.512706Z","end":"2026-06-02T06:57:10.634506Z","steps":["trace[874022839] 'process raft request' (duration: 121.608934ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:56.63239Z","caller":"traceutil/trace.go:171","msg":"trace[1125505531] linearizableReadLoop","detail":"{readStateIndex:1881; appliedIndex:1880; }","duration":"252.494295ms","start":"2026-06-02T06:57:56.379876Z","end":"2026-06-02T06:57:56.63237Z","steps":["trace[1125505531] 'read index received' (duration: 208.030948ms)","trace[1125505531] 'applied index is now lower than readState.Index' (duration: 44.462277ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:57:56.63245Z","caller":"traceutil/trace.go:171","msg":"trace[1360498782] transaction","detail":"{read_only:false; response_revision:1811; number_of_response:1; }","duration":"270.038396ms","start":"2026-06-02T06:57:56.362372Z","end":"2026-06-02T06:57:56.63241Z","steps":["trace[1360498782] 'process raft request' (duration: 225.592349ms)","trace[1360498782] 'compare' (duration: 44.088719ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:57:56.632624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.728719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d4f3c8c4-a567-46b9-bb26-f1333f076304\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-06-02T06:57:56.63271Z","caller":"traceutil/trace.go:171","msg":"trace[365130741] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d4f3c8c4-a567-46b9-bb26-f1333f076304; range_end:; response_count:1; response_revision:1811; }","duration":"252.868872ms","start":"2026-06-02T06:57:56.379821Z","end":"2026-06-02T06:57:56.63269Z","steps":["trace[365130741] 'agreement among raft nodes before linearized reading' (duration: 252.644408ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:57.022777Z","caller":"traceutil/trace.go:171","msg":"trace[1884246751] linearizableReadLoop","detail":"{readStateIndex:1885; appliedIndex:1884; }","duration":"173.014496ms","start":"2026-06-02T06:57:56.849746Z","end":"2026-06-02T06:57:57.02276Z","steps":["trace[1884246751] 'read index received' (duration: 172.835142ms)","trace[1884246751] 'applied index is now lower than readState.Index' (duration: 178.744µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:57:57.02292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.159319ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-06-02T06:57:57.022887Z","caller":"traceutil/trace.go:171","msg":"trace[1836695076] transaction","detail":"{read_only:false; response_revision:1815; number_of_response:1; }","duration":"182.210746ms","start":"2026-06-02T06:57:56.840644Z","end":"2026-06-02T06:57:57.022855Z","steps":["trace[1836695076] 'process raft request' (duration: 181.979471ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:57:57.022959Z","caller":"traceutil/trace.go:171","msg":"trace[1857712247] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1815; }","duration":"173.22523ms","start":"2026-06-02T06:57:56.849724Z","end":"2026-06-02T06:57:57.022949Z","steps":["trace[1857712247] 'agreement among raft nodes before linearized reading' (duration: 173.099837ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:58:08.552024Z","caller":"traceutil/trace.go:171","msg":"trace[164262604] transaction","detail":"{read_only:false; response_revision:1911; number_of_response:1; }","duration":"196.435689ms","start":"2026-06-02T06:58:08.355567Z","end":"2026-06-02T06:58:08.552003Z","steps":["trace[164262604] 'process raft request' (duration: 196.304367ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:58:35.267809Z","caller":"traceutil/trace.go:171","msg":"trace[841494293] transaction","detail":"{read_only:false; response_revision:2072; number_of_response:1; }","duration":"108.481538ms","start":"2026-06-02T06:58:35.159295Z","end":"2026-06-02T06:58:35.267776Z","steps":["trace[841494293] 'process raft request' (duration: 108.249183ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:58:40.955389Z","caller":"traceutil/trace.go:171","msg":"trace[1038549558] transaction","detail":"{read_only:false; response_revision:2100; number_of_response:1; }","duration":"154.040152ms","start":"2026-06-02T06:58:40.801315Z","end":"2026-06-02T06:58:40.955355Z","steps":["trace[1038549558] 'process raft request' (duration: 122.599616ms)","trace[1038549558] 'compare' (duration: 31.18364ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:58:41.413944Z","caller":"traceutil/trace.go:171","msg":"trace[1348878008] transaction","detail":"{read_only:false; response_revision:2104; number_of_response:1; }","duration":"101.536247ms","start":"2026-06-02T06:58:41.312382Z","end":"2026-06-02T06:58:41.413918Z","steps":["trace[1348878008] 'process raft request' (duration: 90.600898ms)","trace[1348878008] 'compare' (duration: 10.823396ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:58:47.28257Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.664574ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T06:58:47.282703Z","caller":"traceutil/trace.go:171","msg":"trace[1185330987] linearizableReadLoop","detail":"{readStateIndex:2210; appliedIndex:2209; }","duration":"289.050609ms","start":"2026-06-02T06:58:46.993605Z","end":"2026-06-02T06:58:47.282656Z","steps":["trace[1185330987] 'read index received' (duration: 14.064217ms)","trace[1185330987] 'applied index is now lower than readState.Index' (duration: 274.984862ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:58:47.282801Z","caller":"traceutil/trace.go:171","msg":"trace[2014753650] transaction","detail":"{read_only:false; response_revision:2130; number_of_response:1; }","duration":"304.968706ms","start":"2026-06-02T06:58:46.977821Z","end":"2026-06-02T06:58:47.282789Z","steps":["trace[2014753650] 'process raft request' (duration: 29.855581ms)","trace[2014753650] 'compare' (duration: 274.531121ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T06:58:47.282868Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T06:58:46.97779Z","time spent":"305.045088ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T06:58:47.283074Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.463818ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-06-02T06:58:47.283102Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.582017ms","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-06-02T06:58:47.283258Z","caller":"traceutil/trace.go:171","msg":"trace[1454213360] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2130; }","duration":"276.7655ms","start":"2026-06-02T06:58:47.006449Z","end":"2026-06-02T06:58:47.283214Z","steps":["trace[1454213360] 'agreement among raft nodes before linearized reading' (duration: 276.403472ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:58:47.283115Z","caller":"traceutil/trace.go:171","msg":"trace[1487854826] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2130; }","duration":"289.54517ms","start":"2026-06-02T06:58:46.993561Z","end":"2026-06-02T06:58:47.283107Z","steps":["trace[1487854826] 'agreement among raft nodes before linearized reading' (duration: 289.419877ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:58:47.454156Z","caller":"traceutil/trace.go:171","msg":"trace[279359365] transaction","detail":"{read_only:false; response_revision:2131; number_of_response:1; }","duration":"165.923901ms","start":"2026-06-02T06:58:47.288201Z","end":"2026-06-02T06:58:47.454125Z","steps":["trace[279359365] 'process raft request' (duration: 139.253849ms)","trace[279359365] 'compare' (duration: 26.548509ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T06:58:47.456438Z","caller":"traceutil/trace.go:171","msg":"trace[335427279] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"167.954274ms","start":"2026-06-02T06:58:47.288273Z","end":"2026-06-02T06:58:47.456227Z","steps":["trace[335427279] 'process raft request' (duration: 167.75271ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T06:58:47.456867Z","caller":"traceutil/trace.go:171","msg":"trace[323532857] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"147.845807ms","start":"2026-06-02T06:58:47.30898Z","end":"2026-06-02T06:58:47.456826Z","steps":["trace[323532857] 'process raft request' (duration: 147.189262ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T06:59:40.890048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.35663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T06:59:40.890111Z","caller":"traceutil/trace.go:171","msg":"trace[1575828621] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2594; }","duration":"162.464492ms","start":"2026-06-02T06:59:40.727633Z","end":"2026-06-02T06:59:40.890098Z","steps":["trace[1575828621] 'range keys from in-memory index tree' (duration: 162.284107ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:00:18.329681Z","caller":"traceutil/trace.go:171","msg":"trace[159212783] transaction","detail":"{read_only:false; response_revision:2821; number_of_response:1; }","duration":"108.485064ms","start":"2026-06-02T07:00:18.221166Z","end":"2026-06-02T07:00:18.329651Z","steps":["trace[159212783] 'process raft request' (duration: 108.28061ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.795518Z","caller":"traceutil/trace.go:171","msg":"trace[1299595545] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"119.661963ms","start":"2026-06-02T07:04:10.675835Z","end":"2026-06-02T07:04:10.795497Z","steps":["trace[1299595545] 'process raft request' (duration: 117.477358ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.818307Z","caller":"traceutil/trace.go:171","msg":"trace[647173597] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"140.672794ms","start":"2026-06-02T07:04:10.677606Z","end":"2026-06-02T07:04:10.818279Z","steps":["trace[647173597] 'process raft request' (duration: 140.572232ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.81837Z","caller":"traceutil/trace.go:171","msg":"trace[571919781] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"140.703095ms","start":"2026-06-02T07:04:10.677578Z","end":"2026-06-02T07:04:10.818281Z","steps":["trace[571919781] 'process raft request' (duration: 140.566782ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.81844Z","caller":"traceutil/trace.go:171","msg":"trace[1168360450] linearizableReadLoop","detail":"{readStateIndex:5026; appliedIndex:5020; }","duration":"132.060765ms","start":"2026-06-02T07:04:10.686361Z","end":"2026-06-02T07:04:10.818421Z","steps":["trace[1168360450] 'read index received' (duration: 106.973308ms)","trace[1168360450] 'applied index is now lower than readState.Index' (duration: 25.086537ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:10.818558Z","caller":"traceutil/trace.go:171","msg":"trace[509877335] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"141.002652ms","start":"2026-06-02T07:04:10.677508Z","end":"2026-06-02T07:04:10.818511Z","steps":["trace[509877335] 'process raft request' (duration: 140.513101ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:10.818633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.246969ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config\" ","response":"range_response_count:1 size:708"} {"level":"info","ts":"2026-06-02T07:04:10.819219Z","caller":"traceutil/trace.go:171","msg":"trace[153685440] transaction","detail":"{read_only:false; response_revision:4844; number_of_response:1; }","duration":"126.411576ms","start":"2026-06-02T07:04:10.692294Z","end":"2026-06-02T07:04:10.818706Z","steps":["trace[153685440] 'process raft request' (duration: 125.978306ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.819254Z","caller":"traceutil/trace.go:171","msg":"trace[1732777277] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-web-config; range_end:; response_count:1; response_revision:4845; }","duration":"132.872342ms","start":"2026-06-02T07:04:10.686355Z","end":"2026-06-02T07:04:10.819227Z","steps":["trace[1732777277] 'agreement among raft nodes before linearized reading' (duration: 132.121616ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.818654Z","caller":"traceutil/trace.go:171","msg":"trace[1640855662] transaction","detail":"{read_only:false; response_revision:4843; number_of_response:1; }","duration":"140.9147ms","start":"2026-06-02T07:04:10.677727Z","end":"2026-06-02T07:04:10.818642Z","steps":["trace[1640855662] 'process raft request' (duration: 140.514111ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.818714Z","caller":"traceutil/trace.go:171","msg":"trace[850588098] transaction","detail":"{read_only:false; response_revision:4842; number_of_response:1; }","duration":"141.017493ms","start":"2026-06-02T07:04:10.67763Z","end":"2026-06-02T07:04:10.818647Z","steps":["trace[850588098] 'process raft request' (duration: 140.579363ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:10.819536Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.090554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:23 size:529415"} {"level":"info","ts":"2026-06-02T07:04:10.819616Z","caller":"traceutil/trace.go:171","msg":"trace[967595222] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:23; response_revision:4845; }","duration":"132.182086ms","start":"2026-06-02T07:04:10.687415Z","end":"2026-06-02T07:04:10.819597Z","steps":["trace[967595222] 'agreement among raft nodes before linearized reading' (duration: 131.784838ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:10.933111Z","caller":"traceutil/trace.go:171","msg":"trace[1425462433] transaction","detail":"{read_only:false; response_revision:4847; number_of_response:1; }","duration":"105.805231ms","start":"2026-06-02T07:04:10.82728Z","end":"2026-06-02T07:04:10.933086Z","steps":["trace[1425462433] 'process raft request' (duration: 72.210255ms)","trace[1425462433] 'compare' (duration: 33.395072ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:10.933105Z","caller":"traceutil/trace.go:171","msg":"trace[74566460] linearizableReadLoop","detail":"{readStateIndex:5030; appliedIndex:5029; }","duration":"104.78556ms","start":"2026-06-02T07:04:10.828297Z","end":"2026-06-02T07:04:10.933083Z","steps":["trace[74566460] 'read index received' (duration: 4.714899ms)","trace[74566460] 'applied index is now lower than readState.Index' (duration: 100.069851ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:10.933194Z","caller":"traceutil/trace.go:171","msg":"trace[406143459] transaction","detail":"{read_only:false; response_revision:4848; number_of_response:1; }","duration":"103.455572ms","start":"2026-06-02T07:04:10.829704Z","end":"2026-06-02T07:04:10.933159Z","steps":["trace[406143459] 'process raft request' (duration: 103.327329ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:10.933392Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.081927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/monitoring/alertmanager-operated\" ","response":"range_response_count:1 size:1285"} {"level":"info","ts":"2026-06-02T07:04:10.933455Z","caller":"traceutil/trace.go:171","msg":"trace[1833424802] range","detail":"{range_begin:/registry/services/specs/monitoring/alertmanager-operated; range_end:; response_count:1; response_revision:4848; }","duration":"105.19118ms","start":"2026-06-02T07:04:10.828254Z","end":"2026-06-02T07:04:10.933445Z","steps":["trace[1833424802] 'agreement among raft nodes before linearized reading' (duration: 104.896113ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:13.628096Z","caller":"traceutil/trace.go:171","msg":"trace[374021975] transaction","detail":"{read_only:false; response_revision:4968; number_of_response:1; }","duration":"102.524073ms","start":"2026-06-02T07:04:13.525551Z","end":"2026-06-02T07:04:13.628075Z","steps":["trace[374021975] 'process raft request' (duration: 102.490952ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:13.628144Z","caller":"traceutil/trace.go:171","msg":"trace[2083137354] transaction","detail":"{read_only:false; response_revision:4967; number_of_response:1; }","duration":"104.063086ms","start":"2026-06-02T07:04:13.524051Z","end":"2026-06-02T07:04:13.628114Z","steps":["trace[2083137354] 'process raft request' (duration: 103.872992ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:15.219382Z","caller":"traceutil/trace.go:171","msg":"trace[233907493] transaction","detail":"{read_only:false; response_revision:4989; number_of_response:1; }","duration":"157.441066ms","start":"2026-06-02T07:04:15.061911Z","end":"2026-06-02T07:04:15.219352Z","steps":["trace[233907493] 'process raft request' (duration: 157.273923ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:15.240086Z","caller":"traceutil/trace.go:171","msg":"trace[1621325519] transaction","detail":"{read_only:false; response_revision:4990; number_of_response:1; }","duration":"176.116699ms","start":"2026-06-02T07:04:15.063946Z","end":"2026-06-02T07:04:15.240063Z","steps":["trace[1621325519] 'process raft request' (duration: 175.788072ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:15.240383Z","caller":"traceutil/trace.go:171","msg":"trace[500605379] linearizableReadLoop","detail":"{readStateIndex:5179; appliedIndex:5177; }","duration":"147.54398ms","start":"2026-06-02T07:04:15.092797Z","end":"2026-06-02T07:04:15.240341Z","steps":["trace[500605379] 'read index received' (duration: 126.408105ms)","trace[500605379] 'applied index is now lower than readState.Index' (duration: 21.131695ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:04:15.240549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.730083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secretimports/\" range_end:\"/registry/secretgen.carvel.dev/secretimports0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T07:04:15.240608Z","caller":"traceutil/trace.go:171","msg":"trace[17302162] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secretimports/; range_end:/registry/secretgen.carvel.dev/secretimports0; response_count:0; response_revision:4991; }","duration":"147.829405ms","start":"2026-06-02T07:04:15.092765Z","end":"2026-06-02T07:04:15.240595Z","steps":["trace[17302162] 'agreement among raft nodes before linearized reading' (duration: 147.708453ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:15.502447Z","caller":"traceutil/trace.go:171","msg":"trace[1981141935] transaction","detail":"{read_only:false; response_revision:5004; number_of_response:1; }","duration":"141.469402ms","start":"2026-06-02T07:04:15.360929Z","end":"2026-06-02T07:04:15.502398Z","steps":["trace[1981141935] 'process raft request' (duration: 110.605264ms)","trace[1981141935] 'compare' (duration: 30.139952ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:15.502544Z","caller":"traceutil/trace.go:171","msg":"trace[1870569541] transaction","detail":"{read_only:false; response_revision:5005; number_of_response:1; }","duration":"135.404675ms","start":"2026-06-02T07:04:15.367111Z","end":"2026-06-02T07:04:15.502516Z","steps":["trace[1870569541] 'process raft request' (duration: 135.19145ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:16.750051Z","caller":"traceutil/trace.go:171","msg":"trace[1608953907] transaction","detail":"{read_only:false; response_revision:5026; number_of_response:1; }","duration":"115.155329ms","start":"2026-06-02T07:04:16.634855Z","end":"2026-06-02T07:04:16.75001Z","steps":["trace[1608953907] 'process raft request' (duration: 88.936078ms)","trace[1608953907] 'compare' (duration: 26.063987ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:35.987698Z","caller":"traceutil/trace.go:171","msg":"trace[1557205518] transaction","detail":"{read_only:false; response_revision:5425; number_of_response:1; }","duration":"267.451237ms","start":"2026-06-02T07:04:35.720226Z","end":"2026-06-02T07:04:35.987677Z","steps":["trace[1557205518] 'process raft request' (duration: 267.312274ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:35.98769Z","caller":"traceutil/trace.go:171","msg":"trace[2135266551] transaction","detail":"{read_only:false; response_revision:5424; number_of_response:1; }","duration":"269.116522ms","start":"2026-06-02T07:04:35.718537Z","end":"2026-06-02T07:04:35.987653Z","steps":["trace[2135266551] 'process raft request' (duration: 185.576868ms)","trace[2135266551] 'compare' (duration: 83.110065ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:35.987619Z","caller":"traceutil/trace.go:171","msg":"trace[1085248180] linearizableReadLoop","detail":"{readStateIndex:5626; appliedIndex:5623; }","duration":"262.863961ms","start":"2026-06-02T07:04:35.724734Z","end":"2026-06-02T07:04:35.987598Z","steps":["trace[1085248180] 'read index received' (duration: 2.136765ms)","trace[1085248180] 'applied index is now lower than readState.Index' (duration: 260.726286ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:04:35.987989Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"263.234639ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T07:04:35.988064Z","caller":"traceutil/trace.go:171","msg":"trace[1304092773] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5425; }","duration":"263.345901ms","start":"2026-06-02T07:04:35.724704Z","end":"2026-06-02T07:04:35.98805Z","steps":["trace[1304092773] 'agreement among raft nodes before linearized reading' (duration: 263.201609ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:35.988589Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.624052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus.18b531abce8d4c38\" ","response":"range_response_count:1 size:745"} {"level":"warn","ts":"2026-06-02T07:04:35.988604Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.680417ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-02T07:04:35.988632Z","caller":"traceutil/trace.go:171","msg":"trace[1977615093] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5425; }","duration":"202.751088ms","start":"2026-06-02T07:04:35.785873Z","end":"2026-06-02T07:04:35.988624Z","steps":["trace[1977615093] 'agreement among raft nodes before linearized reading' (duration: 202.638806ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:35.988634Z","caller":"traceutil/trace.go:171","msg":"trace[50407177] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus.18b531abce8d4c38; range_end:; response_count:1; response_revision:5425; }","duration":"258.693753ms","start":"2026-06-02T07:04:35.729926Z","end":"2026-06-02T07:04:35.98862Z","steps":["trace[50407177] 'agreement among raft nodes before linearized reading' (duration: 258.54398ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:35.988856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.022994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-chunks-cache-0\" ","response":"range_response_count:1 size:4463"} {"level":"info","ts":"2026-06-02T07:04:35.988887Z","caller":"traceutil/trace.go:171","msg":"trace[1019035579] range","detail":"{range_begin:/registry/pods/monitoring/loki-chunks-cache-0; range_end:; response_count:1; response_revision:5425; }","duration":"242.091566ms","start":"2026-06-02T07:04:35.746786Z","end":"2026-06-02T07:04:35.988878Z","steps":["trace[1019035579] 'agreement among raft nodes before linearized reading' (duration: 241.992294ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.156804Z","caller":"traceutil/trace.go:171","msg":"trace[795706754] linearizableReadLoop","detail":"{readStateIndex:5627; appliedIndex:5626; }","duration":"163.908462ms","start":"2026-06-02T07:04:35.992869Z","end":"2026-06-02T07:04:36.156777Z","steps":["trace[795706754] 'read index received' (duration: 115.301112ms)","trace[795706754] 'applied index is now lower than readState.Index' (duration: 48.6065ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:36.156884Z","caller":"traceutil/trace.go:171","msg":"trace[1265666892] transaction","detail":"{read_only:false; response_revision:5426; number_of_response:1; }","duration":"165.436696ms","start":"2026-06-02T07:04:35.99142Z","end":"2026-06-02T07:04:36.156857Z","steps":["trace[1265666892] 'process raft request' (duration: 116.733642ms)","trace[1265666892] 'compare' (duration: 48.478688ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:04:36.157254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.252241ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-4dafcbb1-5f0d-4214-b590-1de9bfbd5aa9\" ","response":"range_response_count:1 size:1275"} {"level":"info","ts":"2026-06-02T07:04:36.157314Z","caller":"traceutil/trace.go:171","msg":"trace[1967740196] range","detail":"{range_begin:/registry/persistentvolumes/pvc-4dafcbb1-5f0d-4214-b590-1de9bfbd5aa9; range_end:; response_count:1; response_revision:5426; }","duration":"164.474105ms","start":"2026-06-02T07:04:35.992825Z","end":"2026-06-02T07:04:36.157299Z","steps":["trace[1967740196] 'agreement among raft nodes before linearized reading' (duration: 164.079497ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.224026Z","caller":"traceutil/trace.go:171","msg":"trace[605630954] transaction","detail":"{read_only:false; response_revision:5427; number_of_response:1; }","duration":"226.851214ms","start":"2026-06-02T07:04:35.997149Z","end":"2026-06-02T07:04:36.224Z","steps":["trace[605630954] 'process raft request' (duration: 226.720251ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:36.232978Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"184.25201ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-02T07:04:36.233009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.107259ms","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-06-02T07:04:36.233026Z","caller":"traceutil/trace.go:171","msg":"trace[210773316] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:5428; }","duration":"184.344242ms","start":"2026-06-02T07:04:36.048672Z","end":"2026-06-02T07:04:36.233016Z","steps":["trace[210773316] 'agreement among raft nodes before linearized reading' (duration: 184.24296ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.23318Z","caller":"traceutil/trace.go:171","msg":"trace[828394806] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5428; }","duration":"135.207151ms","start":"2026-06-02T07:04:36.097844Z","end":"2026-06-02T07:04:36.233051Z","steps":["trace[828394806] 'agreement among raft nodes before linearized reading' (duration: 135.059588ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.342035Z","caller":"traceutil/trace.go:171","msg":"trace[81821151] transaction","detail":"{read_only:false; response_revision:5429; number_of_response:1; }","duration":"113.067505ms","start":"2026-06-02T07:04:36.228933Z","end":"2026-06-02T07:04:36.342001Z","steps":["trace[81821151] 'process raft request' (duration: 105.903765ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.342184Z","caller":"traceutil/trace.go:171","msg":"trace[1358696668] transaction","detail":"{read_only:false; response_revision:5430; number_of_response:1; }","duration":"112.864452ms","start":"2026-06-02T07:04:36.229287Z","end":"2026-06-02T07:04:36.342151Z","steps":["trace[1358696668] 'process raft request' (duration: 112.632827ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.343926Z","caller":"traceutil/trace.go:171","msg":"trace[153134433] transaction","detail":"{read_only:false; response_revision:5431; number_of_response:1; }","duration":"114.510726ms","start":"2026-06-02T07:04:36.229383Z","end":"2026-06-02T07:04:36.343894Z","steps":["trace[153134433] 'process raft request' (duration: 112.664637ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.344017Z","caller":"traceutil/trace.go:171","msg":"trace[1384994031] linearizableReadLoop","detail":"{readStateIndex:5635; appliedIndex:5629; }","duration":"111.104033ms","start":"2026-06-02T07:04:36.232888Z","end":"2026-06-02T07:04:36.343992Z","steps":["trace[1384994031] 'read index received' (duration: 101.994402ms)","trace[1384994031] 'applied index is now lower than readState.Index' (duration: 9.108521ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:04:36.344151Z","caller":"traceutil/trace.go:171","msg":"trace[2016342044] transaction","detail":"{read_only:false; response_revision:5432; number_of_response:1; }","duration":"113.666257ms","start":"2026-06-02T07:04:36.230472Z","end":"2026-06-02T07:04:36.344139Z","steps":["trace[2016342044] 'process raft request' (duration: 113.243538ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.344563Z","caller":"traceutil/trace.go:171","msg":"trace[1079253649] transaction","detail":"{read_only:false; response_revision:5433; number_of_response:1; }","duration":"113.176238ms","start":"2026-06-02T07:04:36.231376Z","end":"2026-06-02T07:04:36.344552Z","steps":["trace[1079253649] 'process raft request' (duration: 112.466652ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.344805Z","caller":"traceutil/trace.go:171","msg":"trace[1785375372] transaction","detail":"{read_only:false; response_revision:5434; number_of_response:1; }","duration":"113.010374ms","start":"2026-06-02T07:04:36.231785Z","end":"2026-06-02T07:04:36.344796Z","steps":["trace[1785375372] 'process raft request' (duration: 112.145635ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:36.345046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.844105ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-0ee508c9-358e-44ce-b4ff-4d1a2a264f29\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-06-02T07:04:36.345311Z","caller":"traceutil/trace.go:171","msg":"trace[1339328489] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-0ee508c9-358e-44ce-b4ff-4d1a2a264f29; range_end:; response_count:1; response_revision:5434; }","duration":"117.14803ms","start":"2026-06-02T07:04:36.228142Z","end":"2026-06-02T07:04:36.34529Z","steps":["trace[1339328489] 'agreement among raft nodes before linearized reading' (duration: 116.726562ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:36.345528Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.654008ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana.18b531abceec8086\" ","response":"range_response_count:1 size:736"} {"level":"info","ts":"2026-06-02T07:04:36.345721Z","caller":"traceutil/trace.go:171","msg":"trace[1131824728] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana.18b531abceec8086; range_end:; response_count:1; response_revision:5434; }","duration":"183.875643ms","start":"2026-06-02T07:04:36.161814Z","end":"2026-06-02T07:04:36.34569Z","steps":["trace[1131824728] 'agreement among raft nodes before linearized reading' (duration: 183.064246ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:04:36.381517Z","caller":"traceutil/trace.go:171","msg":"trace[787010038] transaction","detail":"{read_only:false; response_revision:5435; number_of_response:1; }","duration":"145.056737ms","start":"2026-06-02T07:04:36.236433Z","end":"2026-06-02T07:04:36.381489Z","steps":["trace[787010038] 'process raft request' (duration: 144.7152ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:04:36.381599Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.371744ms","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-06-02T07:04:36.381683Z","caller":"traceutil/trace.go:171","msg":"trace[1839652159] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:5435; }","duration":"135.470666ms","start":"2026-06-02T07:04:36.246191Z","end":"2026-06-02T07:04:36.381661Z","steps":["trace[1839652159] 'agreement among raft nodes before linearized reading' (duration: 135.087718ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:05:44.237119Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2963} {"level":"info","ts":"2026-06-02T07:05:44.314194Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2963,"took":"75.436709ms","hash":1519562081,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":33656832,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-02T07:05:44.314247Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1519562081,"revision":2963,"compact-revision":-1} {"level":"info","ts":"2026-06-02T07:10:41.51731Z","caller":"traceutil/trace.go:171","msg":"trace[1804999958] linearizableReadLoop","detail":"{readStateIndex:8530; appliedIndex:8528; }","duration":"109.128508ms","start":"2026-06-02T07:10:41.408156Z","end":"2026-06-02T07:10:41.517285Z","steps":["trace[1804999958] 'read index received' (duration: 87.763274ms)","trace[1804999958] 'applied index is now lower than readState.Index' (duration: 21.363914ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:10:41.517357Z","caller":"traceutil/trace.go:171","msg":"trace[770550579] transaction","detail":"{read_only:false; response_revision:8243; number_of_response:1; }","duration":"120.428453ms","start":"2026-06-02T07:10:41.396896Z","end":"2026-06-02T07:10:41.517324Z","steps":["trace[770550579] 'process raft request' (duration: 120.28248ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:10:41.517525Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.347763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-02T07:10:41.517566Z","caller":"traceutil/trace.go:171","msg":"trace[285319566] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8243; }","duration":"109.441435ms","start":"2026-06-02T07:10:41.40811Z","end":"2026-06-02T07:10:41.517552Z","steps":["trace[285319566] 'agreement among raft nodes before linearized reading' (duration: 109.282822ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:10:44.245684Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6042} {"level":"info","ts":"2026-06-02T07:10:44.350486Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6042,"took":"102.43877ms","hash":2297542900,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":23748608,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-06-02T07:10:44.350533Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2297542900,"revision":6042,"compact-revision":2963} {"level":"warn","ts":"2026-06-02T07:10:53.18251Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"355.805386ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-02T07:10:53.182641Z","caller":"traceutil/trace.go:171","msg":"trace[1647417522] linearizableReadLoop","detail":"{readStateIndex:8595; appliedIndex:8594; }","duration":"200.238913ms","start":"2026-06-02T07:10:52.982387Z","end":"2026-06-02T07:10:53.182625Z","steps":["trace[1647417522] 'read index received' (duration: 55.011µs)","trace[1647417522] 'applied index is now lower than readState.Index' (duration: 200.182782ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:10:53.182761Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.365066ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-02T07:10:53.182795Z","caller":"traceutil/trace.go:171","msg":"trace[1037723603] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8303; }","duration":"200.447517ms","start":"2026-06-02T07:10:52.982334Z","end":"2026-06-02T07:10:53.182781Z","steps":["trace[1037723603] 'agreement among raft nodes before linearized reading' (duration: 200.354615ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:21.89948Z","caller":"traceutil/trace.go:171","msg":"trace[610068840] linearizableReadLoop","detail":"{readStateIndex:8809; appliedIndex:8808; }","duration":"172.990467ms","start":"2026-06-02T07:11:21.72647Z","end":"2026-06-02T07:11:21.89946Z","steps":["trace[610068840] 'read index received' (duration: 172.738912ms)","trace[610068840] 'applied index is now lower than readState.Index' (duration: 250.645µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:11:21.899745Z","caller":"traceutil/trace.go:171","msg":"trace[1205802439] transaction","detail":"{read_only:false; response_revision:8510; number_of_response:1; }","duration":"284.591636ms","start":"2026-06-02T07:11:21.615141Z","end":"2026-06-02T07:11:21.899733Z","steps":["trace[1205802439] 'process raft request' (duration: 284.165188ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:11:21.899913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.426355ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T07:11:21.899959Z","caller":"traceutil/trace.go:171","msg":"trace[1372154602] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8510; }","duration":"173.514498ms","start":"2026-06-02T07:11:21.726433Z","end":"2026-06-02T07:11:21.899947Z","steps":["trace[1372154602] 'agreement among raft nodes before linearized reading' (duration: 173.429116ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:11:21.900246Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.547498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-02T07:11:21.900276Z","caller":"traceutil/trace.go:171","msg":"trace[794242352] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8510; }","duration":"148.598659ms","start":"2026-06-02T07:11:21.751671Z","end":"2026-06-02T07:11:21.900269Z","steps":["trace[794242352] 'agreement among raft nodes before linearized reading' (duration: 148.505057ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:11:21.900526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.454ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-06-02T07:11:21.900558Z","caller":"traceutil/trace.go:171","msg":"trace[1117575690] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8510; }","duration":"141.503111ms","start":"2026-06-02T07:11:21.759045Z","end":"2026-06-02T07:11:21.900548Z","steps":["trace[1117575690] 'agreement among raft nodes before linearized reading' (duration: 141.43869ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:11:21.900689Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.859554ms","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-06-02T07:11:21.900707Z","caller":"traceutil/trace.go:171","msg":"trace[1221959464] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8510; }","duration":"147.898075ms","start":"2026-06-02T07:11:21.752804Z","end":"2026-06-02T07:11:21.900702Z","steps":["trace[1221959464] 'agreement among raft nodes before linearized reading' (duration: 147.841184ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:22.081392Z","caller":"traceutil/trace.go:171","msg":"trace[936716696] transaction","detail":"{read_only:false; response_revision:8511; number_of_response:1; }","duration":"177.090561ms","start":"2026-06-02T07:11:21.904281Z","end":"2026-06-02T07:11:22.081371Z","steps":["trace[936716696] 'process raft request' (duration: 170.827641ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:22.096368Z","caller":"traceutil/trace.go:171","msg":"trace[1069487743] transaction","detail":"{read_only:false; response_revision:8512; number_of_response:1; }","duration":"192.043631ms","start":"2026-06-02T07:11:21.904302Z","end":"2026-06-02T07:11:22.096346Z","steps":["trace[1069487743] 'process raft request' (duration: 191.884798ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:22.096557Z","caller":"traceutil/trace.go:171","msg":"trace[619207770] transaction","detail":"{read_only:false; response_revision:8513; number_of_response:1; }","duration":"187.59382ms","start":"2026-06-02T07:11:21.90893Z","end":"2026-06-02T07:11:22.096524Z","steps":["trace[619207770] 'process raft request' (duration: 187.386826ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:11:25.043547Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.675933ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-02T07:11:25.043634Z","caller":"traceutil/trace.go:171","msg":"trace[32767688] linearizableReadLoop","detail":"{readStateIndex:8827; appliedIndex:8826; }","duration":"136.782683ms","start":"2026-06-02T07:11:24.906838Z","end":"2026-06-02T07:11:25.043621Z","steps":["trace[32767688] 'read index received' (duration: 45.311µs)","trace[32767688] 'applied index is now lower than readState.Index' (duration: 136.736572ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:11:25.043764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.937556ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xw695\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-06-02T07:11:25.043744Z","caller":"traceutil/trace.go:171","msg":"trace[1007525570] transaction","detail":"{read_only:false; response_revision:8527; number_of_response:1; }","duration":"206.771289ms","start":"2026-06-02T07:11:24.836926Z","end":"2026-06-02T07:11:25.043698Z","steps":["trace[1007525570] 'process raft request' (duration: 15.865721ms)","trace[1007525570] 'compare' (duration: 190.162233ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:11:25.04379Z","caller":"traceutil/trace.go:171","msg":"trace[882559076] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xw695; range_end:; response_count:1; response_revision:8527; }","duration":"136.993288ms","start":"2026-06-02T07:11:24.906789Z","end":"2026-06-02T07:11:25.043782Z","steps":["trace[882559076] 'agreement among raft nodes before linearized reading' (duration: 136.865665ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:34.21955Z","caller":"traceutil/trace.go:171","msg":"trace[1408572663] transaction","detail":"{read_only:false; response_revision:8613; number_of_response:1; }","duration":"117.443747ms","start":"2026-06-02T07:11:34.102076Z","end":"2026-06-02T07:11:34.21952Z","steps":["trace[1408572663] 'process raft request' (duration: 117.288024ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:34.379953Z","caller":"traceutil/trace.go:171","msg":"trace[1770958467] transaction","detail":"{read_only:false; response_revision:8615; number_of_response:1; }","duration":"154.953866ms","start":"2026-06-02T07:11:34.223907Z","end":"2026-06-02T07:11:34.37886Z","steps":["trace[1770958467] 'process raft request' (duration: 76.376746ms)","trace[1770958467] 'compare' (duration: 78.366475ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:11:34.380172Z","caller":"traceutil/trace.go:171","msg":"trace[520086645] linearizableReadLoop","detail":"{readStateIndex:8921; appliedIndex:8919; }","duration":"135.308226ms","start":"2026-06-02T07:11:34.244792Z","end":"2026-06-02T07:11:34.3801Z","steps":["trace[520086645] 'read index received' (duration: 55.538242ms)","trace[520086645] 'applied index is now lower than readState.Index' (duration: 79.759644ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:11:34.380332Z","caller":"traceutil/trace.go:171","msg":"trace[493377885] transaction","detail":"{read_only:false; response_revision:8616; number_of_response:1; }","duration":"142.806452ms","start":"2026-06-02T07:11:34.237346Z","end":"2026-06-02T07:11:34.380152Z","steps":["trace[493377885] 'process raft request' (duration: 141.471265ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:11:34.380462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.287373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-r56w4\" ","response":"range_response_count:1 size:4644"} {"level":"info","ts":"2026-06-02T07:11:34.380533Z","caller":"traceutil/trace.go:171","msg":"trace[98480374] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-r56w4; range_end:; response_count:1; response_revision:8616; }","duration":"156.392575ms","start":"2026-06-02T07:11:34.224127Z","end":"2026-06-02T07:11:34.38052Z","steps":["trace[98480374] 'agreement among raft nodes before linearized reading' (duration: 156.15553ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:34.40619Z","caller":"traceutil/trace.go:171","msg":"trace[1508779212] transaction","detail":"{read_only:false; response_revision:8617; number_of_response:1; }","duration":"157.925116ms","start":"2026-06-02T07:11:34.248246Z","end":"2026-06-02T07:11:34.406171Z","steps":["trace[1508779212] 'process raft request' (duration: 157.307943ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:34.406302Z","caller":"traceutil/trace.go:171","msg":"trace[2032615084] transaction","detail":"{read_only:false; response_revision:8619; number_of_response:1; }","duration":"153.921343ms","start":"2026-06-02T07:11:34.252355Z","end":"2026-06-02T07:11:34.406276Z","steps":["trace[2032615084] 'process raft request' (duration: 153.357041ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:34.406521Z","caller":"traceutil/trace.go:171","msg":"trace[1021910216] transaction","detail":"{read_only:false; response_revision:8618; number_of_response:1; }","duration":"157.64409ms","start":"2026-06-02T07:11:34.248653Z","end":"2026-06-02T07:11:34.406297Z","steps":["trace[1021910216] 'process raft request' (duration: 157.020738ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:34.406657Z","caller":"traceutil/trace.go:171","msg":"trace[1986767545] transaction","detail":"{read_only:false; response_revision:8620; number_of_response:1; }","duration":"129.171819ms","start":"2026-06-02T07:11:34.277476Z","end":"2026-06-02T07:11:34.406648Z","steps":["trace[1986767545] 'process raft request' (duration: 128.273321ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:11:35.309326Z","caller":"traceutil/trace.go:171","msg":"trace[128217905] transaction","detail":"{read_only:false; response_revision:8625; number_of_response:1; }","duration":"140.014115ms","start":"2026-06-02T07:11:35.169278Z","end":"2026-06-02T07:11:35.309292Z","steps":["trace[128217905] 'process raft request' (duration: 88.307321ms)","trace[128217905] 'compare' (duration: 51.454318ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:12:15.058122Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002460.wal"} {"level":"info","ts":"2026-06-02T07:13:30.850035Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T07:13:30.855346Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-02T07:13:30.855457Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-02T07:15:44.251793Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8258} {"level":"info","ts":"2026-06-02T07:15:44.333034Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8258,"took":"78.807126ms","hash":19449208,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":26292224,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-02T07:15:44.333114Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":19449208,"revision":8258,"compact-revision":6042} {"level":"info","ts":"2026-06-02T07:20:44.258915Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10748} {"level":"info","ts":"2026-06-02T07:20:44.34977Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10748,"took":"88.390981ms","hash":2392522146,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":27377664,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-02T07:20:44.349839Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2392522146,"revision":10748,"compact-revision":8258} {"level":"info","ts":"2026-06-02T07:22:41.109506Z","caller":"traceutil/trace.go:171","msg":"trace[542185069] transaction","detail":"{read_only:false; response_revision:13696; number_of_response:1; }","duration":"184.434873ms","start":"2026-06-02T07:22:40.925049Z","end":"2026-06-02T07:22:41.109483Z","steps":["trace[542185069] 'process raft request' (duration: 184.304971ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:22:41.111924Z","caller":"traceutil/trace.go:171","msg":"trace[807202976] linearizableReadLoop","detail":"{readStateIndex:14164; appliedIndex:14163; }","duration":"148.974079ms","start":"2026-06-02T07:22:40.962919Z","end":"2026-06-02T07:22:41.111893Z","steps":["trace[807202976] 'read index received' (duration: 147.340955ms)","trace[807202976] 'applied index is now lower than readState.Index' (duration: 1.632434ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:22:41.112087Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.151042ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-06-02T07:22:41.11212Z","caller":"traceutil/trace.go:171","msg":"trace[2133019699] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13698; }","duration":"149.250414ms","start":"2026-06-02T07:22:40.96286Z","end":"2026-06-02T07:22:41.11211Z","steps":["trace[2133019699] 'agreement among raft nodes before linearized reading' (duration: 149.110081ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:22:41.112371Z","caller":"traceutil/trace.go:171","msg":"trace[1917442451] transaction","detail":"{read_only:false; response_revision:13697; number_of_response:1; }","duration":"184.699849ms","start":"2026-06-02T07:22:40.927661Z","end":"2026-06-02T07:22:41.112361Z","steps":["trace[1917442451] 'process raft request' (duration: 184.109316ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:22:56.254766Z","caller":"traceutil/trace.go:171","msg":"trace[1118698843] transaction","detail":"{read_only:false; response_revision:13793; number_of_response:1; }","duration":"103.704036ms","start":"2026-06-02T07:22:56.151026Z","end":"2026-06-02T07:22:56.25473Z","steps":["trace[1118698843] 'process raft request' (duration: 103.488162ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:22:57.403286Z","caller":"traceutil/trace.go:171","msg":"trace[554705637] linearizableReadLoop","detail":"{readStateIndex:14267; appliedIndex:14265; }","duration":"219.454588ms","start":"2026-06-02T07:22:57.183806Z","end":"2026-06-02T07:22:57.40326Z","steps":["trace[554705637] 'read index received' (duration: 72.211µs)","trace[554705637] 'applied index is now lower than readState.Index' (duration: 219.381417ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:22:57.403427Z","caller":"traceutil/trace.go:171","msg":"trace[1474476058] transaction","detail":"{read_only:false; response_revision:13796; number_of_response:1; }","duration":"240.268111ms","start":"2026-06-02T07:22:57.163146Z","end":"2026-06-02T07:22:57.403414Z","steps":["trace[1474476058] 'process raft request' (duration: 209.265572ms)","trace[1474476058] 'compare' (duration: 30.735484ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:22:57.403666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.845086ms","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-06-02T07:22:57.403709Z","caller":"traceutil/trace.go:171","msg":"trace[1043263012] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:13796; }","duration":"219.940508ms","start":"2026-06-02T07:22:57.183758Z","end":"2026-06-02T07:22:57.403698Z","steps":["trace[1043263012] 'agreement among raft nodes before linearized reading' (duration: 219.799395ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:23:06.46555Z","caller":"traceutil/trace.go:171","msg":"trace[866016397] linearizableReadLoop","detail":"{readStateIndex:14438; appliedIndex:14436; }","duration":"118.280706ms","start":"2026-06-02T07:23:06.347236Z","end":"2026-06-02T07:23:06.465517Z","steps":["trace[866016397] 'read index received' (duration: 4.474485ms)","trace[866016397] 'applied index is now lower than readState.Index' (duration: 113.804121ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:23:06.46559Z","caller":"traceutil/trace.go:171","msg":"trace[1539248533] transaction","detail":"{read_only:false; response_revision:13964; number_of_response:1; }","duration":"161.020925ms","start":"2026-06-02T07:23:06.304524Z","end":"2026-06-02T07:23:06.465545Z","steps":["trace[1539248533] 'process raft request' (duration: 125.641522ms)","trace[1539248533] 'compare' (duration: 35.078557ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:23:06.465856Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.605084ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-xw695\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-06-02T07:23:06.465905Z","caller":"traceutil/trace.go:171","msg":"trace[1370424880] range","detail":"{range_begin:/registry/pods/openstack/keepalived-xw695; range_end:; response_count:1; response_revision:13964; }","duration":"118.718086ms","start":"2026-06-02T07:23:06.347174Z","end":"2026-06-02T07:23:06.465892Z","steps":["trace[1370424880] 'agreement among raft nodes before linearized reading' (duration: 118.469711ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:24:51.107291Z","caller":"traceutil/trace.go:171","msg":"trace[346638230] linearizableReadLoop","detail":"{readStateIndex:15585; appliedIndex:15584; }","duration":"154.746758ms","start":"2026-06-02T07:24:50.952521Z","end":"2026-06-02T07:24:51.107267Z","steps":["trace[346638230] 'read index received' (duration: 107.529297ms)","trace[346638230] 'applied index is now lower than readState.Index' (duration: 47.216251ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:24:51.107493Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.913292ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-02T07:24:51.107469Z","caller":"traceutil/trace.go:171","msg":"trace[1825589725] transaction","detail":"{read_only:false; response_revision:15075; number_of_response:1; }","duration":"163.174263ms","start":"2026-06-02T07:24:50.944237Z","end":"2026-06-02T07:24:51.107412Z","steps":["trace[1825589725] 'process raft request' (duration: 115.85026ms)","trace[1825589725] 'compare' (duration: 47.052228ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:24:51.107532Z","caller":"traceutil/trace.go:171","msg":"trace[415908434] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15075; }","duration":"155.025445ms","start":"2026-06-02T07:24:50.952495Z","end":"2026-06-02T07:24:51.107521Z","steps":["trace[415908434] 'agreement among raft nodes before linearized reading' (duration: 154.910971ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:24:51.107734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.385677ms","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:7"} {"level":"info","ts":"2026-06-02T07:24:51.107801Z","caller":"traceutil/trace.go:171","msg":"trace[947209543] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstores/; range_end:/registry/ceph.rook.io/cephobjectstores0; response_count:0; response_revision:15075; }","duration":"149.48818ms","start":"2026-06-02T07:24:50.958294Z","end":"2026-06-02T07:24:51.107782Z","steps":["trace[947209543] 'agreement among raft nodes before linearized reading' (duration: 149.352117ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:24:51.107843Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.915071ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5523"} {"level":"info","ts":"2026-06-02T07:24:51.107985Z","caller":"traceutil/trace.go:171","msg":"trace[1971525292] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15075; }","duration":"154.055984ms","start":"2026-06-02T07:24:50.95388Z","end":"2026-06-02T07:24:51.107936Z","steps":["trace[1971525292] 'agreement among raft nodes before linearized reading' (duration: 153.759638ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:24:51.108359Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.324989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:668"} {"level":"info","ts":"2026-06-02T07:24:51.108509Z","caller":"traceutil/trace.go:171","msg":"trace[349969339] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15075; }","duration":"154.515403ms","start":"2026-06-02T07:24:50.953959Z","end":"2026-06-02T07:24:51.108475Z","steps":["trace[349969339] 'agreement among raft nodes before linearized reading' (duration: 154.023933ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:25:44.264684Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12849} {"level":"info","ts":"2026-06-02T07:25:44.34695Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12849,"took":"79.277019ms","hash":7252614,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":30314496,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-02T07:25:44.347041Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":7252614,"revision":12849,"compact-revision":10748} {"level":"info","ts":"2026-06-02T07:30:33.94384Z","caller":"traceutil/trace.go:171","msg":"trace[1785195797] transaction","detail":"{read_only:false; response_revision:17667; number_of_response:1; }","duration":"231.436604ms","start":"2026-06-02T07:30:33.712385Z","end":"2026-06-02T07:30:33.943822Z","steps":["trace[1785195797] 'process raft request' (duration: 231.296191ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:30:33.944208Z","caller":"traceutil/trace.go:171","msg":"trace[1752335216] linearizableReadLoop","detail":"{readStateIndex:18261; appliedIndex:18261; }","duration":"219.428204ms","start":"2026-06-02T07:30:33.724773Z","end":"2026-06-02T07:30:33.944202Z","steps":["trace[1752335216] 'read index received' (duration: 219.425484ms)","trace[1752335216] 'applied index is now lower than readState.Index' (duration: 2.39µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:30:33.944258Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.473375ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:30:33.944274Z","caller":"traceutil/trace.go:171","msg":"trace[216791114] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17667; }","duration":"219.520225ms","start":"2026-06-02T07:30:33.724748Z","end":"2026-06-02T07:30:33.944269Z","steps":["trace[216791114] 'agreement among raft nodes before linearized reading' (duration: 219.479344ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:30:34.445247Z","caller":"traceutil/trace.go:171","msg":"trace[333106030] linearizableReadLoop","detail":"{readStateIndex:18263; appliedIndex:18262; }","duration":"179.48915ms","start":"2026-06-02T07:30:34.265728Z","end":"2026-06-02T07:30:34.445217Z","steps":["trace[333106030] 'read index received' (duration: 179.271955ms)","trace[333106030] 'applied index is now lower than readState.Index' (duration: 216.115µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:30:34.44529Z","caller":"traceutil/trace.go:171","msg":"trace[1611910031] transaction","detail":"{read_only:false; response_revision:17669; number_of_response:1; }","duration":"194.184167ms","start":"2026-06-02T07:30:34.251075Z","end":"2026-06-02T07:30:34.445259Z","steps":["trace[1611910031] 'process raft request' (duration: 193.927271ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:30:34.44554Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"174.683339ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-06-02T07:30:34.445587Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.843807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"warn","ts":"2026-06-02T07:30:34.445595Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.09817ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/sshkeys/\" range_end:\"/registry/secretgen.k14s.io/sshkeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:30:34.445679Z","caller":"traceutil/trace.go:171","msg":"trace[103133953] range","detail":"{range_begin:/registry/secretgen.k14s.io/sshkeys/; range_end:/registry/secretgen.k14s.io/sshkeys0; response_count:0; response_revision:17669; }","duration":"111.217253ms","start":"2026-06-02T07:30:34.334442Z","end":"2026-06-02T07:30:34.445659Z","steps":["trace[103133953] 'agreement among raft nodes before linearized reading' (duration: 111.0857ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:30:34.445791Z","caller":"traceutil/trace.go:171","msg":"trace[516690547] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:17669; }","duration":"180.056191ms","start":"2026-06-02T07:30:34.265681Z","end":"2026-06-02T07:30:34.445737Z","steps":["trace[516690547] 'agreement among raft nodes before linearized reading' (duration: 179.684604ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:30:34.445602Z","caller":"traceutil/trace.go:171","msg":"trace[880157487] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:17669; }","duration":"174.77154ms","start":"2026-06-02T07:30:34.270814Z","end":"2026-06-02T07:30:34.445585Z","steps":["trace[880157487] 'agreement among raft nodes before linearized reading' (duration: 174.612827ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:30:35.006771Z","caller":"traceutil/trace.go:171","msg":"trace[1655821092] transaction","detail":"{read_only:false; response_revision:17673; number_of_response:1; }","duration":"144.07071ms","start":"2026-06-02T07:30:34.862657Z","end":"2026-06-02T07:30:35.006728Z","steps":["trace[1655821092] 'process raft request' (duration: 89.591311ms)","trace[1655821092] 'compare' (duration: 54.304686ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:30:44.271279Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15410} {"level":"info","ts":"2026-06-02T07:30:44.376758Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15410,"took":"102.427379ms","hash":2249715294,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":32104448,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-02T07:30:44.376821Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2249715294,"revision":15410,"compact-revision":12849} {"level":"info","ts":"2026-06-02T07:34:07.240239Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T07:34:07.244524Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-02T07:34:07.244619Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-02T07:35:44.287531Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17803} {"level":"info","ts":"2026-06-02T07:35:44.401788Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17803,"took":"109.074296ms","hash":4247096445,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":33730560,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-02T07:35:44.401876Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4247096445,"revision":17803,"compact-revision":15410} {"level":"info","ts":"2026-06-02T07:35:51.746635Z","caller":"traceutil/trace.go:171","msg":"trace[449083862] transaction","detail":"{read_only:false; response_revision:20110; number_of_response:1; }","duration":"143.714625ms","start":"2026-06-02T07:35:51.602887Z","end":"2026-06-02T07:35:51.746601Z","steps":["trace[449083862] 'process raft request' (duration: 143.45797ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:35:52.385671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.09803ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:35:52.385783Z","caller":"traceutil/trace.go:171","msg":"trace[1020135737] linearizableReadLoop","detail":"{readStateIndex:20787; appliedIndex:20786; }","duration":"210.102204ms","start":"2026-06-02T07:35:52.175664Z","end":"2026-06-02T07:35:52.385766Z","steps":["trace[1020135737] 'read index received' (duration: 31.740548ms)","trace[1020135737] 'applied index is now lower than readState.Index' (duration: 178.360466ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:35:52.385847Z","caller":"traceutil/trace.go:171","msg":"trace[806746430] transaction","detail":"{read_only:false; response_revision:20113; number_of_response:1; }","duration":"285.778807ms","start":"2026-06-02T07:35:52.100036Z","end":"2026-06-02T07:35:52.385815Z","steps":["trace[806746430] 'process raft request' (duration: 107.435732ms)","trace[806746430] 'compare' (duration: 177.946427ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:35:52.386075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.37601ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-06-02T07:35:52.38616Z","caller":"traceutil/trace.go:171","msg":"trace[1227194528] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:20113; }","duration":"211.198427ms","start":"2026-06-02T07:35:52.17494Z","end":"2026-06-02T07:35:52.386139Z","steps":["trace[1227194528] 'agreement among raft nodes before linearized reading' (duration: 210.939612ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:35:52.634059Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.014014ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:35:52.63417Z","caller":"traceutil/trace.go:171","msg":"trace[992246516] linearizableReadLoop","detail":"{readStateIndex:20788; appliedIndex:20787; }","duration":"248.34193ms","start":"2026-06-02T07:35:52.385807Z","end":"2026-06-02T07:35:52.634149Z","steps":["trace[992246516] 'read index received' (duration: 141.093451ms)","trace[992246516] 'applied index is now lower than readState.Index' (duration: 107.246919ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:35:52.634182Z","caller":"traceutil/trace.go:171","msg":"trace[1414047223] transaction","detail":"{read_only:false; response_revision:20114; number_of_response:1; }","duration":"380.084244ms","start":"2026-06-02T07:35:52.254071Z","end":"2026-06-02T07:35:52.634155Z","steps":["trace[1414047223] 'process raft request' (duration: 272.894616ms)","trace[1414047223] 'compare' (duration: 106.710317ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:35:52.634306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:35:52.254041Z","time spent":"380.194286ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:35:52.634349Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"457.591226ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-02T07:35:52.634387Z","caller":"traceutil/trace.go:171","msg":"trace[609447983] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:20114; }","duration":"457.667848ms","start":"2026-06-02T07:35:52.176708Z","end":"2026-06-02T07:35:52.634376Z","steps":["trace[609447983] 'agreement among raft nodes before linearized reading' (duration: 457.531125ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:35:52.634431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:35:52.17669Z","time spent":"457.732839ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"info","ts":"2026-06-02T07:35:52.655834Z","caller":"traceutil/trace.go:171","msg":"trace[1085175525] transaction","detail":"{read_only:false; response_revision:20115; number_of_response:1; }","duration":"264.767764ms","start":"2026-06-02T07:35:52.391044Z","end":"2026-06-02T07:35:52.655812Z","steps":["trace[1085175525] 'process raft request' (duration: 264.56709ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:35:52.655866Z","caller":"traceutil/trace.go:171","msg":"trace[458104817] transaction","detail":"{read_only:false; response_revision:20116; number_of_response:1; }","duration":"150.441137ms","start":"2026-06-02T07:35:52.505397Z","end":"2026-06-02T07:35:52.655838Z","steps":["trace[458104817] 'process raft request' (duration: 150.316464ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:35:52.655854Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.499093ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-02T07:35:52.65601Z","caller":"traceutil/trace.go:171","msg":"trace[1829074017] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20116; }","duration":"239.700396ms","start":"2026-06-02T07:35:52.416299Z","end":"2026-06-02T07:35:52.655999Z","steps":["trace[1829074017] 'agreement among raft nodes before linearized reading' (duration: 239.447051ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:35:52.787825Z","caller":"traceutil/trace.go:171","msg":"trace[401246049] transaction","detail":"{read_only:false; response_revision:20117; number_of_response:1; }","duration":"150.353426ms","start":"2026-06-02T07:35:52.637447Z","end":"2026-06-02T07:35:52.787801Z","steps":["trace[401246049] 'process raft request' (duration: 150.201862ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:35:52.831887Z","caller":"traceutil/trace.go:171","msg":"trace[1443764422] transaction","detail":"{read_only:false; response_revision:20118; number_of_response:1; }","duration":"172.87876ms","start":"2026-06-02T07:35:52.658963Z","end":"2026-06-02T07:35:52.831842Z","steps":["trace[1443764422] 'process raft request' (duration: 172.694526ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:35:52.846857Z","caller":"traceutil/trace.go:171","msg":"trace[563375340] linearizableReadLoop","detail":"{readStateIndex:20793; appliedIndex:20790; }","duration":"121.204903ms","start":"2026-06-02T07:35:52.725627Z","end":"2026-06-02T07:35:52.846832Z","steps":["trace[563375340] 'read index received' (duration: 62.036576ms)","trace[563375340] 'applied index is now lower than readState.Index' (duration: 59.167227ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:35:52.846964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.322965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:35:52.847018Z","caller":"traceutil/trace.go:171","msg":"trace[1546037783] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:20118; }","duration":"121.416757ms","start":"2026-06-02T07:35:52.725584Z","end":"2026-06-02T07:35:52.847001Z","steps":["trace[1546037783] 'agreement among raft nodes before linearized reading' (duration: 121.327095ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:39:42.397239Z","caller":"traceutil/trace.go:171","msg":"trace[1807814508] transaction","detail":"{read_only:false; response_revision:22490; number_of_response:1; }","duration":"111.273563ms","start":"2026-06-02T07:39:42.285939Z","end":"2026-06-02T07:39:42.397213Z","steps":["trace[1807814508] 'process raft request' (duration: 111.073069ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:40:44.295269Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20074} {"level":"info","ts":"2026-06-02T07:40:44.409212Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20074,"took":"110.837723ms","hash":1017924697,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":41676800,"current-db-size-in-use":"42 MB"} {"level":"info","ts":"2026-06-02T07:40:44.409278Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1017924697,"revision":20074,"compact-revision":17803} {"level":"info","ts":"2026-06-02T07:40:53.073424Z","caller":"traceutil/trace.go:171","msg":"trace[1640019685] transaction","detail":"{read_only:false; response_revision:23319; number_of_response:1; }","duration":"113.624183ms","start":"2026-06-02T07:40:52.959771Z","end":"2026-06-02T07:40:53.073396Z","steps":["trace[1640019685] 'process raft request' (duration: 71.813593ms)","trace[1640019685] 'compare' (duration: 41.695338ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:49.02097Z","caller":"traceutil/trace.go:171","msg":"trace[1301292917] linearizableReadLoop","detail":"{readStateIndex:25250; appliedIndex:25249; }","duration":"137.508242ms","start":"2026-06-02T07:42:48.88341Z","end":"2026-06-02T07:42:49.020918Z","steps":["trace[1301292917] 'read index received' (duration: 88.121µs)","trace[1301292917] 'applied index is now lower than readState.Index' (duration: 137.418841ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:49.021047Z","caller":"traceutil/trace.go:171","msg":"trace[930471122] transaction","detail":"{read_only:false; response_revision:24458; number_of_response:1; }","duration":"137.645506ms","start":"2026-06-02T07:42:48.883384Z","end":"2026-06-02T07:42:49.021029Z","steps":["trace[930471122] 'process raft request' (duration: 134.297875ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:49.021336Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.890791ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-02T07:42:49.021493Z","caller":"traceutil/trace.go:171","msg":"trace[2061782723] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24458; }","duration":"138.087745ms","start":"2026-06-02T07:42:48.883369Z","end":"2026-06-02T07:42:49.021457Z","steps":["trace[2061782723] 'agreement among raft nodes before linearized reading' (duration: 137.680797ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:50.27984Z","caller":"traceutil/trace.go:171","msg":"trace[184684889] transaction","detail":"{read_only:false; response_revision:24466; number_of_response:1; }","duration":"111.188899ms","start":"2026-06-02T07:42:50.168621Z","end":"2026-06-02T07:42:50.27981Z","steps":["trace[184684889] 'process raft request' (duration: 111.001905ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:50.490906Z","caller":"traceutil/trace.go:171","msg":"trace[1098650692] linearizableReadLoop","detail":"{readStateIndex:25260; appliedIndex:25258; }","duration":"182.854996ms","start":"2026-06-02T07:42:50.30803Z","end":"2026-06-02T07:42:50.490885Z","steps":["trace[1098650692] 'read index received' (duration: 180.680331ms)","trace[1098650692] 'applied index is now lower than readState.Index' (duration: 2.174005ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:50.491354Z","caller":"traceutil/trace.go:171","msg":"trace[889303776] transaction","detail":"{read_only:false; response_revision:24468; number_of_response:1; }","duration":"321.894399ms","start":"2026-06-02T07:42:50.16944Z","end":"2026-06-02T07:42:50.491335Z","steps":["trace[889303776] 'process raft request' (duration: 321.396189ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:50.491333Z","caller":"traceutil/trace.go:171","msg":"trace[847607479] transaction","detail":"{read_only:false; response_revision:24467; number_of_response:1; }","duration":"322.582524ms","start":"2026-06-02T07:42:50.168712Z","end":"2026-06-02T07:42:50.491295Z","steps":["trace[847607479] 'process raft request' (duration: 319.986041ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:50.491423Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.844761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/acme.cert-manager.io/challenges/\" range_end:\"/registry/acme.cert-manager.io/challenges0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T07:42:50.491472Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:50.169421Z","time spent":"321.976092ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:42:50.491473Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:50.168697Z","time spent":"322.711798ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:42:50.491518Z","caller":"traceutil/trace.go:171","msg":"trace[796234529] range","detail":"{range_begin:/registry/acme.cert-manager.io/challenges/; range_end:/registry/acme.cert-manager.io/challenges0; response_count:0; response_revision:24468; }","duration":"111.016566ms","start":"2026-06-02T07:42:50.380479Z","end":"2026-06-02T07:42:50.491496Z","steps":["trace[796234529] 'agreement among raft nodes before linearized reading' (duration: 110.870502ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:50.491685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.636923ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-06-02T07:42:50.491804Z","caller":"traceutil/trace.go:171","msg":"trace[809246704] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:24468; }","duration":"183.770386ms","start":"2026-06-02T07:42:50.308016Z","end":"2026-06-02T07:42:50.491787Z","steps":["trace[809246704] 'agreement among raft nodes before linearized reading' (duration: 183.249534ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:50.492079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.156734ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T07:42:50.492145Z","caller":"traceutil/trace.go:171","msg":"trace[2144020273] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24468; }","duration":"117.271767ms","start":"2026-06-02T07:42:50.374861Z","end":"2026-06-02T07:42:50.492133Z","steps":["trace[2144020273] 'agreement among raft nodes before linearized reading' (duration: 116.412508ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:54.53168Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.394492ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/addressscopes/\" range_end:\"/registry/openstack.k-orc.cloud/addressscopes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:54.531851Z","caller":"traceutil/trace.go:171","msg":"trace[1460288954] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/addressscopes/; range_end:/registry/openstack.k-orc.cloud/addressscopes0; response_count:0; response_revision:24496; }","duration":"101.654518ms","start":"2026-06-02T07:42:54.430167Z","end":"2026-06-02T07:42:54.531822Z","steps":["trace[1460288954] 'count revisions from in-memory index tree' (duration: 101.26895ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:54.707066Z","caller":"traceutil/trace.go:171","msg":"trace[70572197] transaction","detail":"{read_only:false; response_revision:24499; number_of_response:1; }","duration":"139.801811ms","start":"2026-06-02T07:42:54.567241Z","end":"2026-06-02T07:42:54.707043Z","steps":["trace[70572197] 'process raft request' (duration: 139.7615ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:54.707208Z","caller":"traceutil/trace.go:171","msg":"trace[1060443694] transaction","detail":"{read_only:false; response_revision:24498; number_of_response:1; }","duration":"194.067572ms","start":"2026-06-02T07:42:54.51308Z","end":"2026-06-02T07:42:54.707147Z","steps":["trace[1060443694] 'process raft request' (duration: 130.819853ms)","trace[1060443694] 'compare' (duration: 62.974184ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:54.707316Z","caller":"traceutil/trace.go:171","msg":"trace[1221814713] linearizableReadLoop","detail":"{readStateIndex:25291; appliedIndex:25290; }","duration":"141.184359ms","start":"2026-06-02T07:42:54.566099Z","end":"2026-06-02T07:42:54.707284Z","steps":["trace[1221814713] 'read index received' (duration: 77.817597ms)","trace[1221814713] 'applied index is now lower than readState.Index' (duration: 63.363922ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:42:54.707555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.438906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T07:42:54.707589Z","caller":"traceutil/trace.go:171","msg":"trace[121768599] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24499; }","duration":"141.6555ms","start":"2026-06-02T07:42:54.565919Z","end":"2026-06-02T07:42:54.707574Z","steps":["trace[121768599] 'agreement among raft nodes before linearized reading' (duration: 141.491616ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:55.076234Z","caller":"traceutil/trace.go:171","msg":"trace[766513942] linearizableReadLoop","detail":"{readStateIndex:25293; appliedIndex:25292; }","duration":"236.426713ms","start":"2026-06-02T07:42:54.839784Z","end":"2026-06-02T07:42:55.076211Z","steps":["trace[766513942] 'read index received' (duration: 236.175737ms)","trace[766513942] 'applied index is now lower than readState.Index' (duration: 249.406µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:55.076621Z","caller":"traceutil/trace.go:171","msg":"trace[1203901756] transaction","detail":"{read_only:false; response_revision:24500; number_of_response:1; }","duration":"363.913864ms","start":"2026-06-02T07:42:54.71269Z","end":"2026-06-02T07:42:55.076603Z","steps":["trace[1203901756] 'process raft request' (duration: 363.289221ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:55.076758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:54.712666Z","time spent":"364.016556ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:42:55.077Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"237.212139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumnodes/\" range_end:\"/registry/cilium.io/ciliumnodes0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T07:42:55.077049Z","caller":"traceutil/trace.go:171","msg":"trace[1293784008] range","detail":"{range_begin:/registry/cilium.io/ciliumnodes/; range_end:/registry/cilium.io/ciliumnodes0; response_count:0; response_revision:24500; }","duration":"237.347162ms","start":"2026-06-02T07:42:54.839691Z","end":"2026-06-02T07:42:55.077038Z","steps":["trace[1293784008] 'agreement among raft nodes before linearized reading' (duration: 237.26733ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:55.077354Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.683421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-02T07:42:55.077409Z","caller":"traceutil/trace.go:171","msg":"trace[340810462] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24500; }","duration":"171.776523ms","start":"2026-06-02T07:42:54.905621Z","end":"2026-06-02T07:42:55.077397Z","steps":["trace[340810462] 'agreement among raft nodes before linearized reading' (duration: 171.62403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:55.078184Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.534336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/\" range_end:\"/registry/mutatingwebhookconfigurations0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T07:42:55.078311Z","caller":"traceutil/trace.go:171","msg":"trace[686165722] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/; range_end:/registry/mutatingwebhookconfigurations0; response_count:0; response_revision:24500; }","duration":"149.695739ms","start":"2026-06-02T07:42:54.928572Z","end":"2026-06-02T07:42:55.078268Z","steps":["trace[686165722] 'agreement among raft nodes before linearized reading' (duration: 149.501545ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:55.635913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.105969ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:55.636046Z","caller":"traceutil/trace.go:171","msg":"trace[912039971] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:24505; }","duration":"181.254923ms","start":"2026-06-02T07:42:55.454773Z","end":"2026-06-02T07:42:55.636028Z","steps":["trace[912039971] 'range keys from in-memory index tree' (duration: 181.077518ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:55.668437Z","caller":"traceutil/trace.go:171","msg":"trace[1377479560] transaction","detail":"{read_only:false; response_revision:24506; number_of_response:1; }","duration":"307.860534ms","start":"2026-06-02T07:42:55.360551Z","end":"2026-06-02T07:42:55.668411Z","steps":["trace[1377479560] 'process raft request' (duration: 307.68042ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:55.66865Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:55.360529Z","time spent":"307.987578ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:42:55.930966Z","caller":"traceutil/trace.go:171","msg":"trace[203443882] linearizableReadLoop","detail":"{readStateIndex:25300; appliedIndex:25299; }","duration":"205.224826ms","start":"2026-06-02T07:42:55.725715Z","end":"2026-06-02T07:42:55.930939Z","steps":["trace[203443882] 'read index received' (duration: 108.081354ms)","trace[203443882] 'applied index is now lower than readState.Index' (duration: 97.142052ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:55.931077Z","caller":"traceutil/trace.go:171","msg":"trace[2008056132] transaction","detail":"{read_only:false; response_revision:24507; number_of_response:1; }","duration":"338.960799ms","start":"2026-06-02T07:42:55.592108Z","end":"2026-06-02T07:42:55.931068Z","steps":["trace[2008056132] 'process raft request' (duration: 241.747105ms)","trace[2008056132] 'compare' (duration: 96.487349ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:42:55.931165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:55.592085Z","time spent":"339.011689ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:42:55.931376Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.669475ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:55.931399Z","caller":"traceutil/trace.go:171","msg":"trace[1647582190] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24507; }","duration":"205.734277ms","start":"2026-06-02T07:42:55.725658Z","end":"2026-06-02T07:42:55.931393Z","steps":["trace[1647582190] 'agreement among raft nodes before linearized reading' (duration: 205.667395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:55.931475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.804507ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:55.931546Z","caller":"traceutil/trace.go:171","msg":"trace[93853704] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:24507; }","duration":"155.929178ms","start":"2026-06-02T07:42:55.775598Z","end":"2026-06-02T07:42:55.931528Z","steps":["trace[93853704] 'agreement among raft nodes before linearized reading' (duration: 155.815586ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:56.144402Z","caller":"traceutil/trace.go:171","msg":"trace[49115397] linearizableReadLoop","detail":"{readStateIndex:25301; appliedIndex:25300; }","duration":"128.731407ms","start":"2026-06-02T07:42:56.015647Z","end":"2026-06-02T07:42:56.144378Z","steps":["trace[49115397] 'read index received' (duration: 127.277817ms)","trace[49115397] 'applied index is now lower than readState.Index' (duration: 1.45264ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:56.144483Z","caller":"traceutil/trace.go:171","msg":"trace[941840576] transaction","detail":"{read_only:false; response_revision:24508; number_of_response:1; }","duration":"136.121453ms","start":"2026-06-02T07:42:56.00833Z","end":"2026-06-02T07:42:56.144452Z","steps":["trace[941840576] 'process raft request' (duration: 134.574151ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:56.144627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.918922ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T07:42:56.144906Z","caller":"traceutil/trace.go:171","msg":"trace[814868503] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:24508; }","duration":"129.27266ms","start":"2026-06-02T07:42:56.015612Z","end":"2026-06-02T07:42:56.144884Z","steps":["trace[814868503] 'agreement among raft nodes before linearized reading' (duration: 128.892891ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:56.144665Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.966835ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-06-02T07:42:56.145074Z","caller":"traceutil/trace.go:171","msg":"trace[1014683336] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24508; }","duration":"101.393754ms","start":"2026-06-02T07:42:56.043631Z","end":"2026-06-02T07:42:56.145025Z","steps":["trace[1014683336] 'agreement among raft nodes before linearized reading' (duration: 100.905314ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:56.64747Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"339.906718ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:42:56.647639Z","caller":"traceutil/trace.go:171","msg":"trace[1389630082] transaction","detail":"{read_only:false; response_revision:24510; number_of_response:1; }","duration":"275.941283ms","start":"2026-06-02T07:42:56.371678Z","end":"2026-06-02T07:42:56.64762Z","steps":["trace[1389630082] 'process raft request' (duration: 275.880742ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:56.647759Z","caller":"traceutil/trace.go:171","msg":"trace[1025805670] transaction","detail":"{read_only:false; response_revision:24509; number_of_response:1; }","duration":"498.422182ms","start":"2026-06-02T07:42:56.149324Z","end":"2026-06-02T07:42:56.647746Z","steps":["trace[1025805670] 'process raft request' (duration: 158.164677ms)","trace[1025805670] 'compare' (duration: 339.805686ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:42:56.647809Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:56.149303Z","time spent":"498.475504ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:42:56.977818Z","caller":"traceutil/trace.go:171","msg":"trace[1126118637] transaction","detail":"{read_only:false; response_revision:24511; number_of_response:1; }","duration":"440.014474ms","start":"2026-06-02T07:42:56.537782Z","end":"2026-06-02T07:42:56.977796Z","steps":["trace[1126118637] 'process raft request' (duration: 439.868311ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:56.978014Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:56.537757Z","time spent":"440.119847ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:42:57.44192Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.966837ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:42:57.442201Z","caller":"traceutil/trace.go:171","msg":"trace[1067856341] transaction","detail":"{read_only:false; response_revision:24512; number_of_response:1; }","duration":"730.184508ms","start":"2026-06-02T07:42:56.71197Z","end":"2026-06-02T07:42:57.442154Z","steps":["trace[1067856341] 'process raft request' (duration: 509.882764ms)","trace[1067856341] 'compare' (duration: 219.563888ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:57.442357Z","caller":"traceutil/trace.go:171","msg":"trace[595842197] transaction","detail":"{read_only:false; response_revision:24515; number_of_response:1; }","duration":"287.528817ms","start":"2026-06-02T07:42:57.154755Z","end":"2026-06-02T07:42:57.442284Z","steps":["trace[595842197] 'process raft request' (duration: 287.468696ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.44244Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:56.711947Z","time spent":"730.390922ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:42:57.442756Z","caller":"traceutil/trace.go:171","msg":"trace[661437036] transaction","detail":"{read_only:false; response_revision:24514; number_of_response:1; }","duration":"317.432536ms","start":"2026-06-02T07:42:57.125312Z","end":"2026-06-02T07:42:57.442745Z","steps":["trace[661437036] 'process raft request' (duration: 316.855274ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:57.442743Z","caller":"traceutil/trace.go:171","msg":"trace[1203103333] linearizableReadLoop","detail":"{readStateIndex:25306; appliedIndex:25304; }","duration":"714.984607ms","start":"2026-06-02T07:42:56.727664Z","end":"2026-06-02T07:42:57.442649Z","steps":["trace[1203103333] 'read index received' (duration: 250.167391ms)","trace[1203103333] 'applied index is now lower than readState.Index' (duration: 464.813346ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:42:57.442813Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:57.125299Z","time spent":"317.488487ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":496,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:42:57.442866Z","caller":"traceutil/trace.go:171","msg":"trace[1580183223] transaction","detail":"{read_only:false; response_revision:24513; number_of_response:1; }","duration":"730.583016ms","start":"2026-06-02T07:42:56.712272Z","end":"2026-06-02T07:42:57.442855Z","steps":["trace[1580183223] 'process raft request' (duration: 729.78285ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.44294Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.724474ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-06-02T07:42:57.442964Z","caller":"traceutil/trace.go:171","msg":"trace[1952337058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24515; }","duration":"318.783134ms","start":"2026-06-02T07:42:57.124173Z","end":"2026-06-02T07:42:57.442956Z","steps":["trace[1952337058] 'agreement among raft nodes before linearized reading' (duration: 318.702313ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.442983Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:57.124152Z","time spent":"318.825426ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":504,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T07:42:57.44298Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:56.712264Z","time spent":"730.639967ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:42:57.443043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"715.389796ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:57.443068Z","caller":"traceutil/trace.go:171","msg":"trace[528788986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24515; }","duration":"715.450927ms","start":"2026-06-02T07:42:56.727611Z","end":"2026-06-02T07:42:57.443062Z","steps":["trace[528788986] 'agreement among raft nodes before linearized reading' (duration: 715.416256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.443066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"561.400946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"warn","ts":"2026-06-02T07:42:57.442919Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.356177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T07:42:57.443089Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.328989ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T07:42:57.443138Z","caller":"traceutil/trace.go:171","msg":"trace[348251] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:24515; }","duration":"561.469948ms","start":"2026-06-02T07:42:56.881653Z","end":"2026-06-02T07:42:57.443122Z","steps":["trace[348251] 'agreement among raft nodes before linearized reading' (duration: 561.303264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.44316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.741052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"info","ts":"2026-06-02T07:42:57.443161Z","caller":"traceutil/trace.go:171","msg":"trace[1647997492] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24515; }","duration":"360.487582ms","start":"2026-06-02T07:42:57.082656Z","end":"2026-06-02T07:42:57.443144Z","steps":["trace[1647997492] 'agreement among raft nodes before linearized reading' (duration: 360.242557ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:57.443151Z","caller":"traceutil/trace.go:171","msg":"trace[311552479] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0; response_count:0; response_revision:24515; }","duration":"678.615502ms","start":"2026-06-02T07:42:56.764516Z","end":"2026-06-02T07:42:57.443131Z","steps":["trace[311552479] 'agreement among raft nodes before linearized reading' (duration: 678.346036ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:57.443199Z","caller":"traceutil/trace.go:171","msg":"trace[145355143] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:24515; }","duration":"317.797163ms","start":"2026-06-02T07:42:57.125385Z","end":"2026-06-02T07:42:57.443183Z","steps":["trace[145355143] 'agreement among raft nodes before linearized reading' (duration: 317.719721ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.443209Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:56.881594Z","time spent":"561.584841ms","remote":"127.0.0.1:44240","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-06-02T07:42:57.443088Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:56.72759Z","time spent":"715.492278ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-02T07:42:57.443254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:57.125295Z","time spent":"317.936716ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-06-02T07:42:57.443066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.01239ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"warn","ts":"2026-06-02T07:42:57.443202Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:57.08263Z","time spent":"360.563433ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T07:42:57.443218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:56.764497Z","time spent":"678.701894ms","remote":"127.0.0.1:58454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":152,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/magnum-system0\" "} {"level":"info","ts":"2026-06-02T07:42:57.443301Z","caller":"traceutil/trace.go:171","msg":"trace[1021183665] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24515; }","duration":"320.252555ms","start":"2026-06-02T07:42:57.12304Z","end":"2026-06-02T07:42:57.443292Z","steps":["trace[1021183665] 'agreement among raft nodes before linearized reading' (duration: 319.953639ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.443413Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:57.122986Z","time spent":"320.414719ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-02T07:42:57.721062Z","caller":"traceutil/trace.go:171","msg":"trace[1857464340] transaction","detail":"{read_only:false; response_revision:24516; number_of_response:1; }","duration":"272.613094ms","start":"2026-06-02T07:42:57.448405Z","end":"2026-06-02T07:42:57.721018Z","steps":["trace[1857464340] 'process raft request' (duration: 184.413799ms)","trace[1857464340] 'compare' (duration: 87.678644ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:42:57.723514Z","caller":"traceutil/trace.go:171","msg":"trace[1275163571] transaction","detail":"{read_only:false; response_revision:24518; number_of_response:1; }","duration":"274.600106ms","start":"2026-06-02T07:42:57.448886Z","end":"2026-06-02T07:42:57.723486Z","steps":["trace[1275163571] 'process raft request' (duration: 274.499963ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:57.723568Z","caller":"traceutil/trace.go:171","msg":"trace[428658275] transaction","detail":"{read_only:false; response_revision:24517; number_of_response:1; }","duration":"275.090886ms","start":"2026-06-02T07:42:57.44845Z","end":"2026-06-02T07:42:57.72354Z","steps":["trace[428658275] 'process raft request' (duration: 274.782399ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:57.723702Z","caller":"traceutil/trace.go:171","msg":"trace[1131132091] transaction","detail":"{read_only:false; response_revision:24519; number_of_response:1; }","duration":"274.721098ms","start":"2026-06-02T07:42:57.448968Z","end":"2026-06-02T07:42:57.723689Z","steps":["trace[1131132091] 'process raft request' (duration: 274.454642ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:57.723849Z","caller":"traceutil/trace.go:171","msg":"trace[1457546055] linearizableReadLoop","detail":"{readStateIndex:25312; appliedIndex:25308; }","duration":"273.303268ms","start":"2026-06-02T07:42:57.450335Z","end":"2026-06-02T07:42:57.723639Z","steps":["trace[1457546055] 'read index received' (duration: 182.450467ms)","trace[1457546055] 'applied index is now lower than readState.Index' (duration: 90.849521ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:42:57.723992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.636094ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:18571"} {"level":"info","ts":"2026-06-02T07:42:57.724082Z","caller":"traceutil/trace.go:171","msg":"trace[1180505779] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:24519; }","duration":"273.751787ms","start":"2026-06-02T07:42:57.450308Z","end":"2026-06-02T07:42:57.72406Z","steps":["trace[1180505779] 'agreement among raft nodes before linearized reading' (duration: 273.470862ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.72439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"273.334049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/magnum-system/\" range_end:\"/registry/services/specs/magnum-system0\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:57.724469Z","caller":"traceutil/trace.go:171","msg":"trace[505869321] range","detail":"{range_begin:/registry/services/specs/magnum-system/; range_end:/registry/services/specs/magnum-system0; response_count:0; response_revision:24520; }","duration":"273.44682ms","start":"2026-06-02T07:42:57.451002Z","end":"2026-06-02T07:42:57.724449Z","steps":["trace[505869321] 'agreement among raft nodes before linearized reading' (duration: 273.295277ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:57.724501Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.140918ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.38\" ","response":"range_response_count:1 size:137"} {"level":"info","ts":"2026-06-02T07:42:57.724553Z","caller":"traceutil/trace.go:171","msg":"trace[1645970071] range","detail":"{range_begin:/registry/masterleases/199.204.45.38; range_end:; response_count:1; response_revision:24520; }","duration":"170.22764ms","start":"2026-06-02T07:42:57.554312Z","end":"2026-06-02T07:42:57.72454Z","steps":["trace[1645970071] 'agreement among raft nodes before linearized reading' (duration: 170.019495ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:58.192061Z","caller":"traceutil/trace.go:171","msg":"trace[1860007649] transaction","detail":"{read_only:false; response_revision:24522; number_of_response:1; }","duration":"255.980634ms","start":"2026-06-02T07:42:57.936063Z","end":"2026-06-02T07:42:58.192044Z","steps":["trace[1860007649] 'process raft request' (duration: 255.689368ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:58.509086Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"230.442997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:58.509761Z","caller":"traceutil/trace.go:171","msg":"trace[1887874242] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:24523; }","duration":"231.182763ms","start":"2026-06-02T07:42:58.27856Z","end":"2026-06-02T07:42:58.509742Z","steps":["trace[1887874242] 'count revisions from in-memory index tree' (duration: 230.191043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:58.50947Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.670593ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephcosidrivers/\" range_end:\"/registry/ceph.rook.io/cephcosidrivers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:58.510206Z","caller":"traceutil/trace.go:171","msg":"trace[1318584414] range","detail":"{range_begin:/registry/ceph.rook.io/cephcosidrivers/; range_end:/registry/ceph.rook.io/cephcosidrivers0; response_count:0; response_revision:24523; }","duration":"145.434219ms","start":"2026-06-02T07:42:58.364755Z","end":"2026-06-02T07:42:58.510189Z","steps":["trace[1318584414] 'count revisions from in-memory index tree' (duration: 144.450689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:58.50967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.725499ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:58.510345Z","caller":"traceutil/trace.go:171","msg":"trace[240419444] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:24523; }","duration":"121.396483ms","start":"2026-06-02T07:42:58.388891Z","end":"2026-06-02T07:42:58.510288Z","steps":["trace[240419444] 'count revisions from in-memory index tree' (duration: 120.441043ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:58.843371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.071151ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:42:58.843484Z","caller":"traceutil/trace.go:171","msg":"trace[185073968] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24525; }","duration":"115.216763ms","start":"2026-06-02T07:42:58.728229Z","end":"2026-06-02T07:42:58.843446Z","steps":["trace[185073968] 'range keys from in-memory index tree' (duration: 114.977868ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:59.13004Z","caller":"traceutil/trace.go:171","msg":"trace[1964171203] transaction","detail":"{read_only:false; response_revision:24526; number_of_response:1; }","duration":"146.828878ms","start":"2026-06-02T07:42:58.983185Z","end":"2026-06-02T07:42:59.130014Z","steps":["trace[1964171203] 'process raft request' (duration: 146.674425ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:59.336745Z","caller":"traceutil/trace.go:171","msg":"trace[706906682] transaction","detail":"{read_only:false; response_revision:24527; number_of_response:1; }","duration":"293.917341ms","start":"2026-06-02T07:42:59.042805Z","end":"2026-06-02T07:42:59.336722Z","steps":["trace[706906682] 'process raft request' (duration: 293.786689ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:42:59.711372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.289941ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:42:59.711674Z","caller":"traceutil/trace.go:171","msg":"trace[404824586] transaction","detail":"{read_only:false; response_revision:24530; number_of_response:1; }","duration":"262.290907ms","start":"2026-06-02T07:42:59.449358Z","end":"2026-06-02T07:42:59.711649Z","steps":["trace[404824586] 'process raft request' (duration: 262.189605ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:42:59.711732Z","caller":"traceutil/trace.go:171","msg":"trace[290024766] transaction","detail":"{read_only:false; response_revision:24529; number_of_response:1; }","duration":"263.174615ms","start":"2026-06-02T07:42:59.448464Z","end":"2026-06-02T07:42:59.711638Z","steps":["trace[290024766] 'process raft request' (duration: 113.452335ms)","trace[290024766] 'compare' (duration: 149.138518ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:00.058922Z","caller":"traceutil/trace.go:171","msg":"trace[1255482121] transaction","detail":"{read_only:false; response_revision:24532; number_of_response:1; }","duration":"329.329607ms","start":"2026-06-02T07:42:59.729565Z","end":"2026-06-02T07:43:00.058895Z","steps":["trace[1255482121] 'process raft request' (duration: 328.9993ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:00.058933Z","caller":"traceutil/trace.go:171","msg":"trace[1977343631] linearizableReadLoop","detail":"{readStateIndex:25326; appliedIndex:25324; }","duration":"328.328195ms","start":"2026-06-02T07:42:59.730579Z","end":"2026-06-02T07:43:00.058907Z","steps":["trace[1977343631] 'read index received' (duration: 24.997795ms)","trace[1977343631] 'applied index is now lower than readState.Index' (duration: 303.32843ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:00.059078Z","caller":"traceutil/trace.go:171","msg":"trace[1608427459] transaction","detail":"{read_only:false; response_revision:24533; number_of_response:1; }","duration":"327.607631ms","start":"2026-06-02T07:42:59.731418Z","end":"2026-06-02T07:43:00.059025Z","steps":["trace[1608427459] 'process raft request' (duration: 327.384806ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:00.059111Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:59.72955Z","time spent":"329.44147ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":608,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:00.059074Z","caller":"traceutil/trace.go:171","msg":"trace[661969476] transaction","detail":"{read_only:false; response_revision:24534; number_of_response:1; }","duration":"326.381845ms","start":"2026-06-02T07:42:59.732668Z","end":"2026-06-02T07:43:00.05905Z","steps":["trace[661969476] 'process raft request' (duration: 326.183671ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:00.059307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:59.731403Z","time spent":"327.779674ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:00.059321Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:59.732647Z","time spent":"326.60273ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:00.059421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"328.825946ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-02T07:43:00.059501Z","caller":"traceutil/trace.go:171","msg":"trace[960921688] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24534; }","duration":"328.954228ms","start":"2026-06-02T07:42:59.730528Z","end":"2026-06-02T07:43:00.059482Z","steps":["trace[960921688] 'agreement among raft nodes before linearized reading' (duration: 328.536549ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:00.059531Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:42:59.730505Z","time spent":"329.01996ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T07:43:00.283687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.393697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-06-02T07:43:00.283782Z","caller":"traceutil/trace.go:171","msg":"trace[234634733] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-glance-server-0; range_end:; response_count:1; response_revision:24535; }","duration":"115.581461ms","start":"2026-06-02T07:43:00.168179Z","end":"2026-06-02T07:43:00.28376Z","steps":["trace[234634733] 'range keys from in-memory index tree' (duration: 115.218953ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:09.409536Z","caller":"traceutil/trace.go:171","msg":"trace[606620302] transaction","detail":"{read_only:false; response_revision:24600; number_of_response:1; }","duration":"242.651954ms","start":"2026-06-02T07:43:09.166847Z","end":"2026-06-02T07:43:09.409499Z","steps":["trace[606620302] 'process raft request' (duration: 242.43462ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:09.786497Z","caller":"traceutil/trace.go:171","msg":"trace[552921745] transaction","detail":"{read_only:false; response_revision:24602; number_of_response:1; }","duration":"308.08781ms","start":"2026-06-02T07:43:09.478365Z","end":"2026-06-02T07:43:09.786453Z","steps":["trace[552921745] 'process raft request' (duration: 306.297573ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:09.786723Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:09.478344Z","time spent":"308.243193ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:10.110842Z","caller":"traceutil/trace.go:171","msg":"trace[1548786788] transaction","detail":"{read_only:false; response_revision:24603; number_of_response:1; }","duration":"337.61127ms","start":"2026-06-02T07:43:09.773212Z","end":"2026-06-02T07:43:10.110823Z","steps":["trace[1548786788] 'process raft request' (duration: 321.751476ms)","trace[1548786788] 'compare' (duration: 15.745171ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:10.110961Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:09.773192Z","time spent":"337.701401ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:10.111187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.631626ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:10.111279Z","caller":"traceutil/trace.go:171","msg":"trace[1908089894] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24605; }","duration":"323.730508ms","start":"2026-06-02T07:43:09.787532Z","end":"2026-06-02T07:43:10.111262Z","steps":["trace[1908089894] 'agreement among raft nodes before linearized reading' (duration: 323.579465ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:10.111325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:09.787512Z","time spent":"323.805199ms","remote":"127.0.0.1:44036","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T07:43:10.111153Z","caller":"traceutil/trace.go:171","msg":"trace[539826223] transaction","detail":"{read_only:false; response_revision:24604; number_of_response:1; }","duration":"337.776103ms","start":"2026-06-02T07:43:09.773298Z","end":"2026-06-02T07:43:10.111075Z","steps":["trace[539826223] 'process raft request' (duration: 337.501717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:10.111564Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:09.773275Z","time spent":"338.180182ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:10.111247Z","caller":"traceutil/trace.go:171","msg":"trace[33526859] linearizableReadLoop","detail":"{readStateIndex:25400; appliedIndex:25398; }","duration":"323.568735ms","start":"2026-06-02T07:43:09.787538Z","end":"2026-06-02T07:43:10.111106Z","steps":["trace[33526859] 'read index received' (duration: 307.419655ms)","trace[33526859] 'applied index is now lower than readState.Index' (duration: 16.14606ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:10.112519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"302.667235ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-06-02T07:43:10.112572Z","caller":"traceutil/trace.go:171","msg":"trace[1499318049] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24605; }","duration":"302.769928ms","start":"2026-06-02T07:43:09.809789Z","end":"2026-06-02T07:43:10.112559Z","steps":["trace[1499318049] 'agreement among raft nodes before linearized reading' (duration: 302.323928ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:10.11261Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:09.809776Z","time spent":"302.826049ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":531,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-06-02T07:43:10.113124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.086167ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cronjobs/\" range_end:\"/registry/cronjobs0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T07:43:10.113222Z","caller":"traceutil/trace.go:171","msg":"trace[115006016] range","detail":"{range_begin:/registry/cronjobs/; range_end:/registry/cronjobs0; response_count:0; response_revision:24605; }","duration":"198.24449ms","start":"2026-06-02T07:43:09.914948Z","end":"2026-06-02T07:43:10.113193Z","steps":["trace[115006016] 'agreement among raft nodes before linearized reading' (duration: 198.051556ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:10.538348Z","caller":"traceutil/trace.go:171","msg":"trace[261474304] linearizableReadLoop","detail":"{readStateIndex:25404; appliedIndex:25402; }","duration":"377.054811ms","start":"2026-06-02T07:43:10.161272Z","end":"2026-06-02T07:43:10.538327Z","steps":["trace[261474304] 'read index received' (duration: 376.945118ms)","trace[261474304] 'applied index is now lower than readState.Index' (duration: 108.892µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:10.538401Z","caller":"traceutil/trace.go:171","msg":"trace[696204827] transaction","detail":"{read_only:false; response_revision:24607; number_of_response:1; }","duration":"421.433964ms","start":"2026-06-02T07:43:10.116927Z","end":"2026-06-02T07:43:10.538361Z","steps":["trace[696204827] 'process raft request' (duration: 421.23943ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:10.538447Z","caller":"traceutil/trace.go:171","msg":"trace[617173083] transaction","detail":"{read_only:false; response_revision:24608; number_of_response:1; }","duration":"419.490993ms","start":"2026-06-02T07:43:10.118946Z","end":"2026-06-02T07:43:10.538437Z","steps":["trace[617173083] 'process raft request' (duration: 419.34646ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:10.538543Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.118915Z","time spent":"419.560625ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:10.538556Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.116906Z","time spent":"421.567187ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:10.538753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"377.471559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-02T07:43:10.538815Z","caller":"traceutil/trace.go:171","msg":"trace[2126512377] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24608; }","duration":"377.557541ms","start":"2026-06-02T07:43:10.161241Z","end":"2026-06-02T07:43:10.538799Z","steps":["trace[2126512377] 'agreement among raft nodes before linearized reading' (duration: 377.362717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:10.538856Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.161229Z","time spent":"377.619202ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T07:43:11.064479Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.375141ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:43:11.064689Z","caller":"traceutil/trace.go:171","msg":"trace[456857824] transaction","detail":"{read_only:false; response_revision:24610; number_of_response:1; }","duration":"522.694294ms","start":"2026-06-02T07:43:10.541974Z","end":"2026-06-02T07:43:11.064668Z","steps":["trace[456857824] 'process raft request' (duration: 522.606591ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.064762Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.541959Z","time spent":"522.769185ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:11.064734Z","caller":"traceutil/trace.go:171","msg":"trace[161259341] transaction","detail":"{read_only:false; response_revision:24609; number_of_response:1; }","duration":"751.419954ms","start":"2026-06-02T07:43:10.313226Z","end":"2026-06-02T07:43:11.064646Z","steps":["trace[161259341] 'process raft request' (duration: 320.793447ms)","trace[161259341] 'compare' (duration: 430.265869ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:11.064949Z","caller":"traceutil/trace.go:171","msg":"trace[1676167743] linearizableReadLoop","detail":"{readStateIndex:25405; appliedIndex:25404; }","duration":"526.531484ms","start":"2026-06-02T07:43:10.538407Z","end":"2026-06-02T07:43:11.064939Z","steps":["trace[1676167743] 'read index received' (duration: 95.626571ms)","trace[1676167743] 'applied index is now lower than readState.Index' (duration: 430.903703ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:11.064936Z","caller":"traceutil/trace.go:171","msg":"trace[598001232] transaction","detail":"{read_only:false; response_revision:24611; number_of_response:1; }","duration":"339.41355ms","start":"2026-06-02T07:43:10.725491Z","end":"2026-06-02T07:43:11.064905Z","steps":["trace[598001232] 'process raft request' (duration: 339.137174ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.064966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.313193Z","time spent":"751.66834ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:11.065101Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.725468Z","time spent":"339.545362ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:11.06515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"897.103358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:11.065189Z","caller":"traceutil/trace.go:171","msg":"trace[993036183] range","detail":"{range_begin:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/; range_end:/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0; response_count:0; response_revision:24611; }","duration":"897.16764ms","start":"2026-06-02T07:43:10.16801Z","end":"2026-06-02T07:43:11.065177Z","steps":["trace[993036183] 'agreement among raft nodes before linearized reading' (duration: 897.092359ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.065226Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.167999Z","time spent":"897.219001ms","remote":"127.0.0.1:58336","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":28,"request content":"key:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates/\" range_end:\"/registry/bootstrap.cluster.x-k8s.io/kubeadmconfigtemplates0\" count_only:true "} {"level":"warn","ts":"2026-06-02T07:43:11.065222Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"473.347915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T07:43:11.065293Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.852477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:11.065315Z","caller":"traceutil/trace.go:171","msg":"trace[810862467] range","detail":"{range_begin:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/; range_end:/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0; response_count:0; response_revision:24611; }","duration":"473.490139ms","start":"2026-06-02T07:43:10.591805Z","end":"2026-06-02T07:43:11.065295Z","steps":["trace[810862467] 'agreement among raft nodes before linearized reading' (duration: 473.315295ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.06533Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"441.778141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-06-02T07:43:11.065329Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.268035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-02T07:43:11.065339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.203044ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ipam.cluster.x-k8s.io/ipaddresses/\" range_end:\"/registry/ipam.cluster.x-k8s.io/ipaddresses0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:11.065385Z","caller":"traceutil/trace.go:171","msg":"trace[1457553651] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:24611; }","duration":"441.872923ms","start":"2026-06-02T07:43:10.6235Z","end":"2026-06-02T07:43:11.065373Z","steps":["trace[1457553651] 'agreement among raft nodes before linearized reading' (duration: 441.759481ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:11.065398Z","caller":"traceutil/trace.go:171","msg":"trace[1892434752] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:24611; }","duration":"309.388877ms","start":"2026-06-02T07:43:10.755992Z","end":"2026-06-02T07:43:11.065381Z","steps":["trace[1892434752] 'agreement among raft nodes before linearized reading' (duration: 309.176373ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:11.065337Z","caller":"traceutil/trace.go:171","msg":"trace[2124315689] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-manila; range_end:; response_count:0; response_revision:24611; }","duration":"192.925467ms","start":"2026-06-02T07:43:10.872397Z","end":"2026-06-02T07:43:11.065322Z","steps":["trace[2124315689] 'agreement among raft nodes before linearized reading' (duration: 192.866216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.065424Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.623479Z","time spent":"441.936555ms","remote":"127.0.0.1:44582","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":19,"response size":30,"request content":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true "} {"level":"info","ts":"2026-06-02T07:43:11.065429Z","caller":"traceutil/trace.go:171","msg":"trace[425061576] range","detail":"{range_begin:/registry/ipam.cluster.x-k8s.io/ipaddresses/; range_end:/registry/ipam.cluster.x-k8s.io/ipaddresses0; response_count:0; response_revision:24611; }","duration":"136.364528ms","start":"2026-06-02T07:43:10.929042Z","end":"2026-06-02T07:43:11.065407Z","steps":["trace[425061576] 'agreement among raft nodes before linearized reading' (duration: 136.182164ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.065364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.59179Z","time spent":"473.56269ms","remote":"127.0.0.1:58282","response type":"/etcdserverpb.KV/Range","request count":0,"request size":128,"response count":0,"response size":28,"request content":"key:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings/\" range_end:\"/registry/addons.cluster.x-k8s.io/clusterresourcesetbindings0\" count_only:true "} {"level":"warn","ts":"2026-06-02T07:43:11.065187Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"725.386686ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-02T07:43:11.065538Z","caller":"traceutil/trace.go:171","msg":"trace[1207798660] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24611; }","duration":"725.820786ms","start":"2026-06-02T07:43:10.339707Z","end":"2026-06-02T07:43:11.065527Z","steps":["trace[1207798660] 'agreement among raft nodes before linearized reading' (duration: 725.355376ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.06558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.339684Z","time spent":"725.879566ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":463,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-06-02T07:43:11.06545Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.75597Z","time spent":"309.468609ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-06-02T07:43:11.065876Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.664232ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:11.065988Z","caller":"traceutil/trace.go:171","msg":"trace[1194492824] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24611; }","duration":"338.310926ms","start":"2026-06-02T07:43:10.727661Z","end":"2026-06-02T07:43:11.065972Z","steps":["trace[1194492824] 'agreement among raft nodes before linearized reading' (duration: 337.54542ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.06622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:10.727641Z","time spent":"338.55702ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T07:43:11.355776Z","caller":"traceutil/trace.go:171","msg":"trace[27677741] transaction","detail":"{read_only:false; response_revision:24612; number_of_response:1; }","duration":"285.531516ms","start":"2026-06-02T07:43:11.070203Z","end":"2026-06-02T07:43:11.355734Z","steps":["trace[27677741] 'process raft request' (duration: 268.869935ms)","trace[27677741] 'compare' (duration: 16.491337ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:11.355924Z","caller":"traceutil/trace.go:171","msg":"trace[298225714] linearizableReadLoop","detail":"{readStateIndex:25409; appliedIndex:25407; }","duration":"107.529941ms","start":"2026-06-02T07:43:11.248371Z","end":"2026-06-02T07:43:11.355901Z","steps":["trace[298225714] 'read index received' (duration: 90.729278ms)","trace[298225714] 'applied index is now lower than readState.Index' (duration: 16.799753ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:11.356583Z","caller":"traceutil/trace.go:171","msg":"trace[1502116348] transaction","detail":"{read_only:false; response_revision:24613; number_of_response:1; }","duration":"285.946494ms","start":"2026-06-02T07:43:11.0706Z","end":"2026-06-02T07:43:11.356547Z","steps":["trace[1502116348] 'process raft request' (duration: 285.091325ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:11.356938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.549663ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:11.356978Z","caller":"traceutil/trace.go:171","msg":"trace[2118495282] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanetemplates0; response_count:0; response_revision:24613; }","duration":"108.661935ms","start":"2026-06-02T07:43:11.248307Z","end":"2026-06-02T07:43:11.356969Z","steps":["trace[2118495282] 'agreement among raft nodes before linearized reading' (duration: 107.976581ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:11.996781Z","caller":"traceutil/trace.go:171","msg":"trace[718146461] transaction","detail":"{read_only:false; response_revision:24614; number_of_response:1; }","duration":"582.152014ms","start":"2026-06-02T07:43:11.414578Z","end":"2026-06-02T07:43:11.99673Z","steps":["trace[718146461] 'process raft request' (duration: 581.93551ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:11.996732Z","caller":"traceutil/trace.go:171","msg":"trace[1473788824] linearizableReadLoop","detail":"{readStateIndex:25410; appliedIndex:25409; }","duration":"284.972404ms","start":"2026-06-02T07:43:11.711726Z","end":"2026-06-02T07:43:11.996699Z","steps":["trace[1473788824] 'read index received' (duration: 284.754479ms)","trace[1473788824] 'applied index is now lower than readState.Index' (duration: 216.895µs)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:11.996912Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:11.414551Z","time spent":"582.295297ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":522,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:11.996926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.167577ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/\" range_end:\"/registry/monitoring.coreos.com/prometheuses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-02T07:43:11.997Z","caller":"traceutil/trace.go:171","msg":"trace[1849960803] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/; range_end:/registry/monitoring.coreos.com/prometheuses0; response_count:0; response_revision:24614; }","duration":"285.307671ms","start":"2026-06-02T07:43:11.711674Z","end":"2026-06-02T07:43:11.996982Z","steps":["trace[1849960803] 'agreement among raft nodes before linearized reading' (duration: 285.143037ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:12.252395Z","caller":"traceutil/trace.go:171","msg":"trace[230122829] transaction","detail":"{read_only:false; response_revision:24615; number_of_response:1; }","duration":"458.701937ms","start":"2026-06-02T07:43:11.793663Z","end":"2026-06-02T07:43:12.252364Z","steps":["trace[230122829] 'process raft request' (duration: 456.391069ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:12.252664Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:11.793643Z","time spent":"458.906722ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:12.252483Z","caller":"traceutil/trace.go:171","msg":"trace[1215989125] linearizableReadLoop","detail":"{readStateIndex:25411; appliedIndex:25410; }","duration":"162.357085ms","start":"2026-06-02T07:43:12.090102Z","end":"2026-06-02T07:43:12.252459Z","steps":["trace[1215989125] 'read index received' (duration: 159.985654ms)","trace[1215989125] 'applied index is now lower than readState.Index' (duration: 2.36929ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:12.252676Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.560109ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0\" ","response":"range_response_count:1 size:1864"} {"level":"info","ts":"2026-06-02T07:43:12.252877Z","caller":"traceutil/trace.go:171","msg":"trace[473769890] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-octavia-server-0; range_end:; response_count:1; response_revision:24615; }","duration":"162.758413ms","start":"2026-06-02T07:43:12.09009Z","end":"2026-06-02T07:43:12.252848Z","steps":["trace[473769890] 'agreement among raft nodes before linearized reading' (duration: 162.439066ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:12.253619Z","caller":"traceutil/trace.go:171","msg":"trace[656533596] transaction","detail":"{read_only:false; response_revision:24616; number_of_response:1; }","duration":"135.812967ms","start":"2026-06-02T07:43:12.117792Z","end":"2026-06-02T07:43:12.253605Z","steps":["trace[656533596] 'process raft request' (duration: 134.794626ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:12.254163Z","caller":"traceutil/trace.go:171","msg":"trace[793525427] transaction","detail":"{read_only:false; response_revision:24617; number_of_response:1; }","duration":"135.173393ms","start":"2026-06-02T07:43:12.118973Z","end":"2026-06-02T07:43:12.254146Z","steps":["trace[793525427] 'process raft request' (duration: 134.698663ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:12.254824Z","caller":"traceutil/trace.go:171","msg":"trace[2111363907] transaction","detail":"{read_only:false; response_revision:24618; number_of_response:1; }","duration":"124.991048ms","start":"2026-06-02T07:43:12.129819Z","end":"2026-06-02T07:43:12.25481Z","steps":["trace[2111363907] 'process raft request' (duration: 123.976717ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:13.625171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.478231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-3a382e09-70ae-43f4-b565-ba09e8cf7ed7\" ","response":"range_response_count:1 size:3643"} {"level":"info","ts":"2026-06-02T07:43:13.625276Z","caller":"traceutil/trace.go:171","msg":"trace[488296345] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-3a382e09-70ae-43f4-b565-ba09e8cf7ed7; range_end:; response_count:1; response_revision:24685; }","duration":"107.647984ms","start":"2026-06-02T07:43:13.517602Z","end":"2026-06-02T07:43:13.62525Z","steps":["trace[488296345] 'range keys from in-memory index tree' (duration: 107.248115ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:15.509308Z","caller":"traceutil/trace.go:171","msg":"trace[1894964637] transaction","detail":"{read_only:false; response_revision:24700; number_of_response:1; }","duration":"136.834748ms","start":"2026-06-02T07:43:15.372449Z","end":"2026-06-02T07:43:15.509283Z","steps":["trace[1894964637] 'process raft request' (duration: 136.692155ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:15.630105Z","caller":"traceutil/trace.go:171","msg":"trace[1341949354] transaction","detail":"{read_only:false; response_revision:24701; number_of_response:1; }","duration":"257.397544ms","start":"2026-06-02T07:43:15.372654Z","end":"2026-06-02T07:43:15.630051Z","steps":["trace[1341949354] 'process raft request' (duration: 212.466469ms)","trace[1341949354] 'compare' (duration: 44.668459ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:19.238198Z","caller":"traceutil/trace.go:171","msg":"trace[1598089822] transaction","detail":"{read_only:false; response_revision:24745; number_of_response:1; }","duration":"137.42825ms","start":"2026-06-02T07:43:19.100747Z","end":"2026-06-02T07:43:19.238175Z","steps":["trace[1598089822] 'process raft request' (duration: 137.294628ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:19.445788Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.101586ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:43:19.44586Z","caller":"traceutil/trace.go:171","msg":"trace[302963898] linearizableReadLoop","detail":"{readStateIndex:25545; appliedIndex:25543; }","duration":"321.923851ms","start":"2026-06-02T07:43:19.123924Z","end":"2026-06-02T07:43:19.445848Z","steps":["trace[302963898] 'read index received' (duration: 114.207922ms)","trace[302963898] 'applied index is now lower than readState.Index' (duration: 207.715309ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:19.44602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.104954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-02T07:43:19.446041Z","caller":"traceutil/trace.go:171","msg":"trace[1507977902] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:24746; }","duration":"322.166276ms","start":"2026-06-02T07:43:19.123869Z","end":"2026-06-02T07:43:19.446036Z","steps":["trace[1507977902] 'agreement among raft nodes before linearized reading' (duration: 322.036783ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:19.44606Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:19.123847Z","time spent":"322.208516ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-06-02T07:43:19.446127Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.475534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:10358"} {"level":"info","ts":"2026-06-02T07:43:19.446037Z","caller":"traceutil/trace.go:171","msg":"trace[1400585126] transaction","detail":"{read_only:false; response_revision:24746; number_of_response:1; }","duration":"338.270474ms","start":"2026-06-02T07:43:19.107607Z","end":"2026-06-02T07:43:19.445878Z","steps":["trace[1400585126] 'process raft request' (duration: 188.007644ms)","trace[1400585126] 'compare' (duration: 149.940783ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:19.446192Z","caller":"traceutil/trace.go:171","msg":"trace[253697956] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24746; }","duration":"276.601867ms","start":"2026-06-02T07:43:19.169577Z","end":"2026-06-02T07:43:19.446179Z","steps":["trace[253697956] 'agreement among raft nodes before linearized reading' (duration: 276.414693ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:19.446228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"200.603849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0\" ","response":"range_response_count:1 size:1860"} {"level":"info","ts":"2026-06-02T07:43:19.446284Z","caller":"traceutil/trace.go:171","msg":"trace[1056780587] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-manila-server-0; range_end:; response_count:1; response_revision:24746; }","duration":"200.697981ms","start":"2026-06-02T07:43:19.24557Z","end":"2026-06-02T07:43:19.446268Z","steps":["trace[1056780587] 'agreement among raft nodes before linearized reading' (duration: 200.556958ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:19.446641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:19.107586Z","time spent":"338.721184ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:32.45921Z","caller":"traceutil/trace.go:171","msg":"trace[1409923681] transaction","detail":"{read_only:false; response_revision:24853; number_of_response:1; }","duration":"128.017252ms","start":"2026-06-02T07:43:32.331172Z","end":"2026-06-02T07:43:32.459189Z","steps":["trace[1409923681] 'process raft request' (duration: 127.864239ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:32.677741Z","caller":"traceutil/trace.go:171","msg":"trace[771874918] transaction","detail":"{read_only:false; response_revision:24854; number_of_response:1; }","duration":"343.191938ms","start":"2026-06-02T07:43:32.334507Z","end":"2026-06-02T07:43:32.677699Z","steps":["trace[771874918] 'process raft request' (duration: 309.254705ms)","trace[771874918] 'compare' (duration: 33.743539ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:32.677947Z","caller":"traceutil/trace.go:171","msg":"trace[724261536] linearizableReadLoop","detail":"{readStateIndex:25657; appliedIndex:25654; }","duration":"324.021915ms","start":"2026-06-02T07:43:32.353894Z","end":"2026-06-02T07:43:32.677916Z","steps":["trace[724261536] 'read index received' (duration: 105.281544ms)","trace[724261536] 'applied index is now lower than readState.Index' (duration: 218.738631ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:32.678088Z","caller":"traceutil/trace.go:171","msg":"trace[1620161082] transaction","detail":"{read_only:false; response_revision:24856; number_of_response:1; }","duration":"338.336196ms","start":"2026-06-02T07:43:32.339737Z","end":"2026-06-02T07:43:32.678073Z","steps":["trace[1620161082] 'process raft request' (duration: 337.956008ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:32.678114Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.33448Z","time spent":"343.369383ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":523,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:32.678194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.339728Z","time spent":"338.391417ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":497,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:32.677759Z","caller":"traceutil/trace.go:171","msg":"trace[930035075] transaction","detail":"{read_only:false; response_revision:24855; number_of_response:1; }","duration":"341.567354ms","start":"2026-06-02T07:43:32.336165Z","end":"2026-06-02T07:43:32.677732Z","steps":["trace[930035075] 'process raft request' (duration: 341.479352ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:32.678386Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.33615Z","time spent":"342.167576ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:32.67844Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.669165ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:32.678537Z","caller":"traceutil/trace.go:171","msg":"trace[1795990274] range","detail":"{range_begin:/registry/cilium.io/ciliumpodippools/; range_end:/registry/cilium.io/ciliumpodippools0; response_count:0; response_revision:24856; }","duration":"311.813248ms","start":"2026-06-02T07:43:32.366703Z","end":"2026-06-02T07:43:32.678516Z","steps":["trace[1795990274] 'agreement among raft nodes before linearized reading' (duration: 311.607494ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:32.678622Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.36669Z","time spent":"311.919ms","remote":"127.0.0.1:42614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":0,"response size":28,"request content":"key:\"/registry/cilium.io/ciliumpodippools/\" range_end:\"/registry/cilium.io/ciliumpodippools0\" count_only:true "} {"level":"warn","ts":"2026-06-02T07:43:32.678756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"324.856043ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-02T07:43:32.678835Z","caller":"traceutil/trace.go:171","msg":"trace[191274833] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:24856; }","duration":"324.966925ms","start":"2026-06-02T07:43:32.353848Z","end":"2026-06-02T07:43:32.678815Z","steps":["trace[191274833] 'agreement among raft nodes before linearized reading' (duration: 324.526626ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:32.678884Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.353831Z","time spent":"325.042687ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"info","ts":"2026-06-02T07:43:32.997616Z","caller":"traceutil/trace.go:171","msg":"trace[566805358] transaction","detail":"{read_only:false; response_revision:24857; number_of_response:1; }","duration":"315.19704ms","start":"2026-06-02T07:43:32.682367Z","end":"2026-06-02T07:43:32.997564Z","steps":["trace[566805358] 'process raft request' (duration: 299.299675ms)","trace[566805358] 'compare' (duration: 15.569378ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:32.998081Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.682351Z","time spent":"315.603078ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:33.00034Z","caller":"traceutil/trace.go:171","msg":"trace[1769540060] transaction","detail":"{read_only:false; response_revision:24858; number_of_response:1; }","duration":"317.11007ms","start":"2026-06-02T07:43:32.683208Z","end":"2026-06-02T07:43:33.000318Z","steps":["trace[1769540060] 'process raft request' (duration: 316.979777ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:33.000513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.683192Z","time spent":"317.241322ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-02T07:43:33.000635Z","caller":"traceutil/trace.go:171","msg":"trace[1779341332] transaction","detail":"{read_only:false; response_revision:24859; number_of_response:1; }","duration":"316.63739ms","start":"2026-06-02T07:43:32.683973Z","end":"2026-06-02T07:43:33.00061Z","steps":["trace[1779341332] 'process raft request' (duration: 316.309823ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:33.000755Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.683956Z","time spent":"316.740001ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":477,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:33.181249Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.6783ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-06-02T07:43:33.181353Z","caller":"traceutil/trace.go:171","msg":"trace[1038759855] linearizableReadLoop","detail":"{readStateIndex:25660; appliedIndex:25657; }","duration":"455.194723ms","start":"2026-06-02T07:43:32.726138Z","end":"2026-06-02T07:43:33.181333Z","steps":["trace[1038759855] 'read index received' (duration: 255.474753ms)","trace[1038759855] 'applied index is now lower than readState.Index' (duration: 199.71838ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:33.181504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"455.353737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:33.181545Z","caller":"traceutil/trace.go:171","msg":"trace[561056001] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24859; }","duration":"455.428889ms","start":"2026-06-02T07:43:32.726104Z","end":"2026-06-02T07:43:33.181532Z","steps":["trace[561056001] 'agreement among raft nodes before linearized reading' (duration: 455.344618ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:33.18154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"315.036477ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-06-02T07:43:33.18158Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.726087Z","time spent":"455.48504ms","remote":"127.0.0.1:44050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-06-02T07:43:33.181609Z","caller":"traceutil/trace.go:171","msg":"trace[1371612899] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclusters/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclusters0; response_count:0; response_revision:24859; }","duration":"315.141008ms","start":"2026-06-02T07:43:32.866446Z","end":"2026-06-02T07:43:33.181587Z","steps":["trace[1371612899] 'agreement among raft nodes before linearized reading' (duration: 315.022256ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:33.181669Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:32.866429Z","time spent":"315.223861ms","remote":"127.0.0.1:58454","response type":"/etcdserverpb.KV/Range","request count":0,"request size":126,"response count":0,"response size":28,"request content":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclusters0\" count_only:true "} {"level":"info","ts":"2026-06-02T07:43:33.60491Z","caller":"traceutil/trace.go:171","msg":"trace[1726141525] transaction","detail":"{read_only:false; response_revision:24861; number_of_response:1; }","duration":"116.142923ms","start":"2026-06-02T07:43:33.488745Z","end":"2026-06-02T07:43:33.604888Z","steps":["trace[1726141525] 'process raft request' (duration: 115.906468ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:33.922365Z","caller":"traceutil/trace.go:171","msg":"trace[2055153490] linearizableReadLoop","detail":"{readStateIndex:25665; appliedIndex:25664; }","duration":"213.780386ms","start":"2026-06-02T07:43:33.708546Z","end":"2026-06-02T07:43:33.922326Z","steps":["trace[2055153490] 'read index received' (duration: 213.49596ms)","trace[2055153490] 'applied index is now lower than readState.Index' (duration: 282.356µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:33.922455Z","caller":"traceutil/trace.go:171","msg":"trace[1538954233] transaction","detail":"{read_only:false; response_revision:24863; number_of_response:1; }","duration":"311.44982ms","start":"2026-06-02T07:43:33.610971Z","end":"2026-06-02T07:43:33.922421Z","steps":["trace[1538954233] 'process raft request' (duration: 311.117403ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:33.922608Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-02T07:43:33.610958Z","time spent":"311.571702ms","remote":"127.0.0.1:44322","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":40,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-02T07:43:33.922637Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.582602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:33.922731Z","caller":"traceutil/trace.go:171","msg":"trace[1888104189] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24863; }","duration":"194.758755ms","start":"2026-06-02T07:43:33.727952Z","end":"2026-06-02T07:43:33.922711Z","steps":["trace[1888104189] 'agreement among raft nodes before linearized reading' (duration: 194.628132ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:33.922756Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.176974ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-02T07:43:33.922852Z","caller":"traceutil/trace.go:171","msg":"trace[379727114] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:24863; }","duration":"214.327167ms","start":"2026-06-02T07:43:33.708502Z","end":"2026-06-02T07:43:33.922829Z","steps":["trace[379727114] 'agreement among raft nodes before linearized reading' (duration: 214.01859ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:33.922893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"148.727668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:33.923031Z","caller":"traceutil/trace.go:171","msg":"trace[1173107828] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24863; }","duration":"148.892911ms","start":"2026-06-02T07:43:33.774093Z","end":"2026-06-02T07:43:33.922986Z","steps":["trace[1173107828] 'agreement among raft nodes before linearized reading' (duration: 148.543974ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:34.088477Z","caller":"traceutil/trace.go:171","msg":"trace[720765985] linearizableReadLoop","detail":"{readStateIndex:25666; appliedIndex:25665; }","duration":"161.875015ms","start":"2026-06-02T07:43:33.926573Z","end":"2026-06-02T07:43:34.088448Z","steps":["trace[720765985] 'read index received' (duration: 160.323223ms)","trace[720765985] 'applied index is now lower than readState.Index' (duration: 1.550832ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:34.088646Z","caller":"traceutil/trace.go:171","msg":"trace[1125697442] transaction","detail":"{read_only:false; response_revision:24864; number_of_response:1; }","duration":"162.351965ms","start":"2026-06-02T07:43:33.926249Z","end":"2026-06-02T07:43:34.088601Z","steps":["trace[1125697442] 'process raft request' (duration: 160.628559ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:34.08884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.256252ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:34.088905Z","caller":"traceutil/trace.go:171","msg":"trace[1869719025] range","detail":"{range_begin:/registry/services/specs/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:24865; }","duration":"162.358865ms","start":"2026-06-02T07:43:33.926532Z","end":"2026-06-02T07:43:34.088891Z","steps":["trace[1869719025] 'agreement among raft nodes before linearized reading' (duration: 162.026048ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:34.850986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.978885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/objectbucket.io/objectbucketclaims/\" range_end:\"/registry/objectbucket.io/objectbucketclaims0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:34.851083Z","caller":"traceutil/trace.go:171","msg":"trace[1114982199] range","detail":"{range_begin:/registry/objectbucket.io/objectbucketclaims/; range_end:/registry/objectbucket.io/objectbucketclaims0; response_count:0; response_revision:24867; }","duration":"247.113388ms","start":"2026-06-02T07:43:34.603943Z","end":"2026-06-02T07:43:34.851057Z","steps":["trace[1114982199] 'count revisions from in-memory index tree' (duration: 246.901752ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:34.87062Z","caller":"traceutil/trace.go:171","msg":"trace[833550102] transaction","detail":"{read_only:false; response_revision:24868; number_of_response:1; }","duration":"187.401771ms","start":"2026-06-02T07:43:34.683189Z","end":"2026-06-02T07:43:34.87059Z","steps":["trace[833550102] 'process raft request' (duration: 187.223437ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:34.917785Z","caller":"traceutil/trace.go:171","msg":"trace[1447902692] transaction","detail":"{read_only:false; response_revision:24870; number_of_response:1; }","duration":"233.390629ms","start":"2026-06-02T07:43:34.684357Z","end":"2026-06-02T07:43:34.917747Z","steps":["trace[1447902692] 'process raft request' (duration: 233.284847ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:34.917843Z","caller":"traceutil/trace.go:171","msg":"trace[495264818] transaction","detail":"{read_only:false; response_revision:24869; number_of_response:1; }","duration":"234.239396ms","start":"2026-06-02T07:43:34.683506Z","end":"2026-06-02T07:43:34.917745Z","steps":["trace[495264818] 'process raft request' (duration: 233.98062ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:34.918115Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"196.39483ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/\" range_end:\"/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:34.918247Z","caller":"traceutil/trace.go:171","msg":"trace[241752688] range","detail":"{range_begin:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates/; range_end:/registry/infrastructure.cluster.x-k8s.io/openstackclustertemplates0; response_count:0; response_revision:24870; }","duration":"196.595745ms","start":"2026-06-02T07:43:34.721624Z","end":"2026-06-02T07:43:34.91822Z","steps":["trace[241752688] 'agreement among raft nodes before linearized reading' (duration: 196.337659ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:34.91832Z","caller":"traceutil/trace.go:171","msg":"trace[2007187765] linearizableReadLoop","detail":"{readStateIndex:25672; appliedIndex:25669; }","duration":"196.017413ms","start":"2026-06-02T07:43:34.721678Z","end":"2026-06-02T07:43:34.917695Z","steps":["trace[2007187765] 'read index received' (duration: 148.808289ms)","trace[2007187765] 'applied index is now lower than readState.Index' (duration: 47.208214ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:34.918685Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.086619ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:34.918768Z","caller":"traceutil/trace.go:171","msg":"trace[976614977] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24870; }","duration":"191.219972ms","start":"2026-06-02T07:43:34.727519Z","end":"2026-06-02T07:43:34.918739Z","steps":["trace[976614977] 'agreement among raft nodes before linearized reading' (duration: 191.0852ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:35.219198Z","caller":"traceutil/trace.go:171","msg":"trace[523894104] linearizableReadLoop","detail":"{readStateIndex:25675; appliedIndex:25673; }","duration":"139.716559ms","start":"2026-06-02T07:43:35.079453Z","end":"2026-06-02T07:43:35.21917Z","steps":["trace[523894104] 'read index received' (duration: 52.329431ms)","trace[523894104] 'applied index is now lower than readState.Index' (duration: 87.386088ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:35.219344Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.861592ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/openstack.k-orc.cloud/roles/\" range_end:\"/registry/openstack.k-orc.cloud/roles0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:35.21935Z","caller":"traceutil/trace.go:171","msg":"trace[876909530] transaction","detail":"{read_only:false; response_revision:24873; number_of_response:1; }","duration":"145.766085ms","start":"2026-06-02T07:43:35.07353Z","end":"2026-06-02T07:43:35.219296Z","steps":["trace[876909530] 'process raft request' (duration: 145.50027ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:35.219392Z","caller":"traceutil/trace.go:171","msg":"trace[1877963866] range","detail":"{range_begin:/registry/openstack.k-orc.cloud/roles/; range_end:/registry/openstack.k-orc.cloud/roles0; response_count:0; response_revision:24873; }","duration":"139.943774ms","start":"2026-06-02T07:43:35.079429Z","end":"2026-06-02T07:43:35.219373Z","steps":["trace[1877963866] 'agreement among raft nodes before linearized reading' (duration: 139.845752ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:36.28164Z","caller":"traceutil/trace.go:171","msg":"trace[1032061819] transaction","detail":"{read_only:false; response_revision:24884; number_of_response:1; }","duration":"183.895617ms","start":"2026-06-02T07:43:36.097702Z","end":"2026-06-02T07:43:36.281597Z","steps":["trace[1032061819] 'process raft request' (duration: 125.400677ms)","trace[1032061819] 'compare' (duration: 58.255875ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:41.095133Z","caller":"traceutil/trace.go:171","msg":"trace[1234531087] transaction","detail":"{read_only:false; response_revision:24934; number_of_response:1; }","duration":"158.787089ms","start":"2026-06-02T07:43:40.936323Z","end":"2026-06-02T07:43:41.09511Z","steps":["trace[1234531087] 'process raft request' (duration: 158.729207ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:41.095154Z","caller":"traceutil/trace.go:171","msg":"trace[277346756] transaction","detail":"{read_only:false; response_revision:24933; number_of_response:1; }","duration":"159.962454ms","start":"2026-06-02T07:43:40.935163Z","end":"2026-06-02T07:43:41.095125Z","steps":["trace[277346756] 'process raft request' (duration: 137.161594ms)","trace[277346756] 'compare' (duration: 22.548335ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:41.333306Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.443238ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:43:41.333408Z","caller":"traceutil/trace.go:171","msg":"trace[612822776] linearizableReadLoop","detail":"{readStateIndex:25739; appliedIndex:25738; }","duration":"166.158904ms","start":"2026-06-02T07:43:41.16723Z","end":"2026-06-02T07:43:41.333389Z","steps":["trace[612822776] 'read index received' (duration: 30.44646ms)","trace[612822776] 'applied index is now lower than readState.Index' (duration: 135.711344ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:41.333479Z","caller":"traceutil/trace.go:171","msg":"trace[1894400279] transaction","detail":"{read_only:false; response_revision:24935; number_of_response:1; }","duration":"176.491413ms","start":"2026-06-02T07:43:41.156916Z","end":"2026-06-02T07:43:41.333407Z","steps":["trace[1894400279] 'process raft request' (duration: 40.85307ms)","trace[1894400279] 'compare' (duration: 135.320896ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:41.333635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.39551ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-06-02T07:43:41.333704Z","caller":"traceutil/trace.go:171","msg":"trace[1802159944] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:24935; }","duration":"166.480892ms","start":"2026-06-02T07:43:41.167206Z","end":"2026-06-02T07:43:41.333687Z","steps":["trace[1802159944] 'agreement among raft nodes before linearized reading' (duration: 166.293748ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:41.510516Z","caller":"traceutil/trace.go:171","msg":"trace[1406057127] transaction","detail":"{read_only:false; response_revision:24936; number_of_response:1; }","duration":"173.000358ms","start":"2026-06-02T07:43:41.337496Z","end":"2026-06-02T07:43:41.510496Z","steps":["trace[1406057127] 'process raft request' (duration: 172.839735ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:41.520624Z","caller":"traceutil/trace.go:171","msg":"trace[851341192] transaction","detail":"{read_only:false; response_revision:24937; number_of_response:1; }","duration":"182.377955ms","start":"2026-06-02T07:43:41.338209Z","end":"2026-06-02T07:43:41.520587Z","steps":["trace[851341192] 'process raft request' (duration: 182.11264ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:44.889691Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.869205ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:44.889788Z","caller":"traceutil/trace.go:171","msg":"trace[1352804469] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:24958; }","duration":"162.000048ms","start":"2026-06-02T07:43:44.727764Z","end":"2026-06-02T07:43:44.889764Z","steps":["trace[1352804469] 'range keys from in-memory index tree' (duration: 161.806553ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:50.75456Z","caller":"traceutil/trace.go:171","msg":"trace[1802803526] transaction","detail":"{read_only:false; response_revision:25003; number_of_response:1; }","duration":"127.254848ms","start":"2026-06-02T07:43:50.627272Z","end":"2026-06-02T07:43:50.754526Z","steps":["trace[1802803526] 'process raft request' (duration: 74.299744ms)","trace[1802803526] 'compare' (duration: 52.81447ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:51.665913Z","caller":"traceutil/trace.go:171","msg":"trace[423009077] linearizableReadLoop","detail":"{readStateIndex:25814; appliedIndex:25813; }","duration":"108.567254ms","start":"2026-06-02T07:43:51.557318Z","end":"2026-06-02T07:43:51.665885Z","steps":["trace[423009077] 'read index received' (duration: 108.469242ms)","trace[423009077] 'applied index is now lower than readState.Index' (duration: 96.972µs)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:51.665998Z","caller":"traceutil/trace.go:171","msg":"trace[1808468433] transaction","detail":"{read_only:false; response_revision:25008; number_of_response:1; }","duration":"115.162843ms","start":"2026-06-02T07:43:51.5508Z","end":"2026-06-02T07:43:51.665962Z","steps":["trace[1808468433] 'process raft request' (duration: 114.918727ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:51.666156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.824919ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-06-02T07:43:51.666203Z","caller":"traceutil/trace.go:171","msg":"trace[1096236150] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:25008; }","duration":"108.914581ms","start":"2026-06-02T07:43:51.557276Z","end":"2026-06-02T07:43:51.666191Z","steps":["trace[1096236150] 'agreement among raft nodes before linearized reading' (duration: 108.737868ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:51.846317Z","caller":"traceutil/trace.go:171","msg":"trace[637652821] transaction","detail":"{read_only:false; response_revision:25009; number_of_response:1; }","duration":"247.148578ms","start":"2026-06-02T07:43:51.599144Z","end":"2026-06-02T07:43:51.846292Z","steps":["trace[637652821] 'process raft request' (duration: 159.584516ms)","trace[637652821] 'compare' (duration: 86.751965ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:51.846504Z","caller":"traceutil/trace.go:171","msg":"trace[1992142683] transaction","detail":"{read_only:false; response_revision:25010; number_of_response:1; }","duration":"192.464618ms","start":"2026-06-02T07:43:51.654024Z","end":"2026-06-02T07:43:51.846488Z","steps":["trace[1992142683] 'process raft request' (duration: 192.140641ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:51.846475Z","caller":"traceutil/trace.go:171","msg":"trace[21258804] linearizableReadLoop","detail":"{readStateIndex:25816; appliedIndex:25814; }","duration":"180.448684ms","start":"2026-06-02T07:43:51.665987Z","end":"2026-06-02T07:43:51.846435Z","steps":["trace[21258804] 'read index received' (duration: 92.771301ms)","trace[21258804] 'applied index is now lower than readState.Index' (duration: 87.675033ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:43:51.846706Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.853647ms","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:6"} {"level":"info","ts":"2026-06-02T07:43:51.846778Z","caller":"traceutil/trace.go:171","msg":"trace[144108068] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:25010; }","duration":"215.019291ms","start":"2026-06-02T07:43:51.631738Z","end":"2026-06-02T07:43:51.846758Z","steps":["trace[144108068] 'agreement among raft nodes before linearized reading' (duration: 214.851568ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:51.909092Z","caller":"traceutil/trace.go:171","msg":"trace[1085256377] transaction","detail":"{read_only:false; response_revision:25011; number_of_response:1; }","duration":"238.412374ms","start":"2026-06-02T07:43:51.670654Z","end":"2026-06-02T07:43:51.909067Z","steps":["trace[1085256377] 'process raft request' (duration: 238.20515ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:51.909206Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.343115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-06-02T07:43:51.909284Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.057579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:562"} {"level":"info","ts":"2026-06-02T07:43:51.909323Z","caller":"traceutil/trace.go:171","msg":"trace[605661226] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25011; }","duration":"182.471598ms","start":"2026-06-02T07:43:51.726796Z","end":"2026-06-02T07:43:51.909267Z","steps":["trace[605661226] 'agreement among raft nodes before linearized reading' (duration: 182.238883ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:51.909372Z","caller":"traceutil/trace.go:171","msg":"trace[1659751737] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:25011; }","duration":"172.203262ms","start":"2026-06-02T07:43:51.737146Z","end":"2026-06-02T07:43:51.90935Z","steps":["trace[1659751737] 'agreement among raft nodes before linearized reading' (duration: 171.942027ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:54.721853Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.927472ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:54.721936Z","caller":"traceutil/trace.go:171","msg":"trace[1013043721] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:25030; }","duration":"120.064156ms","start":"2026-06-02T07:43:54.601854Z","end":"2026-06-02T07:43:54.721918Z","steps":["trace[1013043721] 'count revisions from in-memory index tree' (duration: 119.835471ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:54.72218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"161.960037ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:54.72223Z","caller":"traceutil/trace.go:171","msg":"trace[1018265222] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:25030; }","duration":"162.045278ms","start":"2026-06-02T07:43:54.560173Z","end":"2026-06-02T07:43:54.722218Z","steps":["trace[1018265222] 'range keys from in-memory index tree' (duration: 161.903685ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:43:54.722425Z","caller":"traceutil/trace.go:171","msg":"trace[1866515006] transaction","detail":"{read_only:false; response_revision:25031; number_of_response:1; }","duration":"100.225268ms","start":"2026-06-02T07:43:54.622183Z","end":"2026-06-02T07:43:54.722408Z","steps":["trace[1866515006] 'process raft request' (duration: 26.60846ms)","trace[1866515006] 'compare' (duration: 73.133368ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:54.871457Z","caller":"traceutil/trace.go:171","msg":"trace[706636953] transaction","detail":"{read_only:false; response_revision:25032; number_of_response:1; }","duration":"102.114297ms","start":"2026-06-02T07:43:54.769312Z","end":"2026-06-02T07:43:54.871426Z","steps":["trace[706636953] 'process raft request' (duration: 101.893372ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:55.42948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.469019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:43:55.429614Z","caller":"traceutil/trace.go:171","msg":"trace[1200336975] linearizableReadLoop","detail":"{readStateIndex:25842; appliedIndex:25840; }","duration":"239.776532ms","start":"2026-06-02T07:43:55.189826Z","end":"2026-06-02T07:43:55.429603Z","steps":["trace[1200336975] 'read index received' (duration: 7.136399ms)","trace[1200336975] 'applied index is now lower than readState.Index' (duration: 232.639243ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:55.42977Z","caller":"traceutil/trace.go:171","msg":"trace[788096612] transaction","detail":"{read_only:false; response_revision:25034; number_of_response:1; }","duration":"260.713673ms","start":"2026-06-02T07:43:55.16904Z","end":"2026-06-02T07:43:55.429754Z","steps":["trace[788096612] 'process raft request' (duration: 27.908987ms)","trace[788096612] 'compare' (duration: 232.287756ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:43:55.429808Z","caller":"traceutil/trace.go:171","msg":"trace[1311773822] transaction","detail":"{read_only:false; response_revision:25035; number_of_response:1; }","duration":"249.992177ms","start":"2026-06-02T07:43:55.179808Z","end":"2026-06-02T07:43:55.4298Z","steps":["trace[1311773822] 'process raft request' (duration: 249.745952ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:43:55.429799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"239.944336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/\" range_end:\"/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:43:55.429858Z","caller":"traceutil/trace.go:171","msg":"trace[1834620237] range","detail":"{range_begin:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes/; range_end:/registry/controlplane.cluster.x-k8s.io/kubeadmcontrolplanes0; response_count:0; response_revision:25035; }","duration":"240.047658ms","start":"2026-06-02T07:43:55.189796Z","end":"2026-06-02T07:43:55.429844Z","steps":["trace[1834620237] 'agreement among raft nodes before linearized reading' (duration: 239.925346ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:44:00.134097Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"140.077796ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-02T07:44:00.134237Z","caller":"traceutil/trace.go:171","msg":"trace[981447896] transaction","detail":"{read_only:false; response_revision:25069; number_of_response:1; }","duration":"173.121392ms","start":"2026-06-02T07:43:59.961087Z","end":"2026-06-02T07:44:00.134208Z","steps":["trace[981447896] 'process raft request' (duration: 32.826281ms)","trace[981447896] 'compare' (duration: 139.855992ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:44:00.176766Z","caller":"traceutil/trace.go:171","msg":"trace[848000990] linearizableReadLoop","detail":"{readStateIndex:25878; appliedIndex:25876; }","duration":"212.189323ms","start":"2026-06-02T07:43:59.964562Z","end":"2026-06-02T07:44:00.176751Z","steps":["trace[848000990] 'read index received' (duration: 29.335408ms)","trace[848000990] 'applied index is now lower than readState.Index' (duration: 182.853195ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:44:00.176828Z","caller":"traceutil/trace.go:171","msg":"trace[1562899030] transaction","detail":"{read_only:false; response_revision:25070; number_of_response:1; }","duration":"215.663485ms","start":"2026-06-02T07:43:59.961143Z","end":"2026-06-02T07:44:00.176806Z","steps":["trace[1562899030] 'process raft request' (duration: 215.524362ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:44:00.176889Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.320786ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-06-02T07:44:00.176914Z","caller":"traceutil/trace.go:171","msg":"trace[1585614084] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:25070; }","duration":"212.385827ms","start":"2026-06-02T07:43:59.964521Z","end":"2026-06-02T07:44:00.176907Z","steps":["trace[1585614084] 'agreement among raft nodes before linearized reading' (duration: 212.281295ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:44:00.336103Z","caller":"traceutil/trace.go:171","msg":"trace[172686015] linearizableReadLoop","detail":"{readStateIndex:25879; appliedIndex:25878; }","duration":"119.863311ms","start":"2026-06-02T07:44:00.216225Z","end":"2026-06-02T07:44:00.336088Z","steps":["trace[172686015] 'read index received' (duration: 103.028258ms)","trace[172686015] 'applied index is now lower than readState.Index' (duration: 16.834543ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:44:00.33627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.031005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-02T07:44:00.336295Z","caller":"traceutil/trace.go:171","msg":"trace[1722385163] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:25071; }","duration":"120.082256ms","start":"2026-06-02T07:44:00.216204Z","end":"2026-06-02T07:44:00.336286Z","steps":["trace[1722385163] 'agreement among raft nodes before linearized reading' (duration: 119.942443ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:44:00.33636Z","caller":"traceutil/trace.go:171","msg":"trace[1239187921] transaction","detail":"{read_only:false; response_revision:25071; number_of_response:1; }","duration":"155.701665ms","start":"2026-06-02T07:44:00.180625Z","end":"2026-06-02T07:44:00.336327Z","steps":["trace[1239187921] 'process raft request' (duration: 138.620616ms)","trace[1239187921] 'compare' (duration: 16.587459ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:44:00.554343Z","caller":"traceutil/trace.go:171","msg":"trace[974905237] linearizableReadLoop","detail":"{readStateIndex:25880; appliedIndex:25879; }","duration":"210.271293ms","start":"2026-06-02T07:44:00.344047Z","end":"2026-06-02T07:44:00.554318Z","steps":["trace[974905237] 'read index received' (duration: 131.783442ms)","trace[974905237] 'applied index is now lower than readState.Index' (duration: 78.486901ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:44:00.554354Z","caller":"traceutil/trace.go:171","msg":"trace[2087403997] transaction","detail":"{read_only:false; response_revision:25072; number_of_response:1; }","duration":"214.301938ms","start":"2026-06-02T07:44:00.340014Z","end":"2026-06-02T07:44:00.554316Z","steps":["trace[2087403997] 'process raft request' (duration: 135.842187ms)","trace[2087403997] 'compare' (duration: 78.266527ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:44:00.554601Z","caller":"traceutil/trace.go:171","msg":"trace[1212419547] transaction","detail":"{read_only:false; response_revision:25073; number_of_response:1; }","duration":"181.661161ms","start":"2026-06-02T07:44:00.372906Z","end":"2026-06-02T07:44:00.554568Z","steps":["trace[1212419547] 'process raft request' (duration: 181.371855ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:44:00.554722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.021349ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-759cb9c84c-wgl4g.18b532064ef1e0b8\" ","response":"range_response_count:1 size:1137"} {"level":"info","ts":"2026-06-02T07:44:00.554793Z","caller":"traceutil/trace.go:171","msg":"trace[1979453256] range","detail":"{range_begin:/registry/events/openstack/barbican-api-759cb9c84c-wgl4g.18b532064ef1e0b8; range_end:; response_count:1; response_revision:25073; }","duration":"182.174692ms","start":"2026-06-02T07:44:00.372597Z","end":"2026-06-02T07:44:00.554771Z","steps":["trace[1979453256] 'agreement among raft nodes before linearized reading' (duration: 181.926297ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:44:00.554832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.766413ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/glance-api\" ","response":"range_response_count:1 size:11837"} {"level":"info","ts":"2026-06-02T07:44:00.554872Z","caller":"traceutil/trace.go:171","msg":"trace[333949007] range","detail":"{range_begin:/registry/deployments/openstack/glance-api; range_end:; response_count:1; response_revision:25073; }","duration":"210.824734ms","start":"2026-06-02T07:44:00.344035Z","end":"2026-06-02T07:44:00.55486Z","steps":["trace[333949007] 'agreement among raft nodes before linearized reading' (duration: 210.355834ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:44:00.667224Z","caller":"traceutil/trace.go:171","msg":"trace[558318568] transaction","detail":"{read_only:false; response_revision:25075; number_of_response:1; }","duration":"108.338049ms","start":"2026-06-02T07:44:00.558863Z","end":"2026-06-02T07:44:00.667201Z","steps":["trace[558318568] 'process raft request' (duration: 106.959351ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:44:01.549018Z","caller":"traceutil/trace.go:171","msg":"trace[1991464125] transaction","detail":"{read_only:false; response_revision:25079; number_of_response:1; }","duration":"100.340111ms","start":"2026-06-02T07:44:01.448656Z","end":"2026-06-02T07:44:01.548996Z","steps":["trace[1991464125] 'process raft request' (duration: 99.221337ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:44:01.551311Z","caller":"traceutil/trace.go:171","msg":"trace[26540343] transaction","detail":"{read_only:false; response_revision:25080; number_of_response:1; }","duration":"101.383213ms","start":"2026-06-02T07:44:01.449912Z","end":"2026-06-02T07:44:01.551295Z","steps":["trace[26540343] 'process raft request' (duration: 101.088067ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:44:03.949617Z","caller":"traceutil/trace.go:171","msg":"trace[59933070] transaction","detail":"{read_only:false; response_revision:25098; number_of_response:1; }","duration":"145.174343ms","start":"2026-06-02T07:44:03.804411Z","end":"2026-06-02T07:44:03.949585Z","steps":["trace[59933070] 'process raft request' (duration: 139.118776ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:45:44.304633Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":23258} {"level":"info","ts":"2026-06-02T07:45:44.438566Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":23258,"took":"130.253479ms","hash":168812636,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":36130816,"current-db-size-in-use":"36 MB"} {"level":"info","ts":"2026-06-02T07:45:44.43866Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":168812636,"revision":23258,"compact-revision":20074} {"level":"info","ts":"2026-06-02T07:46:15.127712Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006a76.wal"} {"level":"info","ts":"2026-06-02T07:47:19.884277Z","caller":"traceutil/trace.go:171","msg":"trace[1569620664] linearizableReadLoop","detail":"{readStateIndex:27948; appliedIndex:27947; }","duration":"140.27099ms","start":"2026-06-02T07:47:19.743982Z","end":"2026-06-02T07:47:19.884253Z","steps":["trace[1569620664] 'read index received' (duration: 109.147296ms)","trace[1569620664] 'applied index is now lower than readState.Index' (duration: 31.122684ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:47:19.884407Z","caller":"traceutil/trace.go:171","msg":"trace[322825058] transaction","detail":"{read_only:false; response_revision:27091; number_of_response:1; }","duration":"149.167947ms","start":"2026-06-02T07:47:19.735223Z","end":"2026-06-02T07:47:19.88439Z","steps":["trace[322825058] 'process raft request' (duration: 117.946241ms)","trace[322825058] 'compare' (duration: 30.9209ms)"],"step_count":2} {"level":"warn","ts":"2026-06-02T07:47:19.884506Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.792406ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-06-02T07:47:19.88455Z","caller":"traceutil/trace.go:171","msg":"trace[1879944022] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:27091; }","duration":"107.891618ms","start":"2026-06-02T07:47:19.776649Z","end":"2026-06-02T07:47:19.88454Z","steps":["trace[1879944022] 'agreement among raft nodes before linearized reading' (duration: 107.752105ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:47:19.884559Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"157.618295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:47:19.884644Z","caller":"traceutil/trace.go:171","msg":"trace[2087376890] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:27091; }","duration":"157.750777ms","start":"2026-06-02T07:47:19.726873Z","end":"2026-06-02T07:47:19.884624Z","steps":["trace[2087376890] 'agreement among raft nodes before linearized reading' (duration: 157.580913ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:47:24.008957Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.853737ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-02T07:47:24.009022Z","caller":"traceutil/trace.go:171","msg":"trace[166939134] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:27124; }","duration":"124.989259ms","start":"2026-06-02T07:47:23.884017Z","end":"2026-06-02T07:47:24.009007Z","steps":["trace[166939134] 'count revisions from in-memory index tree' (duration: 124.755904ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:47:24.00919Z","caller":"traceutil/trace.go:171","msg":"trace[954218348] transaction","detail":"{read_only:false; response_revision:27125; number_of_response:1; }","duration":"113.459587ms","start":"2026-06-02T07:47:23.895677Z","end":"2026-06-02T07:47:24.009137Z","steps":["trace[954218348] 'process raft request' (duration: 96.658764ms)","trace[954218348] 'compare' (duration: 16.619179ms)"],"step_count":2} {"level":"info","ts":"2026-06-02T07:47:24.056476Z","caller":"traceutil/trace.go:171","msg":"trace[256874443] transaction","detail":"{read_only:false; response_revision:27126; number_of_response:1; }","duration":"118.059174ms","start":"2026-06-02T07:47:23.938397Z","end":"2026-06-02T07:47:24.056456Z","steps":["trace[256874443] 'process raft request' (duration: 117.945422ms)"],"step_count":1} {"level":"warn","ts":"2026-06-02T07:47:24.056675Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.02029ms","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-06-02T07:47:24.056728Z","caller":"traceutil/trace.go:171","msg":"trace[1238336481] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:27126; }","duration":"105.079351ms","start":"2026-06-02T07:47:23.951636Z","end":"2026-06-02T07:47:24.056715Z","steps":["trace[1238336481] 'agreement among raft nodes before linearized reading' (duration: 104.860636ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:47:24.240764Z","caller":"traceutil/trace.go:171","msg":"trace[1466273913] transaction","detail":"{read_only:false; response_revision:27128; number_of_response:1; }","duration":"110.607326ms","start":"2026-06-02T07:47:24.13013Z","end":"2026-06-02T07:47:24.240737Z","steps":["trace[1466273913] 'process raft request' (duration: 110.373812ms)"],"step_count":1} {"level":"info","ts":"2026-06-02T07:50:44.311458Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":26133} {"level":"info","ts":"2026-06-02T07:50:44.45732Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":26133,"took":"142.485911ms","hash":3211114883,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":33603584,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-02T07:50:44.457442Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3211114883,"revision":26133,"compact-revision":23258} {"level":"info","ts":"2026-06-02T07:51:29.669473Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":30003,"local-member-snapshot-index":20002,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T07:51:29.676658Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":30003} {"level":"info","ts":"2026-06-02T07:51:29.676821Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":25003} {"level":"info","ts":"2026-06-02T07:55:44.31692Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":28751} {"level":"info","ts":"2026-06-02T07:55:44.452184Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":28751,"took":"132.126756ms","hash":1963643180,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":30089216,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-02T07:55:44.452282Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1963643180,"revision":28751,"compact-revision":26133} {"level":"info","ts":"2026-06-02T08:00:44.322735Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":30974} {"level":"info","ts":"2026-06-02T08:00:44.454383Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":30974,"took":"128.077146ms","hash":2935118686,"current-db-size-bytes":58060800,"current-db-size":"58 MB","current-db-size-in-use-bytes":32006144,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-02T08:00:44.454447Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2935118686,"revision":30974,"compact-revision":28751} {"level":"info","ts":"2026-06-02T08:05:44.328271Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":33310} {"level":"info","ts":"2026-06-02T08:05:44.484071Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":33310,"took":"151.685172ms","hash":3928319715,"current-db-size-bytes":59105280,"current-db-size":"59 MB","current-db-size-in-use-bytes":32960512,"current-db-size-in-use":"33 MB"} {"level":"info","ts":"2026-06-02T08:05:44.484126Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3928319715,"revision":33310,"compact-revision":30974} {"level":"info","ts":"2026-06-02T08:10:44.336128Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":35639} {"level":"info","ts":"2026-06-02T08:10:44.484459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":35639,"took":"142.846452ms","hash":2544417879,"current-db-size-bytes":59105280,"current-db-size":"59 MB","current-db-size-in-use-bytes":31948800,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-02T08:10:44.484525Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2544417879,"revision":35639,"compact-revision":33310} {"level":"info","ts":"2026-06-02T08:12:44.456085Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"331455d6226d3423","local-member-applied-index":40004,"local-member-snapshot-index":30003,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-02T08:12:44.461687Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":40004} {"level":"info","ts":"2026-06-02T08:12:44.461812Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":35004} {"level":"info","ts":"2026-06-02T08:15:44.344601Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":37872} {"level":"info","ts":"2026-06-02T08:15:44.460516Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":37872,"took":"112.654585ms","hash":1669653342,"current-db-size-bytes":59105280,"current-db-size":"59 MB","current-db-size-in-use-bytes":30859264,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-06-02T08:15:44.460599Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1669653342,"revision":37872,"compact-revision":35639}