{"level":"warn","ts":"2026-07-30T21:03:49.594618Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T21:03:49.594747Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.121:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.121:2380","--initial-cluster=instance=https://199.19.213.121:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.121:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.121: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-07-30T21:03:49.594835Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-30T21:03:49.594849Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-07-30T21:03:49.594874Z","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-07-30T21:03:49.595696Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"]} {"level":"info","ts":"2026-07-30T21:03:49.595907Z","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":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.121: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-07-30T21:03:49.6013Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.899749ms"} {"level":"info","ts":"2026-07-30T21:03:49.611694Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"31541ae44470b70","cluster-id":"8ae2d89c48d1447d"} {"level":"info","ts":"2026-07-30T21:03:49.611794Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=()"} {"level":"info","ts":"2026-07-30T21:03:49.611818Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 0"} {"level":"info","ts":"2026-07-30T21:03:49.611832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 31541ae44470b70 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-30T21:03:49.61184Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became follower at term 1"} {"level":"info","ts":"2026-07-30T21:03:49.611885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"warn","ts":"2026-07-30T21:03:49.618039Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-30T21:03:49.626527Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-30T21:03:49.631884Z","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-07-30T21:03:49.634471Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"31541ae44470b70","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-30T21:03:49.635046Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"31541ae44470b70","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-30T21:03:49.635209Z","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-07-30T21:03:49.635359Z","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-07-30T21:03:49.635517Z","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-07-30T21:03:49.637349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 switched to configuration voters=(222155973350329200)"} {"level":"info","ts":"2026-07-30T21:03:49.638054Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","added-peer-id":"31541ae44470b70","added-peer-peer-urls":["https://199.19.213.121:2380"]} {"level":"info","ts":"2026-07-30T21:03:49.639607Z","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-07-30T21:03:49.639758Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-07-30T21:03:49.63994Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.121:2380"} {"level":"info","ts":"2026-07-30T21:03:49.640752Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"31541ae44470b70","initial-advertise-peer-urls":["https://199.19.213.121:2380"],"listen-peer-urls":["https://199.19.213.121:2380"],"advertise-client-urls":["https://199.19.213.121:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.121:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-30T21:03:49.640808Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-30T21:03:49.913104Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 is starting a new election at term 1"} {"level":"info","ts":"2026-07-30T21:03:49.913189Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-30T21:03:49.913242Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgPreVoteResp from 31541ae44470b70 at term 1"} {"level":"info","ts":"2026-07-30T21:03:49.913274Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became candidate at term 2"} {"level":"info","ts":"2026-07-30T21:03:49.913291Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 received MsgVoteResp from 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-07-30T21:03:49.913318Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"31541ae44470b70 became leader at term 2"} {"level":"info","ts":"2026-07-30T21:03:49.91334Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 31541ae44470b70 elected leader 31541ae44470b70 at term 2"} {"level":"info","ts":"2026-07-30T21:03:49.914186Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:03:49.914943Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"31541ae44470b70","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.121:2379]}","request-path":"/0/members/31541ae44470b70/attributes","cluster-id":"8ae2d89c48d1447d","publish-timeout":"7s"} {"level":"info","ts":"2026-07-30T21:03:49.914996Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T21:03:49.915345Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"8ae2d89c48d1447d","local-member-id":"31541ae44470b70","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:03:49.915456Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:03:49.915488Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-30T21:03:49.915939Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-30T21:03:49.91642Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-30T21:03:49.916494Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-30T21:03:49.918938Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-30T21:03:49.921342Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.121:2379"} {"level":"info","ts":"2026-07-30T21:04:30.850614Z","caller":"traceutil/trace.go:171","msg":"trace[489206215] linearizableReadLoop","detail":"{readStateIndex:603; appliedIndex:602; }","duration":"185.685049ms","start":"2026-07-30T21:04:30.664902Z","end":"2026-07-30T21:04:30.850587Z","steps":["trace[489206215] 'read index received' (duration: 184.69722ms)","trace[489206215] 'applied index is now lower than readState.Index' (duration: 986.649µs)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:04:30.850767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"185.847642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:04:30.850828Z","caller":"traceutil/trace.go:171","msg":"trace[905949962] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:580; }","duration":"185.979985ms","start":"2026-07-30T21:04:30.664836Z","end":"2026-07-30T21:04:30.850816Z","steps":["trace[905949962] 'agreement among raft nodes before linearized reading' (duration: 185.874823ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:04:30.851117Z","caller":"traceutil/trace.go:171","msg":"trace[1078163673] transaction","detail":"{read_only:false; response_revision:580; number_of_response:1; }","duration":"232.842579ms","start":"2026-07-30T21:04:30.618263Z","end":"2026-07-30T21:04:30.851106Z","steps":["trace[1078163673] 'process raft request' (duration: 231.648715ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:04:32.115814Z","caller":"traceutil/trace.go:171","msg":"trace[1010833435] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"180.004447ms","start":"2026-07-30T21:04:31.935781Z","end":"2026-07-30T21:04:32.115785Z","steps":["trace[1010833435] 'process raft request' (duration: 158.387938ms)","trace[1010833435] 'compare' (duration: 21.490176ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:04:32.122979Z","caller":"traceutil/trace.go:171","msg":"trace[193313318] transaction","detail":"{read_only:false; response_revision:590; number_of_response:1; }","duration":"183.998791ms","start":"2026-07-30T21:04:31.93895Z","end":"2026-07-30T21:04:32.122949Z","steps":["trace[193313318] 'process raft request' (duration: 183.823878ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:04:32.12307Z","caller":"traceutil/trace.go:171","msg":"trace[1683169103] transaction","detail":"{read_only:false; response_revision:591; number_of_response:1; }","duration":"171.17988ms","start":"2026-07-30T21:04:31.951875Z","end":"2026-07-30T21:04:32.123055Z","steps":["trace[1683169103] 'process raft request' (duration: 171.003606ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:32.123483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.751259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-30T21:04:32.122944Z","caller":"traceutil/trace.go:171","msg":"trace[603805398] linearizableReadLoop","detail":"{readStateIndex:614; appliedIndex:611; }","duration":"138.209287ms","start":"2026-07-30T21:04:31.984712Z","end":"2026-07-30T21:04:32.122921Z","steps":["trace[603805398] 'read index received' (duration: 109.541912ms)","trace[603805398] 'applied index is now lower than readState.Index' (duration: 28.666405ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:04:32.123539Z","caller":"traceutil/trace.go:171","msg":"trace[1501056063] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:591; }","duration":"138.840472ms","start":"2026-07-30T21:04:31.984683Z","end":"2026-07-30T21:04:32.123524Z","steps":["trace[1501056063] 'agreement among raft nodes before linearized reading' (duration: 138.653997ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:32.123701Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.834265ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-sbrw5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-30T21:04:32.123747Z","caller":"traceutil/trace.go:171","msg":"trace[1820133927] range","detail":"{range_begin:/registry/pods/kube-system/cilium-sbrw5; range_end:; response_count:1; response_revision:591; }","duration":"107.930647ms","start":"2026-07-30T21:04:32.015803Z","end":"2026-07-30T21:04:32.123734Z","steps":["trace[1820133927] 'agreement among raft nodes before linearized reading' (duration: 107.786074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:33.164725Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":824334330862072134,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-30T21:04:33.283547Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.128116162s","expected-duration":"1s"} {"level":"warn","ts":"2026-07-30T21:04:33.528375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:04:32.938443Z","time spent":"589.927735ms","remote":"127.0.0.1:43688","response type":"/etcdserverpb.Maintenance/Status","request count":-1,"request size":-1,"response count":-1,"response size":-1,"request content":""} {"level":"warn","ts":"2026-07-30T21:04:33.528311Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.058006151s","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:04:33.528542Z","caller":"traceutil/trace.go:171","msg":"trace[2027567731] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:592; }","duration":"1.058240435s","start":"2026-07-30T21:04:32.470275Z","end":"2026-07-30T21:04:33.528516Z","steps":["trace[2027567731] 'range keys from in-memory index tree' (duration: 1.05799033s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:33.529415Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.763784ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:04:33.529527Z","caller":"traceutil/trace.go:171","msg":"trace[77643396] transaction","detail":"{read_only:false; response_revision:593; number_of_response:1; }","duration":"1.390671676s","start":"2026-07-30T21:04:32.138836Z","end":"2026-07-30T21:04:33.529507Z","steps":["trace[77643396] 'process raft request' (duration: 1.145141756s)","trace[77643396] 'compare' (duration: 244.254863ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:04:33.529596Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:04:32.138821Z","time spent":"1.390743959s","remote":"127.0.0.1:53864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:04:33.556067Z","caller":"traceutil/trace.go:171","msg":"trace[1677396806] linearizableReadLoop","detail":"{readStateIndex:618; appliedIndex:615; }","duration":"892.375633ms","start":"2026-07-30T21:04:32.663672Z","end":"2026-07-30T21:04:33.556048Z","steps":["trace[1677396806] 'read index received' (duration: 620.257267ms)","trace[1677396806] 'applied index is now lower than readState.Index' (duration: 272.117406ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:04:33.556213Z","caller":"traceutil/trace.go:171","msg":"trace[1266627491] transaction","detail":"{read_only:false; response_revision:595; number_of_response:1; }","duration":"780.885701ms","start":"2026-07-30T21:04:32.775302Z","end":"2026-07-30T21:04:33.556188Z","steps":["trace[1266627491] 'process raft request' (duration: 780.691388ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:33.556304Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"687.883036ms","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-07-30T21:04:33.556347Z","caller":"traceutil/trace.go:171","msg":"trace[1390954985] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:595; }","duration":"687.964037ms","start":"2026-07-30T21:04:32.868371Z","end":"2026-07-30T21:04:33.556335Z","steps":["trace[1390954985] 'agreement among raft nodes before linearized reading' (duration: 687.793993ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:33.556338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"252.110589ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.121\" ","response":"range_response_count:1 size:135"} {"level":"warn","ts":"2026-07-30T21:04:33.556375Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:04:32.775277Z","time spent":"781.014115ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:04:33.55636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"892.663069ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T21:04:33.556393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:04:32.868338Z","time spent":"688.046579ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-07-30T21:04:33.556403Z","caller":"traceutil/trace.go:171","msg":"trace[1591471995] range","detail":"{range_begin:/registry/masterleases/199.19.213.121; range_end:; response_count:1; response_revision:595; }","duration":"252.221632ms","start":"2026-07-30T21:04:33.304165Z","end":"2026-07-30T21:04:33.556387Z","steps":["trace[1591471995] 'agreement among raft nodes before linearized reading' (duration: 252.065218ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:04:33.556488Z","caller":"traceutil/trace.go:171","msg":"trace[1215146856] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:595; }","duration":"892.788792ms","start":"2026-07-30T21:04:32.663629Z","end":"2026-07-30T21:04:33.556417Z","steps":["trace[1215146856] 'agreement among raft nodes before linearized reading' (duration: 892.535336ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:33.556576Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:04:32.663617Z","time spent":"892.949095ms","remote":"127.0.0.1:53680","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-07-30T21:04:33.556147Z","caller":"traceutil/trace.go:171","msg":"trace[1974981121] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"1.026276061s","start":"2026-07-30T21:04:32.529845Z","end":"2026-07-30T21:04:33.556121Z","steps":["trace[1974981121] 'process raft request' (duration: 1.025585936s)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:04:33.557044Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:04:32.529822Z","time spent":"1.027121069s","remote":"127.0.0.1:53778","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036293,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:05:19.316605Z","caller":"traceutil/trace.go:171","msg":"trace[335290704] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"205.334477ms","start":"2026-07-30T21:05:19.111241Z","end":"2026-07-30T21:05:19.316576Z","steps":["trace[335290704] 'process raft request' (duration: 205.1008ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:13.757501Z","caller":"traceutil/trace.go:171","msg":"trace[1715886949] transaction","detail":"{read_only:false; response_revision:1918; number_of_response:1; }","duration":"136.616905ms","start":"2026-07-30T21:06:13.620856Z","end":"2026-07-30T21:06:13.757473Z","steps":["trace[1715886949] 'process raft request' (duration: 136.441578ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:19.336464Z","caller":"traceutil/trace.go:171","msg":"trace[793022159] transaction","detail":"{read_only:false; response_revision:1951; number_of_response:1; }","duration":"259.289992ms","start":"2026-07-30T21:06:19.07713Z","end":"2026-07-30T21:06:19.33642Z","steps":["trace[793022159] 'process raft request' (duration: 259.140435ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:19.338688Z","caller":"traceutil/trace.go:171","msg":"trace[2019802827] transaction","detail":"{read_only:false; response_revision:1952; number_of_response:1; }","duration":"213.343262ms","start":"2026-07-30T21:06:19.125326Z","end":"2026-07-30T21:06:19.338669Z","steps":["trace[2019802827] 'process raft request' (duration: 212.84937ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:06:36.056221Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"221.162764ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-30T21:06:36.056397Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.053242ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-30T21:06:36.056482Z","caller":"traceutil/trace.go:171","msg":"trace[1006697959] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2059; }","duration":"221.425896ms","start":"2026-07-30T21:06:35.835012Z","end":"2026-07-30T21:06:36.056437Z","steps":["trace[1006697959] 'count revisions from in-memory index tree' (duration: 221.055519ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:36.056805Z","caller":"traceutil/trace.go:171","msg":"trace[816802655] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2059; }","duration":"183.511023ms","start":"2026-07-30T21:06:35.873274Z","end":"2026-07-30T21:06:36.056785Z","steps":["trace[816802655] 'range keys from in-memory index tree' (duration: 182.805682ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:36.06392Z","caller":"traceutil/trace.go:171","msg":"trace[1052138696] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"133.824904ms","start":"2026-07-30T21:06:35.930074Z","end":"2026-07-30T21:06:36.063899Z","steps":["trace[1052138696] 'process raft request' (duration: 133.684057ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:36.682998Z","caller":"traceutil/trace.go:171","msg":"trace[976077200] linearizableReadLoop","detail":"{readStateIndex:2140; appliedIndex:2139; }","duration":"164.540869ms","start":"2026-07-30T21:06:36.518433Z","end":"2026-07-30T21:06:36.682973Z","steps":["trace[976077200] 'read index received' (duration: 164.34197ms)","trace[976077200] 'applied index is now lower than readState.Index' (duration: 197.919µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:06:36.683083Z","caller":"traceutil/trace.go:171","msg":"trace[1517669571] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"350.408787ms","start":"2026-07-30T21:06:36.332643Z","end":"2026-07-30T21:06:36.683052Z","steps":["trace[1517669571] 'process raft request' (duration: 350.189786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:06:36.68323Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:06:36.332617Z","time spent":"350.527681ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:06:36.683283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.843081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-07-30T21:06:36.683361Z","caller":"traceutil/trace.go:171","msg":"trace[2006936679] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2062; }","duration":"164.927685ms","start":"2026-07-30T21:06:36.518412Z","end":"2026-07-30T21:06:36.68334Z","steps":["trace[2006936679] 'agreement among raft nodes before linearized reading' (duration: 164.661743ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:06:36.840499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"155.935081ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:06:36.840557Z","caller":"traceutil/trace.go:171","msg":"trace[1332820532] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2062; }","duration":"156.036017ms","start":"2026-07-30T21:06:36.684509Z","end":"2026-07-30T21:06:36.840545Z","steps":["trace[1332820532] 'range keys from in-memory index tree' (duration: 155.883899ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:37.005603Z","caller":"traceutil/trace.go:171","msg":"trace[1778399991] linearizableReadLoop","detail":"{readStateIndex:2141; appliedIndex:2140; }","duration":"103.942893ms","start":"2026-07-30T21:06:36.901641Z","end":"2026-07-30T21:06:37.005584Z","steps":["trace[1778399991] 'read index received' (duration: 103.794596ms)","trace[1778399991] 'applied index is now lower than readState.Index' (duration: 147.797µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:06:37.005793Z","caller":"traceutil/trace.go:171","msg":"trace[1751392713] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"127.021632ms","start":"2026-07-30T21:06:36.878766Z","end":"2026-07-30T21:06:37.005787Z","steps":["trace[1751392713] 'process raft request' (duration: 126.717247ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:06:37.005971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.31447ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-30T21:06:37.005994Z","caller":"traceutil/trace.go:171","msg":"trace[2131948371] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2063; }","duration":"104.372173ms","start":"2026-07-30T21:06:36.901616Z","end":"2026-07-30T21:06:37.005988Z","steps":["trace[2131948371] 'agreement among raft nodes before linearized reading' (duration: 104.285389ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:37.243205Z","caller":"traceutil/trace.go:171","msg":"trace[1542059749] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"232.360433ms","start":"2026-07-30T21:06:37.01082Z","end":"2026-07-30T21:06:37.243181Z","steps":["trace[1542059749] 'process raft request' (duration: 210.157023ms)","trace[1542059749] 'compare' (duration: 21.76483ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:06:37.243548Z","caller":"traceutil/trace.go:171","msg":"trace[495983865] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"231.988826ms","start":"2026-07-30T21:06:37.011522Z","end":"2026-07-30T21:06:37.24351Z","steps":["trace[495983865] 'process raft request' (duration: 231.613589ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:06:37.244207Z","caller":"traceutil/trace.go:171","msg":"trace[1285832944] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"231.972256ms","start":"2026-07-30T21:06:37.012206Z","end":"2026-07-30T21:06:37.244178Z","steps":["trace[1285832944] 'process raft request' (duration: 231.203621ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:47.74646Z","caller":"traceutil/trace.go:171","msg":"trace[510390809] transaction","detail":"{read_only:false; response_revision:2545; number_of_response:1; }","duration":"126.501817ms","start":"2026-07-30T21:07:47.61994Z","end":"2026-07-30T21:07:47.746441Z","steps":["trace[510390809] 'process raft request' (duration: 126.392783ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:47.747426Z","caller":"traceutil/trace.go:171","msg":"trace[168752826] transaction","detail":"{read_only:false; response_revision:2547; number_of_response:1; }","duration":"124.864829ms","start":"2026-07-30T21:07:47.622442Z","end":"2026-07-30T21:07:47.747306Z","steps":["trace[168752826] 'process raft request' (duration: 124.832867ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:07:47.747717Z","caller":"traceutil/trace.go:171","msg":"trace[661049974] transaction","detail":"{read_only:false; response_revision:2546; number_of_response:1; }","duration":"127.639552ms","start":"2026-07-30T21:07:47.620069Z","end":"2026-07-30T21:07:47.747709Z","steps":["trace[661049974] 'process raft request' (duration: 127.113327ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:08:20.75044Z","caller":"traceutil/trace.go:171","msg":"trace[1102784730] transaction","detail":"{read_only:false; response_revision:2728; number_of_response:1; }","duration":"137.70279ms","start":"2026-07-30T21:08:20.61266Z","end":"2026-07-30T21:08:20.750363Z","steps":["trace[1102784730] 'process raft request' (duration: 137.473719ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:08:21.310271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.756049ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:08:21.310336Z","caller":"traceutil/trace.go:171","msg":"trace[781646440] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2729; }","duration":"393.899911ms","start":"2026-07-30T21:08:20.91642Z","end":"2026-07-30T21:08:21.31032Z","steps":["trace[781646440] 'count revisions from in-memory index tree' (duration: 393.67429ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:08:21.310404Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:08:20.916397Z","time spent":"393.997162ms","remote":"127.0.0.1:49280","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-30T21:08:21.310758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.332915ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-07-30T21:08:21.3108Z","caller":"traceutil/trace.go:171","msg":"trace[1547578903] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:2729; }","duration":"116.381405ms","start":"2026-07-30T21:08:21.19441Z","end":"2026-07-30T21:08:21.310792Z","steps":["trace[1547578903] 'count revisions from in-memory index tree' (duration: 116.257346ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:08:21.31108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"326.671231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:08:21.31112Z","caller":"traceutil/trace.go:171","msg":"trace[1067133384] range","detail":"{range_begin:/registry/volumeattachments/; range_end:/registry/volumeattachments0; response_count:0; response_revision:2729; }","duration":"326.707321ms","start":"2026-07-30T21:08:20.9844Z","end":"2026-07-30T21:08:21.311107Z","steps":["trace[1067133384] 'count revisions from in-memory index tree' (duration: 326.537691ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:08:21.311151Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:08:20.984328Z","time spent":"326.813981ms","remote":"127.0.0.1:54098","response type":"/etcdserverpb.KV/Range","request count":0,"request size":62,"response count":0,"response size":28,"request content":"key:\"/registry/volumeattachments/\" range_end:\"/registry/volumeattachments0\" count_only:true "} {"level":"warn","ts":"2026-07-30T21:08:21.311469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.100575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T21:08:21.311516Z","caller":"traceutil/trace.go:171","msg":"trace[244658095] range","detail":"{range_begin:/registry/apiregistration.k8s.io/apiservices/; range_end:/registry/apiregistration.k8s.io/apiservices0; response_count:0; response_revision:2729; }","duration":"311.171816ms","start":"2026-07-30T21:08:21.000332Z","end":"2026-07-30T21:08:21.311503Z","steps":["trace[244658095] 'count revisions from in-memory index tree' (duration: 310.980056ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:08:21.311554Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:08:21.000321Z","time spent":"311.221466ms","remote":"127.0.0.1:54250","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":36,"response size":30,"request content":"key:\"/registry/apiregistration.k8s.io/apiservices/\" range_end:\"/registry/apiregistration.k8s.io/apiservices0\" count_only:true "} {"level":"info","ts":"2026-07-30T21:12:02.145033Z","caller":"traceutil/trace.go:171","msg":"trace[328786572] transaction","detail":"{read_only:false; response_revision:4432; number_of_response:1; }","duration":"112.845091ms","start":"2026-07-30T21:12:02.032132Z","end":"2026-07-30T21:12:02.144977Z","steps":["trace[328786572] 'process raft request' (duration: 112.417846ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:05.797683Z","caller":"traceutil/trace.go:171","msg":"trace[116177005] linearizableReadLoop","detail":"{readStateIndex:4730; appliedIndex:4729; }","duration":"134.318768ms","start":"2026-07-30T21:12:05.663338Z","end":"2026-07-30T21:12:05.797657Z","steps":["trace[116177005] 'read index received' (duration: 133.061111ms)","trace[116177005] 'applied index is now lower than readState.Index' (duration: 1.256637ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:05.79782Z","caller":"traceutil/trace.go:171","msg":"trace[220768802] transaction","detail":"{read_only:false; response_revision:4558; number_of_response:1; }","duration":"229.85206ms","start":"2026-07-30T21:12:05.567955Z","end":"2026-07-30T21:12:05.797807Z","steps":["trace[220768802] 'process raft request' (duration: 228.651016ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:05.798081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"134.738704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:12:05.798123Z","caller":"traceutil/trace.go:171","msg":"trace[939218711] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4558; }","duration":"134.829357ms","start":"2026-07-30T21:12:05.663281Z","end":"2026-07-30T21:12:05.798111Z","steps":["trace[939218711] 'agreement among raft nodes before linearized reading' (duration: 134.750074ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:08.866263Z","caller":"traceutil/trace.go:171","msg":"trace[1990364722] linearizableReadLoop","detail":"{readStateIndex:4812; appliedIndex:4811; }","duration":"118.318597ms","start":"2026-07-30T21:12:08.747915Z","end":"2026-07-30T21:12:08.866234Z","steps":["trace[1990364722] 'read index received' (duration: 75.161795ms)","trace[1990364722] 'applied index is now lower than readState.Index' (duration: 43.155092ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:08.866494Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.547215ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-07-30T21:12:08.866538Z","caller":"traceutil/trace.go:171","msg":"trace[620102433] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4637; }","duration":"118.64907ms","start":"2026-07-30T21:12:08.747876Z","end":"2026-07-30T21:12:08.866525Z","steps":["trace[620102433] 'agreement among raft nodes before linearized reading' (duration: 118.456513ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:09.076939Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.155581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-07-30T21:12:09.077006Z","caller":"traceutil/trace.go:171","msg":"trace[1300065062] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4642; }","duration":"139.243324ms","start":"2026-07-30T21:12:08.937748Z","end":"2026-07-30T21:12:09.076991Z","steps":["trace[1300065062] 'range keys from in-memory index tree' (duration: 139.053387ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:09.077147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.203153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60268"} {"level":"info","ts":"2026-07-30T21:12:09.077225Z","caller":"traceutil/trace.go:171","msg":"trace[1402703788] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4642; }","duration":"139.327337ms","start":"2026-07-30T21:12:08.93788Z","end":"2026-07-30T21:12:09.077208Z","steps":["trace[1402703788] 'range keys from in-memory index tree' (duration: 139.037886ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:10.109264Z","caller":"traceutil/trace.go:171","msg":"trace[95951494] transaction","detail":"{read_only:false; response_revision:4649; number_of_response:1; }","duration":"109.446592ms","start":"2026-07-30T21:12:09.999792Z","end":"2026-07-30T21:12:10.109239Z","steps":["trace[95951494] 'process raft request' (duration: 109.277955ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:14.265679Z","caller":"traceutil/trace.go:171","msg":"trace[181965142] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"100.126646ms","start":"2026-07-30T21:12:14.165524Z","end":"2026-07-30T21:12:14.265651Z","steps":["trace[181965142] 'process raft request' (duration: 99.97969ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:15.184973Z","caller":"traceutil/trace.go:171","msg":"trace[992292961] transaction","detail":"{read_only:false; response_revision:4748; number_of_response:1; }","duration":"268.487567ms","start":"2026-07-30T21:12:14.916404Z","end":"2026-07-30T21:12:15.184892Z","steps":["trace[992292961] 'process raft request' (duration: 268.430245ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:15.185304Z","caller":"traceutil/trace.go:171","msg":"trace[1538477725] transaction","detail":"{read_only:false; response_revision:4747; number_of_response:1; }","duration":"270.805553ms","start":"2026-07-30T21:12:14.914452Z","end":"2026-07-30T21:12:15.185258Z","steps":["trace[1538477725] 'process raft request' (duration: 270.214341ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:15.1858Z","caller":"traceutil/trace.go:171","msg":"trace[1004482235] linearizableReadLoop","detail":"{readStateIndex:4924; appliedIndex:4924; }","duration":"259.755833ms","start":"2026-07-30T21:12:14.926007Z","end":"2026-07-30T21:12:15.185763Z","steps":["trace[1004482235] 'read index received' (duration: 259.742842ms)","trace[1004482235] 'applied index is now lower than readState.Index' (duration: 9.721µs)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:15.186131Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.088585ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-07-30T21:12:15.186171Z","caller":"traceutil/trace.go:171","msg":"trace[926367557] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4748; }","duration":"260.163388ms","start":"2026-07-30T21:12:14.925992Z","end":"2026-07-30T21:12:15.186156Z","steps":["trace[926367557] 'agreement among raft nodes before linearized reading' (duration: 259.932288ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:15.186267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.139068ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/\" range_end:\"/registry/pods/monitoring0\" ","response":"range_response_count:6 size:60841"} {"level":"info","ts":"2026-07-30T21:12:15.186322Z","caller":"traceutil/trace.go:171","msg":"trace[1168746218] range","detail":"{range_begin:/registry/pods/monitoring/; range_end:/registry/pods/monitoring0; response_count:6; response_revision:4748; }","duration":"260.22724ms","start":"2026-07-30T21:12:14.926078Z","end":"2026-07-30T21:12:15.186306Z","steps":["trace[1168746218] 'agreement among raft nodes before linearized reading' (duration: 259.891808ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:15.644012Z","caller":"traceutil/trace.go:171","msg":"trace[49718405] transaction","detail":"{read_only:false; response_revision:4749; number_of_response:1; }","duration":"452.712845ms","start":"2026-07-30T21:12:15.191268Z","end":"2026-07-30T21:12:15.643981Z","steps":["trace[49718405] 'process raft request' (duration: 358.641281ms)","trace[49718405] 'compare' (duration: 93.730461ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:15.644201Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:15.191249Z","time spent":"452.86048ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:15.688325Z","caller":"traceutil/trace.go:171","msg":"trace[1776404727] transaction","detail":"{read_only:false; response_revision:4750; number_of_response:1; }","duration":"496.795177ms","start":"2026-07-30T21:12:15.19151Z","end":"2026-07-30T21:12:15.688305Z","steps":["trace[1776404727] 'process raft request' (duration: 496.652932ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:15.688496Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:15.1915Z","time spent":"496.877401ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:15.688826Z","caller":"traceutil/trace.go:171","msg":"trace[957294401] transaction","detail":"{read_only:false; response_revision:4751; number_of_response:1; }","duration":"497.257435ms","start":"2026-07-30T21:12:15.191551Z","end":"2026-07-30T21:12:15.688809Z","steps":["trace[957294401] 'process raft request' (duration: 496.724844ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:15.688897Z","caller":"traceutil/trace.go:171","msg":"trace[2096227467] transaction","detail":"{read_only:false; response_revision:4752; number_of_response:1; }","duration":"486.451072ms","start":"2026-07-30T21:12:15.202439Z","end":"2026-07-30T21:12:15.68889Z","steps":["trace[2096227467] 'process raft request' (duration: 486.137229ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:15.688899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:15.19152Z","time spent":"497.336537ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:12:15.688933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:15.20241Z","time spent":"486.503413ms","remote":"127.0.0.1:45984","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7495,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:15.689033Z","caller":"traceutil/trace.go:171","msg":"trace[1691553977] linearizableReadLoop","detail":"{readStateIndex:4929; appliedIndex:4924; }","duration":"252.814238ms","start":"2026-07-30T21:12:15.436213Z","end":"2026-07-30T21:12:15.689027Z","steps":["trace[1691553977] 'read index received' (duration: 113.7945ms)","trace[1691553977] 'applied index is now lower than readState.Index' (duration: 139.019268ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:15.689104Z","caller":"traceutil/trace.go:171","msg":"trace[1841155013] transaction","detail":"{read_only:false; response_revision:4753; number_of_response:1; }","duration":"289.248515ms","start":"2026-07-30T21:12:15.399851Z","end":"2026-07-30T21:12:15.689099Z","steps":["trace[1841155013] 'process raft request' (duration: 289.006786ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:15.689233Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.711815ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:12975"} {"level":"info","ts":"2026-07-30T21:12:15.689264Z","caller":"traceutil/trace.go:171","msg":"trace[1082819131] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4753; }","duration":"128.812779ms","start":"2026-07-30T21:12:15.560441Z","end":"2026-07-30T21:12:15.689254Z","steps":["trace[1082819131] 'agreement among raft nodes before linearized reading' (duration: 128.701665ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:15.689424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.260763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba4f28bd-e1d5-49fe-a5a5-523b28ab84cb\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-30T21:12:15.689445Z","caller":"traceutil/trace.go:171","msg":"trace[1105756555] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ba4f28bd-e1d5-49fe-a5a5-523b28ab84cb; range_end:; response_count:1; response_revision:4753; }","duration":"101.494042ms","start":"2026-07-30T21:12:15.587942Z","end":"2026-07-30T21:12:15.689436Z","steps":["trace[1105756555] 'agreement among raft nodes before linearized reading' (duration: 101.436689ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:15.689688Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.109501ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-grafana-5b7f49dfcb-dg9vv.18c72d9e1d8f8533\" ","response":"range_response_count:1 size:896"} {"level":"info","ts":"2026-07-30T21:12:15.689772Z","caller":"traceutil/trace.go:171","msg":"trace[455008827] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-grafana-5b7f49dfcb-dg9vv.18c72d9e1d8f8533; range_end:; response_count:1; response_revision:4753; }","duration":"125.256615ms","start":"2026-07-30T21:12:15.564492Z","end":"2026-07-30T21:12:15.689749Z","steps":["trace[455008827] 'agreement among raft nodes before linearized reading' (duration: 124.989226ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:15.689838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"253.635488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-07-30T21:12:15.689863Z","caller":"traceutil/trace.go:171","msg":"trace[1283567063] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4753; }","duration":"253.720343ms","start":"2026-07-30T21:12:15.436137Z","end":"2026-07-30T21:12:15.689857Z","steps":["trace[1283567063] 'agreement among raft nodes before linearized reading' (duration: 253.163981ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:16.541649Z","caller":"traceutil/trace.go:171","msg":"trace[514989880] transaction","detail":"{read_only:false; response_revision:4762; number_of_response:1; }","duration":"408.841469ms","start":"2026-07-30T21:12:16.13278Z","end":"2026-07-30T21:12:16.541621Z","steps":["trace[514989880] 'process raft request' (duration: 408.623281ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:16.541835Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:16.132764Z","time spent":"408.961974ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:16.575838Z","caller":"traceutil/trace.go:171","msg":"trace[1674024468] transaction","detail":"{read_only:false; response_revision:4763; number_of_response:1; }","duration":"299.232591ms","start":"2026-07-30T21:12:16.276583Z","end":"2026-07-30T21:12:16.575816Z","steps":["trace[1674024468] 'process raft request' (duration: 299.065975ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:16.576114Z","caller":"traceutil/trace.go:171","msg":"trace[1927199930] linearizableReadLoop","detail":"{readStateIndex:4940; appliedIndex:4938; }","duration":"170.111495ms","start":"2026-07-30T21:12:16.405973Z","end":"2026-07-30T21:12:16.576085Z","steps":["trace[1927199930] 'read index received' (duration: 135.435532ms)","trace[1927199930] 'applied index is now lower than readState.Index' (duration: 34.673993ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:16.576505Z","caller":"traceutil/trace.go:171","msg":"trace[1619083591] transaction","detail":"{read_only:false; response_revision:4764; number_of_response:1; }","duration":"158.71477ms","start":"2026-07-30T21:12:16.417774Z","end":"2026-07-30T21:12:16.576489Z","steps":["trace[1619083591] 'process raft request' (duration: 158.000913ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:16.576972Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.628184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-07-30T21:12:16.577014Z","caller":"traceutil/trace.go:171","msg":"trace[1127761635] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4764; }","duration":"171.075691ms","start":"2026-07-30T21:12:16.405927Z","end":"2026-07-30T21:12:16.577003Z","steps":["trace[1127761635] 'agreement among raft nodes before linearized reading' (duration: 170.592173ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:17.157842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"310.756729ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:12:17.158807Z","caller":"traceutil/trace.go:171","msg":"trace[116860254] transaction","detail":"{read_only:false; response_revision:4768; number_of_response:1; }","duration":"490.299935ms","start":"2026-07-30T21:12:16.668474Z","end":"2026-07-30T21:12:17.158774Z","steps":["trace[116860254] 'process raft request' (duration: 178.513019ms)","trace[116860254] 'compare' (duration: 310.620923ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:17.158966Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:16.668441Z","time spent":"490.435849ms","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1273,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:17.15919Z","caller":"traceutil/trace.go:171","msg":"trace[1039149233] transaction","detail":"{read_only:false; response_revision:4770; number_of_response:1; }","duration":"490.313876ms","start":"2026-07-30T21:12:16.668859Z","end":"2026-07-30T21:12:17.159173Z","steps":["trace[1039149233] 'process raft request' (duration: 490.100138ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:17.159272Z","caller":"traceutil/trace.go:171","msg":"trace[1077617955] transaction","detail":"{read_only:false; response_revision:4771; number_of_response:1; }","duration":"232.848451ms","start":"2026-07-30T21:12:16.926398Z","end":"2026-07-30T21:12:17.159246Z","steps":["trace[1077617955] 'process raft request' (duration: 232.717477ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:17.159217Z","caller":"traceutil/trace.go:171","msg":"trace[609617312] linearizableReadLoop","detail":"{readStateIndex:4947; appliedIndex:4944; }","duration":"433.913082ms","start":"2026-07-30T21:12:16.725272Z","end":"2026-07-30T21:12:17.159185Z","steps":["trace[609617312] 'read index received' (duration: 121.7264ms)","trace[609617312] 'applied index is now lower than readState.Index' (duration: 312.184362ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:17.159475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"465.167928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba4f28bd-e1d5-49fe-a5a5-523b28ab84cb\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-30T21:12:17.159546Z","caller":"traceutil/trace.go:171","msg":"trace[220556699] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ba4f28bd-e1d5-49fe-a5a5-523b28ab84cb; range_end:; response_count:1; response_revision:4771; }","duration":"465.299182ms","start":"2026-07-30T21:12:16.69423Z","end":"2026-07-30T21:12:17.159529Z","steps":["trace[220556699] 'agreement among raft nodes before linearized reading' (duration: 465.048213ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:17.159609Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:16.694209Z","time spent":"465.383435ms","remote":"127.0.0.1:53864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3669,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ba4f28bd-e1d5-49fe-a5a5-523b28ab84cb\" "} {"level":"warn","ts":"2026-07-30T21:12:17.159602Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"430.669471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-30T21:12:17.159702Z","caller":"traceutil/trace.go:171","msg":"trace[896611762] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4771; }","duration":"430.784816ms","start":"2026-07-30T21:12:16.7289Z","end":"2026-07-30T21:12:17.159685Z","steps":["trace[896611762] 'agreement among raft nodes before linearized reading' (duration: 430.573798ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:17.159741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:16.72888Z","time spent":"430.852258ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":147,"response count":1,"response size":1958,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"warn","ts":"2026-07-30T21:12:17.159802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:16.668842Z","time spent":"490.44705ms","remote":"127.0.0.1:53960","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1853,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:17.160059Z","caller":"traceutil/trace.go:171","msg":"trace[359965810] transaction","detail":"{read_only:false; response_revision:4769; number_of_response:1; }","duration":"491.073634ms","start":"2026-07-30T21:12:16.668579Z","end":"2026-07-30T21:12:17.159653Z","steps":["trace[359965810] 'process raft request' (duration: 490.028435ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:17.160573Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:16.668575Z","time spent":"491.546542ms","remote":"127.0.0.1:53842","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":850,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:24.052902Z","caller":"traceutil/trace.go:171","msg":"trace[156409346] linearizableReadLoop","detail":"{readStateIndex:5053; appliedIndex:5052; }","duration":"329.422214ms","start":"2026-07-30T21:12:23.723458Z","end":"2026-07-30T21:12:24.05288Z","steps":["trace[156409346] 'read index received' (duration: 329.189936ms)","trace[156409346] 'applied index is now lower than readState.Index' (duration: 231.188µs)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:24.053021Z","caller":"traceutil/trace.go:171","msg":"trace[781484267] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"371.149143ms","start":"2026-07-30T21:12:23.68186Z","end":"2026-07-30T21:12:24.053009Z","steps":["trace[781484267] 'process raft request' (duration: 370.870633ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:24.053131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:23.681846Z","time spent":"371.200285ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":419,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:12:24.053454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.865061ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-07-30T21:12:24.053552Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.269493ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/\" range_end:\"/registry/persistentvolumes0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T21:12:24.053626Z","caller":"traceutil/trace.go:171","msg":"trace[1196914220] range","detail":"{range_begin:/registry/persistentvolumes/; range_end:/registry/persistentvolumes0; response_count:0; response_revision:4871; }","duration":"205.356527ms","start":"2026-07-30T21:12:23.848241Z","end":"2026-07-30T21:12:24.053597Z","steps":["trace[1196914220] 'agreement among raft nodes before linearized reading' (duration: 205.251074ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:24.053679Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.184154ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-30T21:12:24.053766Z","caller":"traceutil/trace.go:171","msg":"trace[1122796063] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4871; }","duration":"330.311157ms","start":"2026-07-30T21:12:23.723431Z","end":"2026-07-30T21:12:24.053742Z","steps":["trace[1122796063] 'agreement among raft nodes before linearized reading' (duration: 330.031167ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:24.053839Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:23.723413Z","time spent":"330.409901ms","remote":"127.0.0.1:53954","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":"info","ts":"2026-07-30T21:12:24.053531Z","caller":"traceutil/trace.go:171","msg":"trace[1390801921] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4871; }","duration":"330.005087ms","start":"2026-07-30T21:12:23.723507Z","end":"2026-07-30T21:12:24.053512Z","steps":["trace[1390801921] 'agreement among raft nodes before linearized reading' (duration: 329.675094ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:24.054122Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:23.723471Z","time spent":"330.630809ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":461,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-30T21:12:24.057549Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.884656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyextensionpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:12:24.0585Z","caller":"traceutil/trace.go:171","msg":"trace[792244179] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyextensionpolicies/; range_end:/registry/gateway.envoyproxy.io/envoyextensionpolicies0; response_count:0; response_revision:4871; }","duration":"149.761687ms","start":"2026-07-30T21:12:23.908214Z","end":"2026-07-30T21:12:24.057976Z","steps":["trace[792244179] 'agreement among raft nodes before linearized reading' (duration: 145.282069ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:29.10544Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.388548ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:12:29.105645Z","caller":"traceutil/trace.go:171","msg":"trace[1589343863] transaction","detail":"{read_only:false; response_revision:4914; number_of_response:1; }","duration":"453.013662ms","start":"2026-07-30T21:12:28.652582Z","end":"2026-07-30T21:12:29.105595Z","steps":["trace[1589343863] 'process raft request' (duration: 212.407066ms)","trace[1589343863] 'compare' (duration: 239.895979ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:29.105847Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:28.65256Z","time spent":"453.189908ms","remote":"127.0.0.1:53756","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":806,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-07-30T21:12:29.105852Z","caller":"traceutil/trace.go:171","msg":"trace[1247227572] linearizableReadLoop","detail":"{readStateIndex:5096; appliedIndex:5095; }","duration":"418.185594ms","start":"2026-07-30T21:12:28.68764Z","end":"2026-07-30T21:12:29.105825Z","steps":["trace[1247227572] 'read index received' (duration: 177.566738ms)","trace[1247227572] 'applied index is now lower than readState.Index' (duration: 240.616276ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:29.365759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"260.189404ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-07-30T21:12:29.365876Z","caller":"traceutil/trace.go:171","msg":"trace[278814840] linearizableReadLoop","detail":"{readStateIndex:5097; appliedIndex:5096; }","duration":"259.962905ms","start":"2026-07-30T21:12:29.105892Z","end":"2026-07-30T21:12:29.365855Z","steps":["trace[278814840] 'read index received' (duration: 74.533µs)","trace[278814840] 'applied index is now lower than readState.Index' (duration: 259.886572ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:29.36605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"678.349537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:10392"} {"level":"info","ts":"2026-07-30T21:12:29.36615Z","caller":"traceutil/trace.go:171","msg":"trace[192514815] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4914; }","duration":"678.527505ms","start":"2026-07-30T21:12:28.687597Z","end":"2026-07-30T21:12:29.366124Z","steps":["trace[192514815] 'agreement among raft nodes before linearized reading' (duration: 418.348991ms)","trace[192514815] 'range keys from in-memory index tree' (duration: 259.860173ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:29.366208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:28.687581Z","time spent":"678.615567ms","remote":"127.0.0.1:53864","response type":"/etcdserverpb.KV/Range","request count":0,"request size":53,"response count":1,"response size":10415,"request content":"key:\"/registry/pods/openstack/rabbitmq-keystone-server-0\" "} {"level":"warn","ts":"2026-07-30T21:12:29.366437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"338.431338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T21:12:29.366488Z","caller":"traceutil/trace.go:171","msg":"trace[271810926] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:4914; }","duration":"338.50355ms","start":"2026-07-30T21:12:29.027972Z","end":"2026-07-30T21:12:29.366475Z","steps":["trace[271810926] 'agreement among raft nodes before linearized reading' (duration: 338.380626ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:29.366529Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:29.027967Z","time spent":"338.551652ms","remote":"127.0.0.1:54052","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":26,"response size":30,"request content":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true "} {"level":"warn","ts":"2026-07-30T21:12:29.366622Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"363.017379ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T21:12:29.366675Z","caller":"traceutil/trace.go:171","msg":"trace[42981169] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/; range_end:/registry/apiextensions.k8s.io/customresourcedefinitions0; response_count:0; response_revision:4914; }","duration":"363.136833ms","start":"2026-07-30T21:12:29.003525Z","end":"2026-07-30T21:12:29.366662Z","steps":["trace[42981169] 'agreement among raft nodes before linearized reading' (duration: 362.991438ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:29.366708Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:29.003497Z","time spent":"363.203266ms","remote":"127.0.0.1:53732","response type":"/etcdserverpb.KV/Range","request count":0,"request size":120,"response count":71,"response size":30,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/\" range_end:\"/registry/apiextensions.k8s.io/customresourcedefinitions0\" count_only:true "} {"level":"warn","ts":"2026-07-30T21:12:29.366967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"664.537314ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" ","response":"range_response_count:1 size:1865"} {"level":"info","ts":"2026-07-30T21:12:29.367006Z","caller":"traceutil/trace.go:171","msg":"trace[1666357082] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4914; }","duration":"664.627819ms","start":"2026-07-30T21:12:28.702369Z","end":"2026-07-30T21:12:29.366997Z","steps":["trace[1666357082] 'agreement among raft nodes before linearized reading' (duration: 664.523765ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:29.367035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:28.702321Z","time spent":"664.707082ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":83,"response count":1,"response size":1888,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0\" "} {"level":"info","ts":"2026-07-30T21:12:29.383673Z","caller":"traceutil/trace.go:171","msg":"trace[1246420015] transaction","detail":"{read_only:false; response_revision:4915; number_of_response:1; }","duration":"182.236272ms","start":"2026-07-30T21:12:29.201402Z","end":"2026-07-30T21:12:29.383638Z","steps":["trace[1246420015] 'process raft request' (duration: 181.803025ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:29.432322Z","caller":"traceutil/trace.go:171","msg":"trace[1635853301] transaction","detail":"{read_only:false; response_revision:4916; number_of_response:1; }","duration":"200.420161ms","start":"2026-07-30T21:12:29.231882Z","end":"2026-07-30T21:12:29.432302Z","steps":["trace[1635853301] 'process raft request' (duration: 200.171352ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:29.432571Z","caller":"traceutil/trace.go:171","msg":"trace[407892141] transaction","detail":"{read_only:false; response_revision:4917; number_of_response:1; }","duration":"198.127594ms","start":"2026-07-30T21:12:29.234287Z","end":"2026-07-30T21:12:29.432414Z","steps":["trace[407892141] 'process raft request' (duration: 197.908906ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:29.432723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.146083ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3316"} {"level":"info","ts":"2026-07-30T21:12:29.432759Z","caller":"traceutil/trace.go:171","msg":"trace[132117562] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:4918; }","duration":"133.254187ms","start":"2026-07-30T21:12:29.299495Z","end":"2026-07-30T21:12:29.432749Z","steps":["trace[132117562] 'agreement among raft nodes before linearized reading' (duration: 133.06319ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:29.637635Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.634079ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:12:29.638128Z","caller":"traceutil/trace.go:171","msg":"trace[198401615] transaction","detail":"{read_only:false; response_revision:4921; number_of_response:1; }","duration":"196.919067ms","start":"2026-07-30T21:12:29.441182Z","end":"2026-07-30T21:12:29.638101Z","steps":["trace[198401615] 'process raft request' (duration: 196.588975ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:29.638336Z","caller":"traceutil/trace.go:171","msg":"trace[1674736499] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"197.003551ms","start":"2026-07-30T21:12:29.441321Z","end":"2026-07-30T21:12:29.638325Z","steps":["trace[1674736499] 'process raft request' (duration: 196.645277ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:29.638376Z","caller":"traceutil/trace.go:171","msg":"trace[540274432] transaction","detail":"{read_only:false; response_revision:4920; number_of_response:1; }","duration":"197.531681ms","start":"2026-07-30T21:12:29.440802Z","end":"2026-07-30T21:12:29.638334Z","steps":["trace[540274432] 'process raft request' (duration: 86.07932ms)","trace[540274432] 'compare' (duration: 110.36229ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:29.638765Z","caller":"traceutil/trace.go:171","msg":"trace[454370614] transaction","detail":"{read_only:false; response_revision:4923; number_of_response:1; }","duration":"196.729661ms","start":"2026-07-30T21:12:29.442019Z","end":"2026-07-30T21:12:29.638748Z","steps":["trace[454370614] 'process raft request' (duration: 196.000653ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:29.639051Z","caller":"traceutil/trace.go:171","msg":"trace[62945925] transaction","detail":"{read_only:false; response_revision:4924; number_of_response:1; }","duration":"167.503924ms","start":"2026-07-30T21:12:29.471534Z","end":"2026-07-30T21:12:29.639038Z","steps":["trace[62945925] 'process raft request' (duration: 167.112889ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:29.639033Z","caller":"traceutil/trace.go:171","msg":"trace[65715514] linearizableReadLoop","detail":"{readStateIndex:5107; appliedIndex:5102; }","duration":"101.12247ms","start":"2026-07-30T21:12:29.537878Z","end":"2026-07-30T21:12:29.639001Z","steps":["trace[65715514] 'read index received' (duration: 24.828609ms)","trace[65715514] 'applied index is now lower than readState.Index' (duration: 76.291401ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:29.639383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.477613ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-07-30T21:12:29.639442Z","caller":"traceutil/trace.go:171","msg":"trace[274688637] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4924; }","duration":"101.599918ms","start":"2026-07-30T21:12:29.537825Z","end":"2026-07-30T21:12:29.639425Z","steps":["trace[274688637] 'agreement among raft nodes before linearized reading' (duration: 101.342558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:30.112404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.219175ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:12:30.112911Z","caller":"traceutil/trace.go:171","msg":"trace[2020587803] transaction","detail":"{read_only:false; response_revision:4928; number_of_response:1; }","duration":"385.975933ms","start":"2026-07-30T21:12:29.726912Z","end":"2026-07-30T21:12:30.112888Z","steps":["trace[2020587803] 'process raft request' (duration: 264.199116ms)","trace[2020587803] 'compare' (duration: 121.020808ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:30.113144Z","caller":"traceutil/trace.go:171","msg":"trace[1735680181] linearizableReadLoop","detail":"{readStateIndex:5111; appliedIndex:5110; }","duration":"380.376671ms","start":"2026-07-30T21:12:29.732139Z","end":"2026-07-30T21:12:30.112516Z","steps":["trace[1735680181] 'read index received' (duration: 258.853503ms)","trace[1735680181] 'applied index is now lower than readState.Index' (duration: 121.521968ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:30.113152Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:29.726899Z","time spent":"386.099538ms","remote":"127.0.0.1:53864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17136,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:12:30.113372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.193341ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-07-30T21:12:30.113455Z","caller":"traceutil/trace.go:171","msg":"trace[1391678055] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:4928; }","duration":"381.323517ms","start":"2026-07-30T21:12:29.732112Z","end":"2026-07-30T21:12:30.113435Z","steps":["trace[1391678055] 'agreement among raft nodes before linearized reading' (duration: 381.049197ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:30.113452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"340.932787ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"warn","ts":"2026-07-30T21:12:30.11351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:29.732101Z","time spent":"381.39962ms","remote":"127.0.0.1:54252","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5674,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-07-30T21:12:30.113543Z","caller":"traceutil/trace.go:171","msg":"trace[1164059658] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4928; }","duration":"341.115304ms","start":"2026-07-30T21:12:29.772409Z","end":"2026-07-30T21:12:30.113525Z","steps":["trace[1164059658] 'agreement among raft nodes before linearized reading' (duration: 340.850443ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:30.113611Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:29.772379Z","time spent":"341.199278ms","remote":"127.0.0.1:53840","response type":"/etcdserverpb.KV/Range","request count":0,"request size":139,"response count":1,"response size":2105,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" "} {"level":"warn","ts":"2026-07-30T21:12:30.331948Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.908447ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:12:30.332078Z","caller":"traceutil/trace.go:171","msg":"trace[847379600] linearizableReadLoop","detail":"{readStateIndex:5113; appliedIndex:5112; }","duration":"136.827759ms","start":"2026-07-30T21:12:30.19523Z","end":"2026-07-30T21:12:30.332057Z","steps":["trace[847379600] 'read index received' (duration: 16.677473ms)","trace[847379600] 'applied index is now lower than readState.Index' (duration: 120.148736ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:30.332166Z","caller":"traceutil/trace.go:171","msg":"trace[51395192] transaction","detail":"{read_only:false; response_revision:4930; number_of_response:1; }","duration":"138.088965ms","start":"2026-07-30T21:12:30.194062Z","end":"2026-07-30T21:12:30.332151Z","steps":["trace[51395192] 'process raft request' (duration: 17.882357ms)","trace[51395192] 'compare' (duration: 119.774012ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:30.332347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.105259ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-30T21:12:30.332396Z","caller":"traceutil/trace.go:171","msg":"trace[1079836106] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4930; }","duration":"137.17125ms","start":"2026-07-30T21:12:30.195209Z","end":"2026-07-30T21:12:30.33238Z","steps":["trace[1079836106] 'agreement among raft nodes before linearized reading' (duration: 137.014864ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:30.636113Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.927657ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-30T21:12:30.636443Z","caller":"traceutil/trace.go:171","msg":"trace[654204492] transaction","detail":"{read_only:false; response_revision:4931; number_of_response:1; }","duration":"440.952508ms","start":"2026-07-30T21:12:30.195452Z","end":"2026-07-30T21:12:30.636404Z","steps":["trace[654204492] 'process raft request' (duration: 253.644297ms)","trace[654204492] 'compare' (duration: 186.797112ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:30.636565Z","caller":"traceutil/trace.go:171","msg":"trace[1603217341] linearizableReadLoop","detail":"{readStateIndex:5115; appliedIndex:5113; }","duration":"304.436192ms","start":"2026-07-30T21:12:30.332111Z","end":"2026-07-30T21:12:30.636547Z","steps":["trace[1603217341] 'read index received' (duration: 116.905762ms)","trace[1603217341] 'applied index is now lower than readState.Index' (duration: 187.52919ms)"],"step_count":2} {"level":"warn","ts":"2026-07-30T21:12:30.636729Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:30.195442Z","time spent":"441.154117ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:12:30.636832Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"321.955256ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-30T21:12:30.636918Z","caller":"traceutil/trace.go:171","msg":"trace[1028372045] range","detail":"{range_begin:/registry/certificatesigningrequests/; range_end:/registry/certificatesigningrequests0; response_count:0; response_revision:4933; }","duration":"322.065401ms","start":"2026-07-30T21:12:30.314834Z","end":"2026-07-30T21:12:30.636899Z","steps":["trace[1028372045] 'agreement among raft nodes before linearized reading' (duration: 321.900624ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:30.636974Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:30.314757Z","time spent":"322.205645ms","remote":"127.0.0.1:53938","response type":"/etcdserverpb.KV/Range","request count":0,"request size":80,"response count":1,"response size":30,"request content":"key:\"/registry/certificatesigningrequests/\" range_end:\"/registry/certificatesigningrequests0\" count_only:true "} {"level":"warn","ts":"2026-07-30T21:12:30.637075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.287743ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-d5dfa13e-1b03-4531-b750-8663c71b61a2\" ","response":"range_response_count:1 size:1450"} {"level":"info","ts":"2026-07-30T21:12:30.637131Z","caller":"traceutil/trace.go:171","msg":"trace[271136588] range","detail":"{range_begin:/registry/persistentvolumes/pvc-d5dfa13e-1b03-4531-b750-8663c71b61a2; range_end:; response_count:1; response_revision:4933; }","duration":"301.386187ms","start":"2026-07-30T21:12:30.335734Z","end":"2026-07-30T21:12:30.637121Z","steps":["trace[271136588] 'agreement among raft nodes before linearized reading' (duration: 301.21605ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:30.637162Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:30.33572Z","time spent":"301.435468ms","remote":"127.0.0.1:53836","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":1473,"request content":"key:\"/registry/persistentvolumes/pvc-d5dfa13e-1b03-4531-b750-8663c71b61a2\" "} {"level":"info","ts":"2026-07-30T21:12:30.636377Z","caller":"traceutil/trace.go:171","msg":"trace[9660715] transaction","detail":"{read_only:false; response_revision:4932; number_of_response:1; }","duration":"435.44475ms","start":"2026-07-30T21:12:30.200907Z","end":"2026-07-30T21:12:30.636352Z","steps":["trace[9660715] 'process raft request' (duration: 435.300165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:30.638859Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:30.200899Z","time spent":"437.903154ms","remote":"127.0.0.1:53864","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17110,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:30.973433Z","caller":"traceutil/trace.go:171","msg":"trace[1383793193] transaction","detail":"{read_only:false; response_revision:4943; number_of_response:1; }","duration":"140.253278ms","start":"2026-07-30T21:12:30.833148Z","end":"2026-07-30T21:12:30.973402Z","steps":["trace[1383793193] 'process raft request' (duration: 96.77072ms)","trace[1383793193] 'compare' (duration: 43.225579ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:30.973788Z","caller":"traceutil/trace.go:171","msg":"trace[1262027312] transaction","detail":"{read_only:false; response_revision:4944; number_of_response:1; }","duration":"139.49539ms","start":"2026-07-30T21:12:30.834264Z","end":"2026-07-30T21:12:30.973759Z","steps":["trace[1262027312] 'process raft request' (duration: 139.084844ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:30.973973Z","caller":"traceutil/trace.go:171","msg":"trace[603788521] transaction","detail":"{read_only:false; response_revision:4946; number_of_response:1; }","duration":"138.580696ms","start":"2026-07-30T21:12:30.83538Z","end":"2026-07-30T21:12:30.973961Z","steps":["trace[603788521] 'process raft request' (duration: 138.334176ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:30.974277Z","caller":"traceutil/trace.go:171","msg":"trace[149850642] transaction","detail":"{read_only:false; response_revision:4945; number_of_response:1; }","duration":"139.863634ms","start":"2026-07-30T21:12:30.834401Z","end":"2026-07-30T21:12:30.974265Z","steps":["trace[149850642] 'process raft request' (duration: 139.180488ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:30.974284Z","caller":"traceutil/trace.go:171","msg":"trace[1069249655] transaction","detail":"{read_only:false; response_revision:4947; number_of_response:1; }","duration":"130.738888ms","start":"2026-07-30T21:12:30.843524Z","end":"2026-07-30T21:12:30.974263Z","steps":["trace[1069249655] 'process raft request' (duration: 130.240979ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:31.969891Z","caller":"traceutil/trace.go:171","msg":"trace[23918047] transaction","detail":"{read_only:false; response_revision:4949; number_of_response:1; }","duration":"579.550917ms","start":"2026-07-30T21:12:31.390318Z","end":"2026-07-30T21:12:31.969869Z","steps":["trace[23918047] 'process raft request' (duration: 579.370151ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:31.970067Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:31.390284Z","time spent":"579.681302ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-30T21:12:31.974854Z","caller":"traceutil/trace.go:171","msg":"trace[924044773] linearizableReadLoop","detail":"{readStateIndex:5135; appliedIndex:5131; }","duration":"311.488703ms","start":"2026-07-30T21:12:31.663343Z","end":"2026-07-30T21:12:31.974832Z","steps":["trace[924044773] 'read index received' (duration: 306.372299ms)","trace[924044773] 'applied index is now lower than readState.Index' (duration: 5.115554ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:12:31.975149Z","caller":"traceutil/trace.go:171","msg":"trace[175418608] transaction","detail":"{read_only:false; response_revision:4950; number_of_response:1; }","duration":"533.040852ms","start":"2026-07-30T21:12:31.442091Z","end":"2026-07-30T21:12:31.975132Z","steps":["trace[175418608] 'process raft request' (duration: 532.519413ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:31.975136Z","caller":"traceutil/trace.go:171","msg":"trace[639548525] transaction","detail":"{read_only:false; response_revision:4951; number_of_response:1; }","duration":"532.824824ms","start":"2026-07-30T21:12:31.442291Z","end":"2026-07-30T21:12:31.975115Z","steps":["trace[639548525] 'process raft request' (duration: 532.45603ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:12:31.975154Z","caller":"traceutil/trace.go:171","msg":"trace[1764640567] transaction","detail":"{read_only:false; response_revision:4952; number_of_response:1; }","duration":"358.468116ms","start":"2026-07-30T21:12:31.616665Z","end":"2026-07-30T21:12:31.975133Z","steps":["trace[1764640567] 'process raft request' (duration: 358.122823ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:31.975267Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:31.442267Z","time spent":"532.957568ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:12:31.975292Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:31.442049Z","time spent":"533.152527ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:12:31.975329Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:31.616649Z","time spent":"358.623503ms","remote":"127.0.0.1:53954","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-30T21:12:31.975471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.454003ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-30T21:12:31.975564Z","caller":"traceutil/trace.go:171","msg":"trace[640930760] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4952; }","duration":"188.596159ms","start":"2026-07-30T21:12:31.786942Z","end":"2026-07-30T21:12:31.975538Z","steps":["trace[640930760] 'agreement among raft nodes before linearized reading' (duration: 188.236985ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:31.975814Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.936269ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:12:31.975947Z","caller":"traceutil/trace.go:171","msg":"trace[194102980] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4952; }","duration":"312.626516ms","start":"2026-07-30T21:12:31.663293Z","end":"2026-07-30T21:12:31.975919Z","steps":["trace[194102980] 'agreement among raft nodes before linearized reading' (duration: 311.802005ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:12:31.976194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-30T21:12:31.663276Z","time spent":"312.900827ms","remote":"127.0.0.1:53680","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-07-30T21:13:06.636691Z","caller":"traceutil/trace.go:171","msg":"trace[392788366] transaction","detail":"{read_only:false; response_revision:5257; number_of_response:1; }","duration":"142.530491ms","start":"2026-07-30T21:13:06.494135Z","end":"2026-07-30T21:13:06.636666Z","steps":["trace[392788366] 'process raft request' (duration: 142.26316ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:13:50.308703Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2886} {"level":"info","ts":"2026-07-30T21:13:50.414792Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2886,"took":"103.856704ms","hash":1443575234,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":29446144,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-30T21:13:50.414854Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1443575234,"revision":2886,"compact-revision":-1} {"level":"warn","ts":"2026-07-30T21:16:10.867407Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"154.162687ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/federations/\" range_end:\"/registry/rabbitmq.com/federations0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:16:10.86751Z","caller":"traceutil/trace.go:171","msg":"trace[386659405] range","detail":"{range_begin:/registry/rabbitmq.com/federations/; range_end:/registry/rabbitmq.com/federations0; response_count:0; response_revision:6529; }","duration":"154.294063ms","start":"2026-07-30T21:16:10.713194Z","end":"2026-07-30T21:16:10.867488Z","steps":["trace[386659405] 'count revisions from in-memory index tree' (duration: 154.084614ms)"],"step_count":1} {"level":"warn","ts":"2026-07-30T21:16:10.867609Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"203.844378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-30T21:16:10.867693Z","caller":"traceutil/trace.go:171","msg":"trace[819214364] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6529; }","duration":"204.002344ms","start":"2026-07-30T21:16:10.663665Z","end":"2026-07-30T21:16:10.867667Z","steps":["trace[819214364] 'range keys from in-memory index tree' (duration: 203.745854ms)"],"step_count":1} {"level":"info","ts":"2026-07-30T21:16:15.937067Z","caller":"traceutil/trace.go:171","msg":"trace[2025180682] transaction","detail":"{read_only:false; response_revision:6557; number_of_response:1; }","duration":"161.351387ms","start":"2026-07-30T21:16:15.775694Z","end":"2026-07-30T21:16:15.937046Z","steps":["trace[2025180682] 'process raft request' (duration: 93.493306ms)","trace[2025180682] 'compare' (duration: 67.737536ms)"],"step_count":2} {"level":"info","ts":"2026-07-30T21:18:50.314621Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5571} {"level":"info","ts":"2026-07-30T21:18:50.450478Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5571,"took":"133.850667ms","hash":56401703,"current-db-size-bytes":53964800,"current-db-size":"54 MB","current-db-size-in-use-bytes":18378752,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-07-30T21:18:50.450557Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":56401703,"revision":5571,"compact-revision":2886}