{"level":"warn","ts":"2026-05-30T01:44:00.88163Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:44:00.881749Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.19:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.204.45.19:2380","--initial-cluster=instance=https://199.204.45.19:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.19:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.19: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-05-30T01:44:00.881842Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-05-30T01:44:00.881861Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-30T01:44:00.881902Z","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-05-30T01:44:00.883086Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"]} {"level":"info","ts":"2026-05-30T01:44:00.883447Z","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.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.19: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-05-30T01:44:00.894172Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"10.389012ms"} {"level":"info","ts":"2026-05-30T01:44:00.900205Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"a847c2e9c7010db6","cluster-id":"2b11a68e27507b05"} {"level":"info","ts":"2026-05-30T01:44:00.900354Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=()"} {"level":"info","ts":"2026-05-30T01:44:00.900427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 0"} {"level":"info","ts":"2026-05-30T01:44:00.900482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft a847c2e9c7010db6 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-05-30T01:44:00.90051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became follower at term 1"} {"level":"info","ts":"2026-05-30T01:44:00.900593Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"warn","ts":"2026-05-30T01:44:00.909613Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-05-30T01:44:00.910739Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-05-30T01:44:00.911781Z","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-05-30T01:44:00.91328Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"a847c2e9c7010db6","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-05-30T01:44:00.913559Z","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-05-30T01:44:00.913679Z","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-05-30T01:44:00.913693Z","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-05-30T01:44:00.913401Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"a847c2e9c7010db6","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-05-30T01:44:00.91422Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 switched to configuration voters=(12125874831040253366)"} {"level":"info","ts":"2026-05-30T01:44:00.914369Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","added-peer-id":"a847c2e9c7010db6","added-peer-peer-urls":["https://199.204.45.19:2380"]} {"level":"info","ts":"2026-05-30T01:44:00.923277Z","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-05-30T01:44:00.923495Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"a847c2e9c7010db6","initial-advertise-peer-urls":["https://199.204.45.19:2380"],"listen-peer-urls":["https://199.204.45.19:2380"],"advertise-client-urls":["https://199.204.45.19:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.19:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-05-30T01:44:00.923574Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-05-30T01:44:00.923703Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-30T01:44:00.923756Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.19:2380"} {"level":"info","ts":"2026-05-30T01:44:01.403379Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 is starting a new election at term 1"} {"level":"info","ts":"2026-05-30T01:44:01.403502Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became pre-candidate at term 1"} {"level":"info","ts":"2026-05-30T01:44:01.403547Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgPreVoteResp from a847c2e9c7010db6 at term 1"} {"level":"info","ts":"2026-05-30T01:44:01.403591Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became candidate at term 2"} {"level":"info","ts":"2026-05-30T01:44:01.403646Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 received MsgVoteResp from a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-30T01:44:01.403705Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"a847c2e9c7010db6 became leader at term 2"} {"level":"info","ts":"2026-05-30T01:44:01.403752Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: a847c2e9c7010db6 elected leader a847c2e9c7010db6 at term 2"} {"level":"info","ts":"2026-05-30T01:44:01.40882Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:44:01.409632Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:44:01.40963Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"a847c2e9c7010db6","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.19:2379]}","request-path":"/0/members/a847c2e9c7010db6/attributes","cluster-id":"2b11a68e27507b05","publish-timeout":"7s"} {"level":"info","ts":"2026-05-30T01:44:01.409668Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-05-30T01:44:01.409994Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-05-30T01:44:01.410083Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-05-30T01:44:01.410281Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2b11a68e27507b05","local-member-id":"a847c2e9c7010db6","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:44:01.410369Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:44:01.410401Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-05-30T01:44:01.413432Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.19:2379"} {"level":"info","ts":"2026-05-30T01:44:01.414048Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-05-30T01:44:06.15679Z","caller":"traceutil/trace.go:171","msg":"trace[441072693] transaction","detail":"{read_only:false; response_revision:257; number_of_response:1; }","duration":"467.797889ms","start":"2026-05-30T01:44:05.688964Z","end":"2026-05-30T01:44:06.156762Z","steps":["trace[441072693] 'process raft request' (duration: 467.643067ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:06.157392Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:05.688936Z","time spent":"467.94799ms","remote":"127.0.0.1:40200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4002,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:44:06.785509Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"623.637258ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/kube-system/bootstrap-token-drwxoq\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T01:44:06.785572Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.764945ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:44:06.785661Z","caller":"traceutil/trace.go:171","msg":"trace[1763792676] range","detail":"{range_begin:/registry/secrets/kube-system/bootstrap-token-drwxoq; range_end:; response_count:0; response_revision:257; }","duration":"623.91708ms","start":"2026-05-30T01:44:06.161715Z","end":"2026-05-30T01:44:06.785632Z","steps":["trace[1763792676] 'range keys from in-memory index tree' (duration: 623.522326ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:06.78571Z","caller":"traceutil/trace.go:171","msg":"trace[275298924] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:0; response_revision:257; }","duration":"393.986518ms","start":"2026-05-30T01:44:06.391683Z","end":"2026-05-30T01:44:06.785669Z","steps":["trace[275298924] 'range keys from in-memory index tree' (duration: 393.633264ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:06.785724Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:06.161693Z","time spent":"624.018891ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/kube-system/bootstrap-token-drwxoq\" "} {"level":"warn","ts":"2026-05-30T01:44:06.785784Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:06.391644Z","time spent":"394.12939ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":0,"response size":28,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-30T01:44:24.758324Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.062594ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:44:24.758533Z","caller":"traceutil/trace.go:171","msg":"trace[612539872] linearizableReadLoop","detail":"{readStateIndex:461; appliedIndex:459; }","duration":"193.929271ms","start":"2026-05-30T01:44:24.564589Z","end":"2026-05-30T01:44:24.758518Z","steps":["trace[612539872] 'read index received' (duration: 25.065316ms)","trace[612539872] 'applied index is now lower than readState.Index' (duration: 168.863165ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:24.758525Z","caller":"traceutil/trace.go:171","msg":"trace[708262662] transaction","detail":"{read_only:false; response_revision:445; number_of_response:1; }","duration":"194.257754ms","start":"2026-05-30T01:44:24.564239Z","end":"2026-05-30T01:44:24.758497Z","steps":["trace[708262662] 'process raft request' (duration: 86.798626ms)","trace[708262662] 'compare' (duration: 106.949013ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:24.75868Z","caller":"traceutil/trace.go:171","msg":"trace[2074385161] transaction","detail":"{read_only:false; response_revision:447; number_of_response:1; }","duration":"193.668738ms","start":"2026-05-30T01:44:24.564984Z","end":"2026-05-30T01:44:24.758653Z","steps":["trace[2074385161] 'process raft request' (duration: 193.495156ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:24.758755Z","caller":"traceutil/trace.go:171","msg":"trace[672158021] transaction","detail":"{read_only:false; response_revision:446; number_of_response:1; }","duration":"194.118083ms","start":"2026-05-30T01:44:24.56463Z","end":"2026-05-30T01:44:24.758748Z","steps":["trace[672158021] 'process raft request' (duration: 193.79331ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:24.758829Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"194.235533ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/kube-system/coredns\" ","response":"range_response_count:1 size:4195"} {"level":"info","ts":"2026-05-30T01:44:24.75886Z","caller":"traceutil/trace.go:171","msg":"trace[782644721] range","detail":"{range_begin:/registry/deployments/kube-system/coredns; range_end:; response_count:1; response_revision:447; }","duration":"194.284524ms","start":"2026-05-30T01:44:24.564566Z","end":"2026-05-30T01:44:24.758851Z","steps":["trace[782644721] 'agreement among raft nodes before linearized reading' (duration: 194.216783ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:24.971454Z","caller":"traceutil/trace.go:171","msg":"trace[306483617] transaction","detail":"{read_only:false; response_revision:449; number_of_response:1; }","duration":"208.644241ms","start":"2026-05-30T01:44:24.762777Z","end":"2026-05-30T01:44:24.971421Z","steps":["trace[306483617] 'process raft request' (duration: 166.483231ms)","trace[306483617] 'compare' (duration: 41.955518ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:24.971522Z","caller":"traceutil/trace.go:171","msg":"trace[255572669] transaction","detail":"{read_only:false; response_revision:450; number_of_response:1; }","duration":"205.773742ms","start":"2026-05-30T01:44:24.765731Z","end":"2026-05-30T01:44:24.971505Z","steps":["trace[255572669] 'process raft request' (duration: 205.663621ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:24.971525Z","caller":"traceutil/trace.go:171","msg":"trace[1557204772] linearizableReadLoop","detail":"{readStateIndex:466; appliedIndex:464; }","duration":"179.21113ms","start":"2026-05-30T01:44:24.792289Z","end":"2026-05-30T01:44:24.9715Z","steps":["trace[1557204772] 'read index received' (duration: 136.940629ms)","trace[1557204772] 'applied index is now lower than readState.Index' (duration: 42.269581ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:24.971766Z","caller":"traceutil/trace.go:171","msg":"trace[2098214098] transaction","detail":"{read_only:false; response_revision:451; number_of_response:1; }","duration":"177.26054ms","start":"2026-05-30T01:44:24.794491Z","end":"2026-05-30T01:44:24.971752Z","steps":["trace[2098214098] 'process raft request' (duration: 176.979678ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:24.971808Z","caller":"traceutil/trace.go:171","msg":"trace[376336482] transaction","detail":"{read_only:false; response_revision:452; number_of_response:1; }","duration":"175.575572ms","start":"2026-05-30T01:44:24.796209Z","end":"2026-05-30T01:44:24.971784Z","steps":["trace[376336482] 'process raft request' (duration: 175.450831ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:24.971755Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.441543ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/default/kubernetes\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-05-30T01:44:24.972355Z","caller":"traceutil/trace.go:171","msg":"trace[873459742] range","detail":"{range_begin:/registry/endpointslices/default/kubernetes; range_end:; response_count:1; response_revision:451; }","duration":"180.076679ms","start":"2026-05-30T01:44:24.792257Z","end":"2026-05-30T01:44:24.972333Z","steps":["trace[873459742] 'agreement among raft nodes before linearized reading' (duration: 179.397322ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:25.208515Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.549691ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:44:25.208745Z","caller":"traceutil/trace.go:171","msg":"trace[1104280331] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"169.93034ms","start":"2026-05-30T01:44:25.038803Z","end":"2026-05-30T01:44:25.208734Z","steps":["trace[1104280331] 'process raft request' (duration: 169.89937ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:25.208804Z","caller":"traceutil/trace.go:171","msg":"trace[513748255] transaction","detail":"{read_only:false; response_revision:461; number_of_response:1; }","duration":"170.851549ms","start":"2026-05-30T01:44:25.037915Z","end":"2026-05-30T01:44:25.208767Z","steps":["trace[513748255] 'process raft request' (duration: 170.720468ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:25.208932Z","caller":"traceutil/trace.go:171","msg":"trace[187502916] transaction","detail":"{read_only:false; response_revision:460; number_of_response:1; }","duration":"172.95764ms","start":"2026-05-30T01:44:25.035905Z","end":"2026-05-30T01:44:25.208862Z","steps":["trace[187502916] 'process raft request' (duration: 49.982695ms)","trace[187502916] 'compare' (duration: 122.416929ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:25.209014Z","caller":"traceutil/trace.go:171","msg":"trace[1248360995] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"170.257603ms","start":"2026-05-30T01:44:25.038706Z","end":"2026-05-30T01:44:25.208964Z","steps":["trace[1248360995] 'process raft request' (duration: 169.97326ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:25.409212Z","caller":"traceutil/trace.go:171","msg":"trace[1719982614] linearizableReadLoop","detail":"{readStateIndex:481; appliedIndex:480; }","duration":"103.410766ms","start":"2026-05-30T01:44:25.305779Z","end":"2026-05-30T01:44:25.40919Z","steps":["trace[1719982614] 'read index received' (duration: 28.933743ms)","trace[1719982614] 'applied index is now lower than readState.Index' (duration: 74.476443ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:25.409352Z","caller":"traceutil/trace.go:171","msg":"trace[2000182677] transaction","detail":"{read_only:false; response_revision:465; number_of_response:1; }","duration":"124.689952ms","start":"2026-05-30T01:44:25.284598Z","end":"2026-05-30T01:44:25.409288Z","steps":["trace[2000182677] 'process raft request' (duration: 50.158988ms)","trace[2000182677] 'compare' (duration: 74.344303ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:44:25.409386Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.585689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-30T01:44:25.409622Z","caller":"traceutil/trace.go:171","msg":"trace[1770821852] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:465; }","duration":"103.822701ms","start":"2026-05-30T01:44:25.305744Z","end":"2026-05-30T01:44:25.409567Z","steps":["trace[1770821852] 'agreement among raft nodes before linearized reading' (duration: 103.549367ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:27.162616Z","caller":"traceutil/trace.go:171","msg":"trace[881068713] transaction","detail":"{read_only:false; response_revision:469; number_of_response:1; }","duration":"126.66331ms","start":"2026-05-30T01:44:27.035925Z","end":"2026-05-30T01:44:27.162589Z","steps":["trace[881068713] 'process raft request' (duration: 49.818815ms)","trace[881068713] 'compare' (duration: 76.735104ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:37.651264Z","caller":"traceutil/trace.go:171","msg":"trace[707325861] linearizableReadLoop","detail":"{readStateIndex:545; appliedIndex:544; }","duration":"104.200489ms","start":"2026-05-30T01:44:37.547018Z","end":"2026-05-30T01:44:37.651219Z","steps":["trace[707325861] 'read index received' (duration: 104.068628ms)","trace[707325861] 'applied index is now lower than readState.Index' (duration: 130.741µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:44:37.65148Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.43761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-30T01:44:37.651539Z","caller":"traceutil/trace.go:171","msg":"trace[2104621608] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:527; }","duration":"104.547271ms","start":"2026-05-30T01:44:37.546975Z","end":"2026-05-30T01:44:37.651522Z","steps":["trace[2104621608] 'agreement among raft nodes before linearized reading' (duration: 104.4061ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:37.651918Z","caller":"traceutil/trace.go:171","msg":"trace[694814993] transaction","detail":"{read_only:false; response_revision:527; number_of_response:1; }","duration":"151.747416ms","start":"2026-05-30T01:44:37.500154Z","end":"2026-05-30T01:44:37.651901Z","steps":["trace[694814993] 'process raft request' (duration: 150.838487ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:38.654557Z","caller":"traceutil/trace.go:171","msg":"trace[1428495861] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"417.362552ms","start":"2026-05-30T01:44:38.23717Z","end":"2026-05-30T01:44:38.654532Z","steps":["trace[1428495861] 'process raft request' (duration: 417.1471ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.654722Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.237146Z","time spent":"417.497932ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.661062Z","caller":"traceutil/trace.go:171","msg":"trace[1088640778] transaction","detail":"{read_only:false; response_revision:531; number_of_response:1; }","duration":"409.915034ms","start":"2026-05-30T01:44:38.251128Z","end":"2026-05-30T01:44:38.661043Z","steps":["trace[1088640778] 'process raft request' (duration: 409.635982ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.661174Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.251113Z","time spent":"410.006995ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.661281Z","caller":"traceutil/trace.go:171","msg":"trace[187864772] transaction","detail":"{read_only:false; response_revision:532; number_of_response:1; }","duration":"410.083386ms","start":"2026-05-30T01:44:38.251182Z","end":"2026-05-30T01:44:38.661266Z","steps":["trace[187864772] 'process raft request' (duration: 409.770632ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.661342Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.251172Z","time spent":"410.141676ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.661432Z","caller":"traceutil/trace.go:171","msg":"trace[1520983319] transaction","detail":"{read_only:false; response_revision:533; number_of_response:1; }","duration":"402.739248ms","start":"2026-05-30T01:44:38.258683Z","end":"2026-05-30T01:44:38.661422Z","steps":["trace[1520983319] 'process raft request' (duration: 402.345704ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.661538Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.258671Z","time spent":"402.793579ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.661784Z","caller":"traceutil/trace.go:171","msg":"trace[946113195] transaction","detail":"{read_only:false; response_revision:534; number_of_response:1; }","duration":"398.863693ms","start":"2026-05-30T01:44:38.262904Z","end":"2026-05-30T01:44:38.661768Z","steps":["trace[946113195] 'process raft request' (duration: 398.351719ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.661845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.262895Z","time spent":"398.924183ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.662239Z","caller":"traceutil/trace.go:171","msg":"trace[604045933] transaction","detail":"{read_only:false; response_revision:535; number_of_response:1; }","duration":"399.202806ms","start":"2026-05-30T01:44:38.263007Z","end":"2026-05-30T01:44:38.66221Z","steps":["trace[604045933] 'process raft request' (duration: 398.739741ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.662393Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.262977Z","time spent":"399.336847ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.66257Z","caller":"traceutil/trace.go:171","msg":"trace[590004533] transaction","detail":"{read_only:false; response_revision:536; number_of_response:1; }","duration":"398.603991ms","start":"2026-05-30T01:44:38.263955Z","end":"2026-05-30T01:44:38.662559Z","steps":["trace[590004533] 'process raft request' (duration: 398.085507ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.662683Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.263945Z","time spent":"398.657601ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.662931Z","caller":"traceutil/trace.go:171","msg":"trace[2145230213] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"396.127498ms","start":"2026-05-30T01:44:38.26678Z","end":"2026-05-30T01:44:38.662908Z","steps":["trace[2145230213] 'process raft request' (duration: 395.416482ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.663025Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.266772Z","time spent":"396.213119ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.663516Z","caller":"traceutil/trace.go:171","msg":"trace[2054026881] transaction","detail":"{read_only:false; response_revision:538; number_of_response:1; }","duration":"387.291887ms","start":"2026-05-30T01:44:38.276211Z","end":"2026-05-30T01:44:38.663503Z","steps":["trace[2054026881] 'process raft request' (duration: 386.260457ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.663566Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.276192Z","time spent":"387.353647ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.663851Z","caller":"traceutil/trace.go:171","msg":"trace[2099211807] transaction","detail":"{read_only:false; response_revision:539; number_of_response:1; }","duration":"381.07084ms","start":"2026-05-30T01:44:38.282756Z","end":"2026-05-30T01:44:38.663827Z","steps":["trace[2099211807] 'process raft request' (duration: 380.535635ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.664008Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.282737Z","time spent":"381.166051ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.664614Z","caller":"traceutil/trace.go:171","msg":"trace[2129508404] transaction","detail":"{read_only:false; response_revision:540; number_of_response:1; }","duration":"361.220439ms","start":"2026-05-30T01:44:38.303374Z","end":"2026-05-30T01:44:38.664594Z","steps":["trace[2129508404] 'process raft request' (duration: 360.263641ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:38.664821Z","caller":"traceutil/trace.go:171","msg":"trace[368883087] linearizableReadLoop","detail":"{readStateIndex:558; appliedIndex:547; }","duration":"307.110645ms","start":"2026-05-30T01:44:38.357695Z","end":"2026-05-30T01:44:38.664805Z","steps":["trace[368883087] 'read index received' (duration: 296.681549ms)","trace[368883087] 'applied index is now lower than readState.Index' (duration: 10.425346ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:44:38.664961Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.251827ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:44:38.665054Z","caller":"traceutil/trace.go:171","msg":"trace[2109848729] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:542; }","duration":"307.375118ms","start":"2026-05-30T01:44:38.357661Z","end":"2026-05-30T01:44:38.665036Z","steps":["trace[2109848729] 'agreement among raft nodes before linearized reading' (duration: 307.218026ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:38.665091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.357649Z","time spent":"307.432618ms","remote":"127.0.0.1:41648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T01:44:38.664986Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:38.303357Z","time spent":"361.438882ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-05-30T01:44:38.665339Z","caller":"traceutil/trace.go:171","msg":"trace[260307053] transaction","detail":"{read_only:false; response_revision:541; number_of_response:1; }","duration":"266.367102ms","start":"2026-05-30T01:44:38.398957Z","end":"2026-05-30T01:44:38.665324Z","steps":["trace[260307053] 'process raft request' (duration: 265.04059ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:40.615218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.95245ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-05-30T01:44:40.61554Z","caller":"traceutil/trace.go:171","msg":"trace[1612234178] linearizableReadLoop","detail":"{readStateIndex:630; appliedIndex:629; }","duration":"651.550186ms","start":"2026-05-30T01:44:39.963947Z","end":"2026-05-30T01:44:40.615497Z","steps":["trace[1612234178] 'read index received' (duration: 286.274243ms)","trace[1612234178] 'applied index is now lower than readState.Index' (duration: 365.271903ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:40.615601Z","caller":"traceutil/trace.go:171","msg":"trace[516584467] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"625.043355ms","start":"2026-05-30T01:44:39.990546Z","end":"2026-05-30T01:44:40.61559Z","steps":["trace[516584467] 'process raft request' (duration: 624.843874ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:40.615674Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:39.990527Z","time spent":"625.096876ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":208470,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:44:40.615805Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"651.845288ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" ","response":"range_response_count:1 size:9149"} {"level":"info","ts":"2026-05-30T01:44:40.615873Z","caller":"traceutil/trace.go:171","msg":"trace[2043381925] range","detail":"{range_begin:/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io; range_end:; response_count:1; response_revision:608; }","duration":"651.930528ms","start":"2026-05-30T01:44:39.963918Z","end":"2026-05-30T01:44:40.615848Z","steps":["trace[2043381925] 'agreement among raft nodes before linearized reading' (duration: 651.714887ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:40.615931Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:39.963904Z","time spent":"652.0154ms","remote":"127.0.0.1:41704","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":9172,"request content":"key:\"/registry/apiextensions.k8s.io/customresourcedefinitions/xmeshes.gateway.networking.x-k8s.io\" "} {"level":"warn","ts":"2026-05-30T01:44:40.616082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.490754ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:44:40.616121Z","caller":"traceutil/trace.go:171","msg":"trace[2075245494] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:608; }","duration":"264.553965ms","start":"2026-05-30T01:44:40.351554Z","end":"2026-05-30T01:44:40.616108Z","steps":["trace[2075245494] 'agreement among raft nodes before linearized reading' (duration: 264.497795ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:45.439204Z","caller":"traceutil/trace.go:171","msg":"trace[1796394247] linearizableReadLoop","detail":"{readStateIndex:658; appliedIndex:657; }","duration":"364.796892ms","start":"2026-05-30T01:44:45.074369Z","end":"2026-05-30T01:44:45.439166Z","steps":["trace[1796394247] 'read index received' (duration: 363.829384ms)","trace[1796394247] 'applied index is now lower than readState.Index' (duration: 966.388µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:45.439385Z","caller":"traceutil/trace.go:171","msg":"trace[2013816265] transaction","detail":"{read_only:false; response_revision:634; number_of_response:1; }","duration":"615.229591ms","start":"2026-05-30T01:44:44.824142Z","end":"2026-05-30T01:44:45.439371Z","steps":["trace[2013816265] 'process raft request' (duration: 614.354974ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:45.439513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:44.824111Z","time spent":"615.314063ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036265,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:44:45.439851Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.474778ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-30T01:44:45.439903Z","caller":"traceutil/trace.go:171","msg":"trace[1969104086] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:634; }","duration":"365.554938ms","start":"2026-05-30T01:44:45.074334Z","end":"2026-05-30T01:44:45.439889Z","steps":["trace[1969104086] 'agreement among raft nodes before linearized reading' (duration: 365.463917ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:45.439948Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:45.074321Z","time spent":"365.618179ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-30T01:44:45.440123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.55766ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-30T01:44:45.440359Z","caller":"traceutil/trace.go:171","msg":"trace[1225172205] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:634; }","duration":"187.834132ms","start":"2026-05-30T01:44:45.252502Z","end":"2026-05-30T01:44:45.440336Z","steps":["trace[1225172205] 'agreement among raft nodes before linearized reading' (duration: 187.151476ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:46.197342Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151400270563709,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T01:44:46.630014Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.132113214s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T01:44:46.650607Z","caller":"traceutil/trace.go:171","msg":"trace[1278898289] linearizableReadLoop","detail":"{readStateIndex:662; appliedIndex:661; }","duration":"954.308448ms","start":"2026-05-30T01:44:45.696265Z","end":"2026-05-30T01:44:46.650573Z","steps":["trace[1278898289] 'read index received' (duration: 933.87697ms)","trace[1278898289] 'applied index is now lower than readState.Index' (duration: 20.429908ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:46.650759Z","caller":"traceutil/trace.go:171","msg":"trace[1882750870] transaction","detail":"{read_only:false; response_revision:638; number_of_response:1; }","duration":"1.152931676s","start":"2026-05-30T01:44:45.497811Z","end":"2026-05-30T01:44:46.650742Z","steps":["trace[1882750870] 'process raft request' (duration: 1.132549518s)","trace[1882750870] 'compare' (duration: 19.50248ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:44:46.650873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:45.497782Z","time spent":"1.153021706s","remote":"127.0.0.1:40404","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1087,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-05-30T01:44:46.651455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.232486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-30T01:44:46.651593Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"954.927383ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-30T01:44:46.651565Z","caller":"traceutil/trace.go:171","msg":"trace[1590778479] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:638; }","duration":"954.390738ms","start":"2026-05-30T01:44:45.697152Z","end":"2026-05-30T01:44:46.651543Z","steps":["trace[1590778479] 'agreement among raft nodes before linearized reading' (duration: 954.148636ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:46.651683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"301.489373ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:44:46.651663Z","caller":"traceutil/trace.go:171","msg":"trace[167067502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:638; }","duration":"955.439287ms","start":"2026-05-30T01:44:45.696203Z","end":"2026-05-30T01:44:46.651643Z","steps":["trace[167067502] 'agreement among raft nodes before linearized reading' (duration: 954.895532ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:46.651867Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:45.696175Z","time spent":"955.67181ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-30T01:44:46.651933Z","caller":"traceutil/trace.go:171","msg":"trace[967971351] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:638; }","duration":"301.728576ms","start":"2026-05-30T01:44:46.350089Z","end":"2026-05-30T01:44:46.651818Z","steps":["trace[967971351] 'agreement among raft nodes before linearized reading' (duration: 301.404033ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:46.652048Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:46.350067Z","time spent":"301.963828ms","remote":"127.0.0.1:41648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T01:44:46.65187Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:45.697142Z","time spent":"954.611889ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-30T01:44:47.094249Z","caller":"traceutil/trace.go:171","msg":"trace[758679935] linearizableReadLoop","detail":"{readStateIndex:664; appliedIndex:662; }","duration":"433.037842ms","start":"2026-05-30T01:44:46.661183Z","end":"2026-05-30T01:44:47.09422Z","steps":["trace[758679935] 'read index received' (duration: 83.389605ms)","trace[758679935] 'applied index is now lower than readState.Index' (duration: 349.647187ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:44:47.09438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"433.184103ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:44:47.094415Z","caller":"traceutil/trace.go:171","msg":"trace[1291393785] range","detail":"{range_begin:/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system; range_end:; response_count:0; response_revision:640; }","duration":"433.230834ms","start":"2026-05-30T01:44:46.661173Z","end":"2026-05-30T01:44:47.094404Z","steps":["trace[1291393785] 'agreement among raft nodes before linearized reading' (duration: 433.141993ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:47.094828Z","caller":"traceutil/trace.go:171","msg":"trace[1250791854] transaction","detail":"{read_only:false; response_revision:640; number_of_response:1; }","duration":"437.811125ms","start":"2026-05-30T01:44:46.65685Z","end":"2026-05-30T01:44:47.094661Z","steps":["trace[1250791854] 'process raft request' (duration: 393.725524ms)","trace[1250791854] 'compare' (duration: 43.289115ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:44:47.094468Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:46.661136Z","time spent":"433.317686ms","remote":"127.0.0.1:40568","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":0,"response size":28,"request content":"key:\"/registry/mutatingwebhookconfigurations/envoy-gateway-topology-injector.envoy-gateway-system\" "} {"level":"warn","ts":"2026-05-30T01:44:47.094907Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:46.656836Z","time spent":"438.024647ms","remote":"127.0.0.1:40290","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-05-30T01:44:48.27947Z","caller":"traceutil/trace.go:171","msg":"trace[2000996334] transaction","detail":"{read_only:false; response_revision:650; number_of_response:1; }","duration":"199.996501ms","start":"2026-05-30T01:44:48.079425Z","end":"2026-05-30T01:44:48.279421Z","steps":["trace[2000996334] 'process raft request' (duration: 199.333186ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:48.638052Z","caller":"traceutil/trace.go:171","msg":"trace[1836107559] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"212.846772ms","start":"2026-05-30T01:44:48.425175Z","end":"2026-05-30T01:44:48.638022Z","steps":["trace[1836107559] 'process raft request' (duration: 176.124197ms)","trace[1836107559] 'compare' (duration: 36.538014ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:48.645317Z","caller":"traceutil/trace.go:171","msg":"trace[1673249734] transaction","detail":"{read_only:false; response_revision:654; number_of_response:1; }","duration":"175.40316ms","start":"2026-05-30T01:44:48.469892Z","end":"2026-05-30T01:44:48.645295Z","steps":["trace[1673249734] 'process raft request' (duration: 175.30116ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:48.847991Z","caller":"traceutil/trace.go:171","msg":"trace[1664584861] transaction","detail":"{read_only:false; response_revision:655; number_of_response:1; }","duration":"198.305766ms","start":"2026-05-30T01:44:48.649637Z","end":"2026-05-30T01:44:48.847942Z","steps":["trace[1664584861] 'process raft request' (duration: 155.632879ms)","trace[1664584861] 'compare' (duration: 42.432656ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:48.848042Z","caller":"traceutil/trace.go:171","msg":"trace[1677722965] transaction","detail":"{read_only:false; response_revision:656; number_of_response:1; }","duration":"197.794052ms","start":"2026-05-30T01:44:48.650229Z","end":"2026-05-30T01:44:48.848023Z","steps":["trace[1677722965] 'process raft request' (duration: 197.627121ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:48.848447Z","caller":"traceutil/trace.go:171","msg":"trace[814700506] transaction","detail":"{read_only:false; response_revision:658; number_of_response:1; }","duration":"195.512433ms","start":"2026-05-30T01:44:48.652916Z","end":"2026-05-30T01:44:48.848428Z","steps":["trace[814700506] 'process raft request' (duration: 195.076469ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:48.848711Z","caller":"traceutil/trace.go:171","msg":"trace[1473046177] transaction","detail":"{read_only:false; response_revision:657; number_of_response:1; }","duration":"198.188416ms","start":"2026-05-30T01:44:48.650412Z","end":"2026-05-30T01:44:48.8486Z","steps":["trace[1473046177] 'process raft request' (duration: 197.50775ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:49.423743Z","caller":"traceutil/trace.go:171","msg":"trace[1310876718] transaction","detail":"{read_only:false; response_revision:661; number_of_response:1; }","duration":"277.94215ms","start":"2026-05-30T01:44:49.145772Z","end":"2026-05-30T01:44:49.423714Z","steps":["trace[1310876718] 'process raft request' (duration: 272.665425ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:44:50.003975Z","caller":"traceutil/trace.go:171","msg":"trace[19996896] linearizableReadLoop","detail":"{readStateIndex:688; appliedIndex:687; }","duration":"519.714281ms","start":"2026-05-30T01:44:49.48423Z","end":"2026-05-30T01:44:50.003945Z","steps":["trace[19996896] 'read index received' (duration: 455.35957ms)","trace[19996896] 'applied index is now lower than readState.Index' (duration: 64.353691ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:44:50.004101Z","caller":"traceutil/trace.go:171","msg":"trace[1871029861] transaction","detail":"{read_only:false; response_revision:664; number_of_response:1; }","duration":"525.044337ms","start":"2026-05-30T01:44:49.479029Z","end":"2026-05-30T01:44:50.004073Z","steps":["trace[1871029861] 'process raft request' (duration: 460.505233ms)","trace[1871029861] 'compare' (duration: 64.09579ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:44:50.004162Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.923563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"warn","ts":"2026-05-30T01:44:50.004229Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:49.479013Z","time spent":"525.154547ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:44:50.004264Z","caller":"traceutil/trace.go:171","msg":"trace[115888414] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:664; }","duration":"519.971294ms","start":"2026-05-30T01:44:49.484215Z","end":"2026-05-30T01:44:50.004187Z","steps":["trace[115888414] 'agreement among raft nodes before linearized reading' (duration: 519.828083ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:44:50.004314Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:44:49.484156Z","time spent":"520.146434ms","remote":"127.0.0.1:40290","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-05-30T01:44:51.15158Z","caller":"traceutil/trace.go:171","msg":"trace[1678225230] transaction","detail":"{read_only:false; response_revision:693; number_of_response:1; }","duration":"171.573717ms","start":"2026-05-30T01:44:50.979987Z","end":"2026-05-30T01:44:51.151561Z","steps":["trace[1678225230] 'process raft request' (duration: 171.467576ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:05.235636Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"397.609004ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:45:05.235716Z","caller":"traceutil/trace.go:171","msg":"trace[1219823137] range","detail":"{range_begin:/registry/resourcequotas/; range_end:/registry/resourcequotas0; response_count:0; response_revision:811; }","duration":"397.732216ms","start":"2026-05-30T01:45:04.837956Z","end":"2026-05-30T01:45:05.235688Z","steps":["trace[1219823137] 'count revisions from in-memory index tree' (duration: 397.518023ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:05.235741Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:04.837935Z","time spent":"397.799417ms","remote":"127.0.0.1:41746","response type":"/etcdserverpb.KV/Range","request count":0,"request size":56,"response count":0,"response size":28,"request content":"key:\"/registry/resourcequotas/\" range_end:\"/registry/resourcequotas0\" count_only:true "} {"level":"warn","ts":"2026-05-30T01:45:05.235728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"498.106184ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T01:45:05.235798Z","caller":"traceutil/trace.go:171","msg":"trace[1771139070] range","detail":"{range_begin:/registry/configmaps/; range_end:/registry/configmaps0; response_count:0; response_revision:811; }","duration":"498.230095ms","start":"2026-05-30T01:45:04.737553Z","end":"2026-05-30T01:45:05.235783Z","steps":["trace[1771139070] 'count revisions from in-memory index tree' (duration: 497.979683ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:05.235849Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:04.737542Z","time spent":"498.296355ms","remote":"127.0.0.1:41764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":48,"response count":13,"response size":30,"request content":"key:\"/registry/configmaps/\" range_end:\"/registry/configmaps0\" count_only:true "} {"level":"warn","ts":"2026-05-30T01:45:05.235728Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.383795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-30T01:45:05.236033Z","caller":"traceutil/trace.go:171","msg":"trace[1616378575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:811; }","duration":"227.631596ms","start":"2026-05-30T01:45:05.008302Z","end":"2026-05-30T01:45:05.235933Z","steps":["trace[1616378575] 'range keys from in-memory index tree' (duration: 227.237232ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:25.577005Z","caller":"traceutil/trace.go:171","msg":"trace[318453524] transaction","detail":"{read_only:false; response_revision:1159; number_of_response:1; }","duration":"180.327333ms","start":"2026-05-30T01:45:25.396649Z","end":"2026-05-30T01:45:25.576976Z","steps":["trace[318453524] 'process raft request' (duration: 180.179377ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:25.625433Z","caller":"traceutil/trace.go:171","msg":"trace[2102735690] transaction","detail":"{read_only:false; response_revision:1160; number_of_response:1; }","duration":"227.445654ms","start":"2026-05-30T01:45:25.397975Z","end":"2026-05-30T01:45:25.62542Z","steps":["trace[2102735690] 'process raft request' (duration: 227.374261ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:26.861745Z","caller":"traceutil/trace.go:171","msg":"trace[990466440] transaction","detail":"{read_only:false; response_revision:1168; number_of_response:1; }","duration":"184.283215ms","start":"2026-05-30T01:45:26.677445Z","end":"2026-05-30T01:45:26.861728Z","steps":["trace[990466440] 'process raft request' (duration: 184.170251ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:26.957326Z","caller":"traceutil/trace.go:171","msg":"trace[1997223942] transaction","detail":"{read_only:false; response_revision:1169; number_of_response:1; }","duration":"277.943308ms","start":"2026-05-30T01:45:26.679357Z","end":"2026-05-30T01:45:26.9573Z","steps":["trace[1997223942] 'process raft request' (duration: 277.78056ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:27.070975Z","caller":"traceutil/trace.go:171","msg":"trace[1529019133] linearizableReadLoop","detail":"{readStateIndex:1205; appliedIndex:1203; }","duration":"188.124777ms","start":"2026-05-30T01:45:26.882826Z","end":"2026-05-30T01:45:27.07095Z","steps":["trace[1529019133] 'read index received' (duration: 74.326848ms)","trace[1529019133] 'applied index is now lower than readState.Index' (duration: 113.796979ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:45:27.071021Z","caller":"traceutil/trace.go:171","msg":"trace[501179967] transaction","detail":"{read_only:false; response_revision:1170; number_of_response:1; }","duration":"201.819351ms","start":"2026-05-30T01:45:26.869178Z","end":"2026-05-30T01:45:27.070997Z","steps":["trace[501179967] 'process raft request' (duration: 199.994364ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:27.071093Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"188.241372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:45:27.07113Z","caller":"traceutil/trace.go:171","msg":"trace[2049486845] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:0; response_revision:1170; }","duration":"188.314045ms","start":"2026-05-30T01:45:26.882803Z","end":"2026-05-30T01:45:27.071117Z","steps":["trace[2049486845] 'agreement among raft nodes before linearized reading' (duration: 188.235941ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:27.235864Z","caller":"traceutil/trace.go:171","msg":"trace[938453253] transaction","detail":"{read_only:false; response_revision:1171; number_of_response:1; }","duration":"160.357771ms","start":"2026-05-30T01:45:27.075479Z","end":"2026-05-30T01:45:27.235837Z","steps":["trace[938453253] 'process raft request' (duration: 104.787538ms)","trace[938453253] 'compare' (duration: 55.430176ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:45:27.421651Z","caller":"traceutil/trace.go:171","msg":"trace[757647336] transaction","detail":"{read_only:false; response_revision:1172; number_of_response:1; }","duration":"180.134053ms","start":"2026-05-30T01:45:27.241494Z","end":"2026-05-30T01:45:27.421629Z","steps":["trace[757647336] 'process raft request' (duration: 179.978237ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:27.485056Z","caller":"traceutil/trace.go:171","msg":"trace[754934273] transaction","detail":"{read_only:false; response_revision:1173; number_of_response:1; }","duration":"242.334975ms","start":"2026-05-30T01:45:27.242691Z","end":"2026-05-30T01:45:27.485026Z","steps":["trace[754934273] 'process raft request' (duration: 242.154598ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:28.451987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.037041ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:45:28.452065Z","caller":"traceutil/trace.go:171","msg":"trace[1153272700] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1176; }","duration":"100.158025ms","start":"2026-05-30T01:45:28.351889Z","end":"2026-05-30T01:45:28.452047Z","steps":["trace[1153272700] 'range keys from in-memory index tree' (duration: 99.950197ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:28.735373Z","caller":"traceutil/trace.go:171","msg":"trace[1918568987] transaction","detail":"{read_only:false; response_revision:1178; number_of_response:1; }","duration":"278.362204ms","start":"2026-05-30T01:45:28.456994Z","end":"2026-05-30T01:45:28.735356Z","steps":["trace[1918568987] 'process raft request' (duration: 278.232919ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:29.12661Z","caller":"traceutil/trace.go:171","msg":"trace[1236743999] transaction","detail":"{read_only:false; response_revision:1180; number_of_response:1; }","duration":"165.572525ms","start":"2026-05-30T01:45:28.961002Z","end":"2026-05-30T01:45:29.126575Z","steps":["trace[1236743999] 'process raft request' (duration: 163.528401ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:45:41.330837Z","caller":"traceutil/trace.go:171","msg":"trace[947382765] transaction","detail":"{read_only:false; response_revision:1244; number_of_response:1; }","duration":"161.208373ms","start":"2026-05-30T01:45:41.169599Z","end":"2026-05-30T01:45:41.330807Z","steps":["trace[947382765] 'process raft request' (duration: 161.064518ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:42.634868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.932856ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:558"} {"level":"info","ts":"2026-05-30T01:45:42.634962Z","caller":"traceutil/trace.go:171","msg":"trace[1363234883] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:1244; }","duration":"146.079491ms","start":"2026-05-30T01:45:42.488864Z","end":"2026-05-30T01:45:42.634943Z","steps":["trace[1363234883] 'range keys from in-memory index tree' (duration: 145.7665ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:42.635152Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"751.252426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:45:42.635202Z","caller":"traceutil/trace.go:171","msg":"trace[801137358] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/udproutes/; range_end:/registry/gateway.networking.k8s.io/udproutes0; response_count:0; response_revision:1244; }","duration":"751.34603ms","start":"2026-05-30T01:45:41.883838Z","end":"2026-05-30T01:45:42.635184Z","steps":["trace[801137358] 'count revisions from in-memory index tree' (duration: 751.124192ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:42.635234Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:41.883809Z","time spent":"751.416632ms","remote":"127.0.0.1:57040","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/udproutes/\" range_end:\"/registry/gateway.networking.k8s.io/udproutes0\" count_only:true "} {"level":"warn","ts":"2026-05-30T01:45:42.635497Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"846.509789ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-30T01:45:42.635556Z","caller":"traceutil/trace.go:171","msg":"trace[2087070870] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1244; }","duration":"846.635983ms","start":"2026-05-30T01:45:41.788904Z","end":"2026-05-30T01:45:42.63554Z","steps":["trace[2087070870] 'range keys from in-memory index tree' (duration: 846.368444ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:42.635612Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:41.788883Z","time spent":"846.703826ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T01:45:42.635654Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"830.79886ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-30T01:45:42.635956Z","caller":"traceutil/trace.go:171","msg":"trace[1956185013] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1244; }","duration":"831.09643ms","start":"2026-05-30T01:45:41.804787Z","end":"2026-05-30T01:45:42.635883Z","steps":["trace[1956185013] 'range keys from in-memory index tree' (duration: 830.590412ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:42.636117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:45:41.804768Z","time spent":"831.327149ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T01:45:42.63487Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.087288ms","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-05-30T01:45:42.636281Z","caller":"traceutil/trace.go:171","msg":"trace[604731455] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1244; }","duration":"281.53882ms","start":"2026-05-30T01:45:42.354717Z","end":"2026-05-30T01:45:42.636256Z","steps":["trace[604731455] 'range keys from in-memory index tree' (duration: 279.909112ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:45:58.453715Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.90668ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:45:58.453891Z","caller":"traceutil/trace.go:171","msg":"trace[1889739204] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1379; }","duration":"101.085875ms","start":"2026-05-30T01:45:58.352738Z","end":"2026-05-30T01:45:58.453823Z","steps":["trace[1889739204] 'range keys from in-memory index tree' (duration: 100.823057ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:05.119469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.132289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-30T01:46:05.119577Z","caller":"traceutil/trace.go:171","msg":"trace[1787848473] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1512; }","duration":"218.267073ms","start":"2026-05-30T01:46:04.901286Z","end":"2026-05-30T01:46:05.119553Z","steps":["trace[1787848473] 'range keys from in-memory index tree' (duration: 217.916184ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.197135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.008783ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:46:31.197334Z","caller":"traceutil/trace.go:171","msg":"trace[581328311] linearizableReadLoop","detail":"{readStateIndex:1999; appliedIndex:1997; }","duration":"332.886068ms","start":"2026-05-30T01:46:30.864427Z","end":"2026-05-30T01:46:31.197313Z","steps":["trace[581328311] 'read index received' (duration: 313.245952ms)","trace[581328311] 'applied index is now lower than readState.Index' (duration: 19.638726ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:31.197609Z","caller":"traceutil/trace.go:171","msg":"trace[458858043] transaction","detail":"{read_only:false; response_revision:1924; number_of_response:1; }","duration":"642.585079ms","start":"2026-05-30T01:46:30.554949Z","end":"2026-05-30T01:46:31.197534Z","steps":["trace[458858043] 'process raft request' (duration: 642.293931ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.197718Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.212263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-30T01:46:31.197771Z","caller":"traceutil/trace.go:171","msg":"trace[1425794410] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1924; }","duration":"279.296625ms","start":"2026-05-30T01:46:30.918457Z","end":"2026-05-30T01:46:31.197753Z","steps":["trace[1425794410] 'agreement among raft nodes before linearized reading' (duration: 279.094351ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.197773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"223.665005ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-30T01:46:31.197804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"274.593586ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77aa2395-9ea0-41f6-a51f-4eaaf3bd4a17\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-05-30T01:46:31.197851Z","caller":"traceutil/trace.go:171","msg":"trace[1911652564] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1924; }","duration":"223.821689ms","start":"2026-05-30T01:46:30.974017Z","end":"2026-05-30T01:46:31.197839Z","steps":["trace[1911652564] 'agreement among raft nodes before linearized reading' (duration: 223.621975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.197868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"333.39689ms","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-05-30T01:46:31.197993Z","caller":"traceutil/trace.go:171","msg":"trace[1413835270] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1924; }","duration":"333.588534ms","start":"2026-05-30T01:46:30.864385Z","end":"2026-05-30T01:46:31.197974Z","steps":["trace[1413835270] 'agreement among raft nodes before linearized reading' (duration: 333.143654ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:31.198045Z","caller":"traceutil/trace.go:171","msg":"trace[1883675992] transaction","detail":"{read_only:false; response_revision:1923; number_of_response:1; }","duration":"727.387981ms","start":"2026-05-30T01:46:30.470622Z","end":"2026-05-30T01:46:31.19801Z","steps":["trace[1883675992] 'process raft request' (duration: 372.389726ms)","trace[1883675992] 'compare' (duration: 353.837579ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:31.197893Z","caller":"traceutil/trace.go:171","msg":"trace[2100641335] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-77aa2395-9ea0-41f6-a51f-4eaaf3bd4a17; range_end:; response_count:1; response_revision:1924; }","duration":"274.720008ms","start":"2026-05-30T01:46:30.92315Z","end":"2026-05-30T01:46:31.19787Z","steps":["trace[2100641335] 'agreement among raft nodes before linearized reading' (duration: 274.487883ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.198169Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:30.4706Z","time spent":"727.489164ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:46:31.198102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:30.864368Z","time spent":"333.714977ms","remote":"127.0.0.1:40290","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":"warn","ts":"2026-05-30T01:46:31.197883Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:30.554927Z","time spent":"642.818664ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:46:31.197803Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"227.835753ms","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-05-30T01:46:31.198676Z","caller":"traceutil/trace.go:171","msg":"trace[421084485] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1924; }","duration":"228.767014ms","start":"2026-05-30T01:46:30.969893Z","end":"2026-05-30T01:46:31.19866Z","steps":["trace[421084485] 'agreement among raft nodes before linearized reading' (duration: 227.733701ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.835779Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"414.088769ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:46:31.836253Z","caller":"traceutil/trace.go:171","msg":"trace[1768084875] transaction","detail":"{read_only:false; response_revision:1927; number_of_response:1; }","duration":"631.978495ms","start":"2026-05-30T01:46:31.204258Z","end":"2026-05-30T01:46:31.836236Z","steps":["trace[1768084875] 'process raft request' (duration: 631.710199ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.836351Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.204249Z","time spent":"632.071657ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:46:31.836457Z","caller":"traceutil/trace.go:171","msg":"trace[1531182536] transaction","detail":"{read_only:false; response_revision:1928; number_of_response:1; }","duration":"631.615016ms","start":"2026-05-30T01:46:31.204808Z","end":"2026-05-30T01:46:31.836423Z","steps":["trace[1531182536] 'process raft request' (duration: 631.270809ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:31.836503Z","caller":"traceutil/trace.go:171","msg":"trace[994551669] transaction","detail":"{read_only:false; response_revision:1926; number_of_response:1; }","duration":"633.282354ms","start":"2026-05-30T01:46:31.203189Z","end":"2026-05-30T01:46:31.836471Z","steps":["trace[994551669] 'process raft request' (duration: 218.425048ms)","trace[994551669] 'compare' (duration: 413.867664ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:31.836592Z","caller":"traceutil/trace.go:171","msg":"trace[1424509062] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"630.670864ms","start":"2026-05-30T01:46:31.20591Z","end":"2026-05-30T01:46:31.836581Z","steps":["trace[1424509062] 'process raft request' (duration: 630.208554ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.836706Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.203181Z","time spent":"633.397387ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:46:31.836641Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.204799Z","time spent":"631.736909ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:46:31.836527Z","caller":"traceutil/trace.go:171","msg":"trace[2023190986] linearizableReadLoop","detail":"{readStateIndex:2004; appliedIndex:2000; }","duration":"576.701242ms","start":"2026-05-30T01:46:31.259803Z","end":"2026-05-30T01:46:31.836504Z","steps":["trace[2023190986] 'read index received' (duration: 161.871216ms)","trace[2023190986] 'applied index is now lower than readState.Index' (duration: 414.829106ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:31.836742Z","caller":"traceutil/trace.go:171","msg":"trace[830879518] transaction","detail":"{read_only:false; response_revision:1930; number_of_response:1; }","duration":"253.37862ms","start":"2026-05-30T01:46:31.583352Z","end":"2026-05-30T01:46:31.83673Z","steps":["trace[830879518] 'process raft request' (duration: 253.077893ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.836902Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"577.105802ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-30T01:46:31.836974Z","caller":"traceutil/trace.go:171","msg":"trace[1790898537] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1930; }","duration":"577.222805ms","start":"2026-05-30T01:46:31.259742Z","end":"2026-05-30T01:46:31.836965Z","steps":["trace[1790898537] 'agreement among raft nodes before linearized reading' (duration: 576.819865ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.837022Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.259716Z","time spent":"577.298567ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T01:46:31.836951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.205901Z","time spent":"630.726135ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:46:31.861885Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.201713ms","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-05-30T01:46:31.861961Z","caller":"traceutil/trace.go:171","msg":"trace[1025992685] transaction","detail":"{read_only:false; response_revision:1931; number_of_response:1; }","duration":"278.053743ms","start":"2026-05-30T01:46:31.583876Z","end":"2026-05-30T01:46:31.86193Z","steps":["trace[1025992685] 'process raft request' (duration: 277.272474ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:31.862012Z","caller":"traceutil/trace.go:171","msg":"trace[581453041] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1932; }","duration":"511.375007ms","start":"2026-05-30T01:46:31.35062Z","end":"2026-05-30T01:46:31.861995Z","steps":["trace[581453041] 'agreement among raft nodes before linearized reading' (duration: 511.10571ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.862089Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.350599Z","time spent":"511.480199ms","remote":"127.0.0.1:54822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-30T01:46:31.862347Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"511.209393ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T01:46:31.862366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"416.018554ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77aa2395-9ea0-41f6-a51f-4eaaf3bd4a17\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-05-30T01:46:31.862396Z","caller":"traceutil/trace.go:171","msg":"trace[2113830062] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1932; }","duration":"511.313565ms","start":"2026-05-30T01:46:31.351075Z","end":"2026-05-30T01:46:31.862389Z","steps":["trace[2113830062] 'agreement among raft nodes before linearized reading' (duration: 511.246343ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.862462Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.351052Z","time spent":"511.402846ms","remote":"127.0.0.1:41648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T01:46:31.86252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"279.911214ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:31.862453Z","caller":"traceutil/trace.go:171","msg":"trace[1053499388] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-77aa2395-9ea0-41f6-a51f-4eaaf3bd4a17; range_end:; response_count:1; response_revision:1932; }","duration":"416.138817ms","start":"2026-05-30T01:46:31.446279Z","end":"2026-05-30T01:46:31.862418Z","steps":["trace[1053499388] 'agreement among raft nodes before linearized reading' (duration: 416.013034ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:31.86257Z","caller":"traceutil/trace.go:171","msg":"trace[823511724] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:1932; }","duration":"280.001008ms","start":"2026-05-30T01:46:31.582557Z","end":"2026-05-30T01:46:31.862558Z","steps":["trace[823511724] 'agreement among raft nodes before linearized reading' (duration: 279.924765ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:31.862601Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:31.446257Z","time spent":"416.333421ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3766,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-77aa2395-9ea0-41f6-a51f-4eaaf3bd4a17\" "} {"level":"warn","ts":"2026-05-30T01:46:31.862463Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.875236ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/runtimeclasses/\" range_end:\"/registry/runtimeclasses0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:31.862752Z","caller":"traceutil/trace.go:171","msg":"trace[1921342136] range","detail":"{range_begin:/registry/runtimeclasses/; range_end:/registry/runtimeclasses0; response_count:0; response_revision:1932; }","duration":"184.189324ms","start":"2026-05-30T01:46:31.67853Z","end":"2026-05-30T01:46:31.862719Z","steps":["trace[1921342136] 'agreement among raft nodes before linearized reading' (duration: 183.895127ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:36.444937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.651013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xmeshes/\" range_end:\"/registry/gateway.networking.x-k8s.io/xmeshes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:36.445Z","caller":"traceutil/trace.go:171","msg":"trace[870476774] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xmeshes/; range_end:/registry/gateway.networking.x-k8s.io/xmeshes0; response_count:0; response_revision:1977; }","duration":"104.750194ms","start":"2026-05-30T01:46:36.340236Z","end":"2026-05-30T01:46:36.444986Z","steps":["trace[870476774] 'count revisions from in-memory index tree' (duration: 104.561991ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:44.196653Z","caller":"traceutil/trace.go:171","msg":"trace[803278106] transaction","detail":"{read_only:false; response_revision:2033; number_of_response:1; }","duration":"214.174511ms","start":"2026-05-30T01:46:43.98245Z","end":"2026-05-30T01:46:44.196625Z","steps":["trace[803278106] 'process raft request' (duration: 207.45278ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:44.196829Z","caller":"traceutil/trace.go:171","msg":"trace[1128875997] transaction","detail":"{read_only:false; response_revision:2034; number_of_response:1; }","duration":"214.008078ms","start":"2026-05-30T01:46:43.982805Z","end":"2026-05-30T01:46:44.196813Z","steps":["trace[1128875997] 'process raft request' (duration: 213.766962ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:47.051557Z","caller":"traceutil/trace.go:171","msg":"trace[439661225] linearizableReadLoop","detail":"{readStateIndex:2138; appliedIndex:2137; }","duration":"102.097849ms","start":"2026-05-30T01:46:46.949441Z","end":"2026-05-30T01:46:47.051539Z","steps":["trace[439661225] 'read index received' (duration: 101.940956ms)","trace[439661225] 'applied index is now lower than readState.Index' (duration: 156.003µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:47.051657Z","caller":"traceutil/trace.go:171","msg":"trace[1243903480] transaction","detail":"{read_only:false; response_revision:2059; number_of_response:1; }","duration":"128.289276ms","start":"2026-05-30T01:46:46.923359Z","end":"2026-05-30T01:46:47.051648Z","steps":["trace[1243903480] 'process raft request' (duration: 128.057942ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:47.051899Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.445017ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/\" range_end:\"/registry/serviceaccounts0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T01:46:47.051923Z","caller":"traceutil/trace.go:171","msg":"trace[1357073862] range","detail":"{range_begin:/registry/serviceaccounts/; range_end:/registry/serviceaccounts0; response_count:0; response_revision:2059; }","duration":"102.527839ms","start":"2026-05-30T01:46:46.949388Z","end":"2026-05-30T01:46:47.051916Z","steps":["trace[1357073862] 'agreement among raft nodes before linearized reading' (duration: 102.438687ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:47.555794Z","caller":"traceutil/trace.go:171","msg":"trace[1617572325] linearizableReadLoop","detail":"{readStateIndex:2139; appliedIndex:2138; }","duration":"244.222533ms","start":"2026-05-30T01:46:47.311552Z","end":"2026-05-30T01:46:47.555774Z","steps":["trace[1617572325] 'read index received' (duration: 244.04766ms)","trace[1617572325] 'applied index is now lower than readState.Index' (duration: 173.653µs)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:46:47.555969Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"244.395939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-30T01:46:47.555999Z","caller":"traceutil/trace.go:171","msg":"trace[454806727] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2060; }","duration":"244.46912ms","start":"2026-05-30T01:46:47.31152Z","end":"2026-05-30T01:46:47.555989Z","steps":["trace[454806727] 'agreement among raft nodes before linearized reading' (duration: 244.338727ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:47.556128Z","caller":"traceutil/trace.go:171","msg":"trace[964000100] transaction","detail":"{read_only:false; response_revision:2060; number_of_response:1; }","duration":"306.862696ms","start":"2026-05-30T01:46:47.249216Z","end":"2026-05-30T01:46:47.556078Z","steps":["trace[964000100] 'process raft request' (duration: 306.440237ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:47.556299Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:47.249177Z","time spent":"307.018139ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:46:48.509203Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151400270566524,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T01:46:49.010357Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151400270566524,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-05-30T01:46:49.497679Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.508418961s","expected-duration":"1s"} {"level":"warn","ts":"2026-05-30T01:46:49.500393Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.511275761s","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-05-30T01:46:49.500439Z","caller":"traceutil/trace.go:171","msg":"trace[204677206] transaction","detail":"{read_only:false; response_revision:2062; number_of_response:1; }","duration":"1.511244578s","start":"2026-05-30T01:46:47.989171Z","end":"2026-05-30T01:46:49.500416Z","steps":["trace[204677206] 'process raft request' (duration: 1.508979932s)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:49.500471Z","caller":"traceutil/trace.go:171","msg":"trace[1271162918] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2061; }","duration":"1.511358832s","start":"2026-05-30T01:46:47.989092Z","end":"2026-05-30T01:46:49.500451Z","steps":["trace[1271162918] 'range keys from in-memory index tree' (duration: 1.511131478s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.500527Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:47.989048Z","time spent":"1.511469183s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T01:46:49.50055Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:47.989149Z","time spent":"1.511333292s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:46:49.500864Z","caller":"traceutil/trace.go:171","msg":"trace[934156020] linearizableReadLoop","detail":"{readStateIndex:2143; appliedIndex:2140; }","duration":"1.492140114s","start":"2026-05-30T01:46:48.008711Z","end":"2026-05-30T01:46:49.500851Z","steps":["trace[934156020] 'read index received' (duration: 1.489349346s)","trace[934156020] 'applied index is now lower than readState.Index' (duration: 2.789828ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:49.500903Z","caller":"traceutil/trace.go:171","msg":"trace[1229229385] transaction","detail":"{read_only:false; response_revision:2063; number_of_response:1; }","duration":"1.511652397s","start":"2026-05-30T01:46:47.989237Z","end":"2026-05-30T01:46:49.500889Z","steps":["trace[1229229385] 'process raft request' (duration: 1.511519825s)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:49.50094Z","caller":"traceutil/trace.go:171","msg":"trace[978007093] transaction","detail":"{read_only:false; response_revision:2064; number_of_response:1; }","duration":"986.701487ms","start":"2026-05-30T01:46:48.514229Z","end":"2026-05-30T01:46:49.50093Z","steps":["trace[978007093] 'process raft request' (duration: 986.588365ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.500993Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:47.989226Z","time spent":"1.511710998s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:46:49.501Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.514206Z","time spent":"986.760269ms","remote":"127.0.0.1:40290","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-05-30T01:46:49.501153Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"874.352667ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-30T01:46:49.501176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.442476667s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-05-30T01:46:49.501309Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.492602262s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-30T01:46:49.535046Z","caller":"traceutil/trace.go:171","msg":"trace[2120183437] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2064; }","duration":"1.526362645s","start":"2026-05-30T01:46:48.008675Z","end":"2026-05-30T01:46:49.535038Z","steps":["trace[2120183437] 'agreement among raft nodes before linearized reading' (duration: 1.492540721s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.535075Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.008655Z","time spent":"1.526412727s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T01:46:49.533633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"786.217473ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:11988"} {"level":"info","ts":"2026-05-30T01:46:49.535181Z","caller":"traceutil/trace.go:171","msg":"trace[1269130482] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:2064; }","duration":"787.788275ms","start":"2026-05-30T01:46:48.747372Z","end":"2026-05-30T01:46:49.53516Z","steps":["trace[1269130482] 'agreement among raft nodes before linearized reading' (duration: 786.196623ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.535221Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.747305Z","time spent":"787.904078ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12011,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-30T01:46:49.5337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.32367983s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-05-30T01:46:49.535367Z","caller":"traceutil/trace.go:171","msg":"trace[1749720656] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2064; }","duration":"1.325353964s","start":"2026-05-30T01:46:48.20999Z","end":"2026-05-30T01:46:49.535344Z","steps":["trace[1749720656] 'agreement among raft nodes before linearized reading' (duration: 1.323668649s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.535389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.209977Z","time spent":"1.325404776s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-05-30T01:46:49.53375Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.323729841s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-30T01:46:49.535467Z","caller":"traceutil/trace.go:171","msg":"trace[580844339] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2064; }","duration":"1.325472816s","start":"2026-05-30T01:46:48.20999Z","end":"2026-05-30T01:46:49.535463Z","steps":["trace[580844339] 'agreement among raft nodes before linearized reading' (duration: 1.323726561s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.535482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.209977Z","time spent":"1.325500027s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":513,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T01:46:49.533754Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181392643s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:49.535547Z","caller":"traceutil/trace.go:171","msg":"trace[113257873] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2064; }","duration":"1.1832387s","start":"2026-05-30T01:46:48.352304Z","end":"2026-05-30T01:46:49.535543Z","steps":["trace[113257873] 'agreement among raft nodes before linearized reading' (duration: 1.181404772s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.535562Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.352285Z","time spent":"1.183273521s","remote":"127.0.0.1:41648","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-05-30T01:46:49.50119Z","caller":"traceutil/trace.go:171","msg":"trace[1677446588] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2064; }","duration":"874.423999ms","start":"2026-05-30T01:46:48.626757Z","end":"2026-05-30T01:46:49.501181Z","steps":["trace[1677446588] 'agreement among raft nodes before linearized reading' (duration: 874.312607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.53568Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.626735Z","time spent":"908.935937ms","remote":"127.0.0.1:54822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-30T01:46:49.535876Z","caller":"traceutil/trace.go:171","msg":"trace[2106266811] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2064; }","duration":"1.442664201s","start":"2026-05-30T01:46:48.058648Z","end":"2026-05-30T01:46:49.501312Z","steps":["trace[2106266811] 'agreement among raft nodes before linearized reading' (duration: 1.442391485s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.535911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:46:48.05863Z","time spent":"1.47727196s","remote":"127.0.0.1:54822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"info","ts":"2026-05-30T01:46:49.663974Z","caller":"traceutil/trace.go:171","msg":"trace[1264915646] linearizableReadLoop","detail":"{readStateIndex:2144; appliedIndex:2143; }","duration":"126.273902ms","start":"2026-05-30T01:46:49.53767Z","end":"2026-05-30T01:46:49.663944Z","steps":["trace[1264915646] 'read index received' (duration: 125.079187ms)","trace[1264915646] 'applied index is now lower than readState.Index' (duration: 1.193224ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:46:49.664044Z","caller":"traceutil/trace.go:171","msg":"trace[1198061076] transaction","detail":"{read_only:false; response_revision:2065; number_of_response:1; }","duration":"126.441405ms","start":"2026-05-30T01:46:49.537578Z","end":"2026-05-30T01:46:49.664019Z","steps":["trace[1198061076] 'process raft request' (duration: 125.169599ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.664146Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.447845ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:49.664186Z","caller":"traceutil/trace.go:171","msg":"trace[1079289141] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2065; }","duration":"126.535626ms","start":"2026-05-30T01:46:49.537639Z","end":"2026-05-30T01:46:49.664175Z","steps":["trace[1079289141] 'agreement among raft nodes before linearized reading' (duration: 126.437924ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:46:49.665558Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.387372ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:46:49.665618Z","caller":"traceutil/trace.go:171","msg":"trace[992458596] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:2069; }","duration":"124.476384ms","start":"2026-05-30T01:46:49.541129Z","end":"2026-05-30T01:46:49.665605Z","steps":["trace[992458596] 'agreement among raft nodes before linearized reading' (duration: 124.369032ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:49.665752Z","caller":"traceutil/trace.go:171","msg":"trace[1948672998] transaction","detail":"{read_only:false; response_revision:2067; number_of_response:1; }","duration":"127.616508ms","start":"2026-05-30T01:46:49.53812Z","end":"2026-05-30T01:46:49.665736Z","steps":["trace[1948672998] 'process raft request' (duration: 127.257961ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:49.665828Z","caller":"traceutil/trace.go:171","msg":"trace[1661773878] transaction","detail":"{read_only:false; response_revision:2068; number_of_response:1; }","duration":"126.638347ms","start":"2026-05-30T01:46:49.539178Z","end":"2026-05-30T01:46:49.665816Z","steps":["trace[1661773878] 'process raft request' (duration: 126.25142ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:49.665868Z","caller":"traceutil/trace.go:171","msg":"trace[616122224] transaction","detail":"{read_only:false; response_revision:2066; number_of_response:1; }","duration":"128.102619ms","start":"2026-05-30T01:46:49.537736Z","end":"2026-05-30T01:46:49.665839Z","steps":["trace[616122224] 'process raft request' (duration: 127.559128ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:46:49.666088Z","caller":"traceutil/trace.go:171","msg":"trace[2091173520] transaction","detail":"{read_only:false; response_revision:2069; number_of_response:1; }","duration":"105.420742ms","start":"2026-05-30T01:46:49.560386Z","end":"2026-05-30T01:46:49.665807Z","steps":["trace[2091173520] 'process raft request' (duration: 105.076525ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.175937Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":988151400270566830,"retry-timeout":"500ms"} {"level":"info","ts":"2026-05-30T01:47:12.497084Z","caller":"traceutil/trace.go:171","msg":"trace[2105057212] transaction","detail":"{read_only:false; response_revision:2186; number_of_response:1; }","duration":"889.198303ms","start":"2026-05-30T01:47:11.607862Z","end":"2026-05-30T01:47:12.49706Z","steps":["trace[2105057212] 'process raft request' (duration: 889.03856ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.497222Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.607831Z","time spent":"889.323195ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:47:12.49745Z","caller":"traceutil/trace.go:171","msg":"trace[1140537786] transaction","detail":"{read_only:false; response_revision:2187; number_of_response:1; }","duration":"887.920659ms","start":"2026-05-30T01:47:11.609274Z","end":"2026-05-30T01:47:12.497194Z","steps":["trace[1140537786] 'process raft request' (duration: 887.748816ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.497802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.609255Z","time spent":"888.272527ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:47:12.861289Z","caller":"traceutil/trace.go:171","msg":"trace[1044887808] transaction","detail":"{read_only:false; response_revision:2188; number_of_response:1; }","duration":"1.125632123s","start":"2026-05-30T01:47:11.735632Z","end":"2026-05-30T01:47:12.861264Z","steps":["trace[1044887808] 'process raft request' (duration: 1.125441929s)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:12.861561Z","caller":"traceutil/trace.go:171","msg":"trace[1719612445] linearizableReadLoop","detail":"{readStateIndex:2275; appliedIndex:2271; }","duration":"1.185670541s","start":"2026-05-30T01:47:11.675867Z","end":"2026-05-30T01:47:12.861537Z","steps":["trace[1719612445] 'read index received' (duration: 821.280752ms)","trace[1719612445] 'applied index is now lower than readState.Index' (duration: 364.386719ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:47:12.861584Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.735608Z","time spent":"1.125749675s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:47:12.8616Z","caller":"traceutil/trace.go:171","msg":"trace[1488767268] transaction","detail":"{read_only:false; response_revision:2190; number_of_response:1; }","duration":"981.237927ms","start":"2026-05-30T01:47:11.880337Z","end":"2026-05-30T01:47:12.861575Z","steps":["trace[1488767268] 'process raft request' (duration: 981.103975ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.86175Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.880318Z","time spent":"981.35239ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:47:12.861809Z","caller":"traceutil/trace.go:171","msg":"trace[1715181198] transaction","detail":"{read_only:false; response_revision:2189; number_of_response:1; }","duration":"1.062626522s","start":"2026-05-30T01:47:11.799148Z","end":"2026-05-30T01:47:12.861774Z","steps":["trace[1715181198] 'process raft request' (duration: 1.062066261s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.861906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.799133Z","time spent":"1.062731003s","remote":"127.0.0.1:40200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8538,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:47:12.861764Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"587.872426ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T01:47:12.861928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.186009957s","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-05-30T01:47:12.861996Z","caller":"traceutil/trace.go:171","msg":"trace[1523676592] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gateways/; range_end:/registry/gateway.networking.k8s.io/gateways0; response_count:0; response_revision:2190; }","duration":"588.138002ms","start":"2026-05-30T01:47:12.273839Z","end":"2026-05-30T01:47:12.861977Z","steps":["trace[1523676592] 'agreement among raft nodes before linearized reading' (duration: 587.870346ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:12.862041Z","caller":"traceutil/trace.go:171","msg":"trace[441997745] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2190; }","duration":"1.186201021s","start":"2026-05-30T01:47:11.675819Z","end":"2026-05-30T01:47:12.86202Z","steps":["trace[441997745] 'agreement among raft nodes before linearized reading' (duration: 1.185838714s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.862124Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.675797Z","time spent":"1.186315693s","remote":"127.0.0.1:54822","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5435,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-05-30T01:47:12.862171Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.097525894s","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-05-30T01:47:12.862206Z","caller":"traceutil/trace.go:171","msg":"trace[872237507] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2190; }","duration":"1.097594615s","start":"2026-05-30T01:47:11.764603Z","end":"2026-05-30T01:47:12.862198Z","steps":["trace[872237507] 'agreement among raft nodes before linearized reading' (duration: 1.097483753s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.861968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090042738s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"warn","ts":"2026-05-30T01:47:12.862053Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:12.273823Z","time spent":"588.213213ms","remote":"127.0.0.1:57090","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/gateways/\" range_end:\"/registry/gateway.networking.k8s.io/gateways0\" count_only:true "} {"level":"info","ts":"2026-05-30T01:47:12.86228Z","caller":"traceutil/trace.go:171","msg":"trace[566934698] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2190; }","duration":"1.090350243s","start":"2026-05-30T01:47:11.771913Z","end":"2026-05-30T01:47:12.862264Z","steps":["trace[566934698] 'agreement among raft nodes before linearized reading' (duration: 1.089970035s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.862331Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.771879Z","time spent":"1.090439276s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":455,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-05-30T01:47:12.862372Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.098201746s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-30T01:47:12.862343Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.090276432s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-05-30T01:47:12.8624Z","caller":"traceutil/trace.go:171","msg":"trace[924549490] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2190; }","duration":"1.098260637s","start":"2026-05-30T01:47:11.764134Z","end":"2026-05-30T01:47:12.862395Z","steps":["trace[924549490] 'agreement among raft nodes before linearized reading' (duration: 1.098145815s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.862492Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.764127Z","time spent":"1.098359798s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":514,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T01:47:12.862068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.558057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/\" range_end:\"/registry/storageclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T01:47:12.86256Z","caller":"traceutil/trace.go:171","msg":"trace[412633575] range","detail":"{range_begin:/registry/storageclasses/; range_end:/registry/storageclasses0; response_count:0; response_revision:2190; }","duration":"271.077575ms","start":"2026-05-30T01:47:12.591468Z","end":"2026-05-30T01:47:12.862545Z","steps":["trace[412633575] 'agreement among raft nodes before linearized reading' (duration: 270.539386ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.862236Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.764582Z","time spent":"1.097648896s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T01:47:12.861992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.295138ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-05-30T01:47:12.862817Z","caller":"traceutil/trace.go:171","msg":"trace[1408539610] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2190; }","duration":"167.185344ms","start":"2026-05-30T01:47:12.695617Z","end":"2026-05-30T01:47:12.862803Z","steps":["trace[1408539610] 'agreement among raft nodes before linearized reading' (duration: 166.250496ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:12.862448Z","caller":"traceutil/trace.go:171","msg":"trace[1422375037] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2190; }","duration":"1.090469966s","start":"2026-05-30T01:47:11.771965Z","end":"2026-05-30T01:47:12.862435Z","steps":["trace[1422375037] 'agreement among raft nodes before linearized reading' (duration: 1.090025818s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.86316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.103470761s","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-05-30T01:47:12.863233Z","caller":"traceutil/trace.go:171","msg":"trace[830541350] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2190; }","duration":"1.103544113s","start":"2026-05-30T01:47:11.759671Z","end":"2026-05-30T01:47:12.863215Z","steps":["trace[830541350] 'agreement among raft nodes before linearized reading' (duration: 1.102009925s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:47:12.863307Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.75964Z","time spent":"1.103649214s","remote":"127.0.0.1:40290","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":"warn","ts":"2026-05-30T01:47:12.862951Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:47:11.771945Z","time spent":"1.090991315s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":459,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"info","ts":"2026-05-30T01:47:12.998169Z","caller":"traceutil/trace.go:171","msg":"trace[1943120431] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"130.788808ms","start":"2026-05-30T01:47:12.867348Z","end":"2026-05-30T01:47:12.998137Z","steps":["trace[1943120431] 'process raft request' (duration: 99.717088ms)","trace[1943120431] 'compare' (duration: 30.659162ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:47:12.998245Z","caller":"traceutil/trace.go:171","msg":"trace[309557701] transaction","detail":"{read_only:false; response_revision:2196; number_of_response:1; }","duration":"128.898873ms","start":"2026-05-30T01:47:12.869316Z","end":"2026-05-30T01:47:12.998215Z","steps":["trace[309557701] 'process raft request' (duration: 128.841352ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:12.998712Z","caller":"traceutil/trace.go:171","msg":"trace[1776041029] transaction","detail":"{read_only:false; response_revision:2192; number_of_response:1; }","duration":"130.38618ms","start":"2026-05-30T01:47:12.868308Z","end":"2026-05-30T01:47:12.998694Z","steps":["trace[1776041029] 'process raft request' (duration: 129.619846ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:12.998935Z","caller":"traceutil/trace.go:171","msg":"trace[985725477] transaction","detail":"{read_only:false; response_revision:2193; number_of_response:1; }","duration":"130.562463ms","start":"2026-05-30T01:47:12.868356Z","end":"2026-05-30T01:47:12.998918Z","steps":["trace[985725477] 'process raft request' (duration: 129.637286ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:12.999181Z","caller":"traceutil/trace.go:171","msg":"trace[256387053] transaction","detail":"{read_only:false; response_revision:2195; number_of_response:1; }","duration":"130.014673ms","start":"2026-05-30T01:47:12.869148Z","end":"2026-05-30T01:47:12.999162Z","steps":["trace[256387053] 'process raft request' (duration: 128.961774ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:47:12.999228Z","caller":"traceutil/trace.go:171","msg":"trace[1290313540] transaction","detail":"{read_only:false; response_revision:2194; number_of_response:1; }","duration":"130.709156ms","start":"2026-05-30T01:47:12.868471Z","end":"2026-05-30T01:47:12.99918Z","steps":["trace[1290313540] 'process raft request' (duration: 129.584985ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:01.32805Z","caller":"traceutil/trace.go:171","msg":"trace[246691991] linearizableReadLoop","detail":"{readStateIndex:2592; appliedIndex:2591; }","duration":"109.085021ms","start":"2026-05-30T01:48:01.218935Z","end":"2026-05-30T01:48:01.32802Z","steps":["trace[246691991] 'read index received' (duration: 108.954309ms)","trace[246691991] 'applied index is now lower than readState.Index' (duration: 129.432µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:48:01.328144Z","caller":"traceutil/trace.go:171","msg":"trace[525991529] transaction","detail":"{read_only:false; response_revision:2496; number_of_response:1; }","duration":"115.840582ms","start":"2026-05-30T01:48:01.21228Z","end":"2026-05-30T01:48:01.32812Z","steps":["trace[525991529] 'process raft request' (duration: 115.549588ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:01.328287Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.297814ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-05-30T01:48:01.328322Z","caller":"traceutil/trace.go:171","msg":"trace[787169934] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2496; }","duration":"109.374736ms","start":"2026-05-30T01:48:01.218936Z","end":"2026-05-30T01:48:01.32831Z","steps":["trace[787169934] 'agreement among raft nodes before linearized reading' (duration: 109.239093ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:01.328575Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.04823ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-05-30T01:48:01.328627Z","caller":"traceutil/trace.go:171","msg":"trace[1413734460] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2496; }","duration":"105.164623ms","start":"2026-05-30T01:48:01.223448Z","end":"2026-05-30T01:48:01.328612Z","steps":["trace[1413734460] 'agreement among raft nodes before linearized reading' (duration: 104.912989ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:01.328611Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.280669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:490"} {"level":"info","ts":"2026-05-30T01:48:01.328709Z","caller":"traceutil/trace.go:171","msg":"trace[1212869052] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2496; }","duration":"108.415291ms","start":"2026-05-30T01:48:01.220271Z","end":"2026-05-30T01:48:01.328686Z","steps":["trace[1212869052] 'agreement among raft nodes before linearized reading' (duration: 108.141047ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:01.328288Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.333085ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-05-30T01:48:01.328778Z","caller":"traceutil/trace.go:171","msg":"trace[1360319953] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2496; }","duration":"109.836863ms","start":"2026-05-30T01:48:01.218931Z","end":"2026-05-30T01:48:01.328768Z","steps":["trace[1360319953] 'agreement among raft nodes before linearized reading' (duration: 109.231094ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:01.939717Z","caller":"traceutil/trace.go:171","msg":"trace[975860757] transaction","detail":"{read_only:false; response_revision:2504; number_of_response:1; }","duration":"111.421626ms","start":"2026-05-30T01:48:01.82826Z","end":"2026-05-30T01:48:01.939682Z","steps":["trace[975860757] 'process raft request' (duration: 17.761066ms)","trace[975860757] 'compare' (duration: 93.363115ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:48:10.112892Z","caller":"traceutil/trace.go:171","msg":"trace[1206202952] transaction","detail":"{read_only:false; response_revision:2605; number_of_response:1; }","duration":"144.656225ms","start":"2026-05-30T01:48:09.967805Z","end":"2026-05-30T01:48:10.112461Z","steps":["trace[1206202952] 'process raft request' (duration: 144.4022ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:43.504116Z","caller":"traceutil/trace.go:171","msg":"trace[36200703] transaction","detail":"{read_only:false; response_revision:2784; number_of_response:1; }","duration":"446.243032ms","start":"2026-05-30T01:48:43.057848Z","end":"2026-05-30T01:48:43.504091Z","steps":["trace[36200703] 'process raft request' (duration: 446.088841ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:43.504306Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:43.057834Z","time spent":"446.380134ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":543,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:48:43.685382Z","caller":"traceutil/trace.go:171","msg":"trace[735384214] transaction","detail":"{read_only:false; response_revision:2785; number_of_response:1; }","duration":"533.049939ms","start":"2026-05-30T01:48:43.1523Z","end":"2026-05-30T01:48:43.68535Z","steps":["trace[735384214] 'process raft request' (duration: 518.544781ms)","trace[735384214] 'compare' (duration: 14.339916ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:48:43.685447Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"330.960446ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:48:43.685575Z","caller":"traceutil/trace.go:171","msg":"trace[1932037178] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2785; }","duration":"331.123388ms","start":"2026-05-30T01:48:43.354439Z","end":"2026-05-30T01:48:43.685562Z","steps":["trace[1932037178] 'agreement among raft nodes before linearized reading' (duration: 330.967186ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:43.685615Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:43.354421Z","time spent":"331.18829ms","remote":"127.0.0.1:41648","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-05-30T01:48:43.685675Z","caller":"traceutil/trace.go:171","msg":"trace[1298663864] linearizableReadLoop","detail":"{readStateIndex:2890; appliedIndex:2889; }","duration":"330.851185ms","start":"2026-05-30T01:48:43.354473Z","end":"2026-05-30T01:48:43.685324Z","steps":["trace[1298663864] 'read index received' (duration: 149.915951ms)","trace[1298663864] 'applied index is now lower than readState.Index' (duration: 180.934064ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:48:43.6857Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:43.152268Z","time spent":"533.253303ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:48:43.685888Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.908868ms","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-05-30T01:48:43.685911Z","caller":"traceutil/trace.go:171","msg":"trace[1783552213] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:2785; }","duration":"135.942509ms","start":"2026-05-30T01:48:43.549963Z","end":"2026-05-30T01:48:43.685906Z","steps":["trace[1783552213] 'agreement among raft nodes before linearized reading' (duration: 135.859018ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:43.686007Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.347877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"warn","ts":"2026-05-30T01:48:43.686038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.451579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T01:48:43.686043Z","caller":"traceutil/trace.go:171","msg":"trace[464051955] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2785; }","duration":"175.43344ms","start":"2026-05-30T01:48:43.510598Z","end":"2026-05-30T01:48:43.686031Z","steps":["trace[464051955] 'agreement among raft nodes before linearized reading' (duration: 175.197197ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:43.686056Z","caller":"traceutil/trace.go:171","msg":"trace[1065641366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2785; }","duration":"137.50872ms","start":"2026-05-30T01:48:43.548542Z","end":"2026-05-30T01:48:43.686051Z","steps":["trace[1065641366] 'agreement among raft nodes before linearized reading' (duration: 137.448949ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:43.686044Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.946202ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"info","ts":"2026-05-30T01:48:43.68633Z","caller":"traceutil/trace.go:171","msg":"trace[1578673874] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2785; }","duration":"134.240255ms","start":"2026-05-30T01:48:43.552066Z","end":"2026-05-30T01:48:43.686306Z","steps":["trace[1578673874] 'agreement among raft nodes before linearized reading' (duration: 133.740049ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:43.686938Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.771994ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T01:48:43.687183Z","caller":"traceutil/trace.go:171","msg":"trace[1847775863] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2785; }","duration":"138.696666ms","start":"2026-05-30T01:48:43.548298Z","end":"2026-05-30T01:48:43.686995Z","steps":["trace[1847775863] 'agreement among raft nodes before linearized reading' (duration: 137.613912ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:44.502623Z","caller":"traceutil/trace.go:171","msg":"trace[304212931] linearizableReadLoop","detail":"{readStateIndex:2897; appliedIndex:2896; }","duration":"180.086348ms","start":"2026-05-30T01:48:44.322513Z","end":"2026-05-30T01:48:44.502599Z","steps":["trace[304212931] 'read index received' (duration: 179.956297ms)","trace[304212931] 'applied index is now lower than readState.Index' (duration: 128.841µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:48:44.502709Z","caller":"traceutil/trace.go:171","msg":"trace[1344352795] transaction","detail":"{read_only:false; response_revision:2792; number_of_response:1; }","duration":"268.280984ms","start":"2026-05-30T01:48:44.234404Z","end":"2026-05-30T01:48:44.502685Z","steps":["trace[1344352795] 'process raft request' (duration: 268.04486ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:44.502933Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.409704ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-headless\" ","response":"range_response_count:1 size:1369"} {"level":"info","ts":"2026-05-30T01:48:44.502997Z","caller":"traceutil/trace.go:171","msg":"trace[1664598262] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-headless; range_end:; response_count:1; response_revision:2792; }","duration":"180.511105ms","start":"2026-05-30T01:48:44.322476Z","end":"2026-05-30T01:48:44.502987Z","steps":["trace[1664598262] 'agreement among raft nodes before linearized reading' (duration: 180.287332ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:44.978458Z","caller":"traceutil/trace.go:171","msg":"trace[1192779257] linearizableReadLoop","detail":"{readStateIndex:2898; appliedIndex:2897; }","duration":"472.383121ms","start":"2026-05-30T01:48:44.506042Z","end":"2026-05-30T01:48:44.978425Z","steps":["trace[1192779257] 'read index received' (duration: 472.175218ms)","trace[1192779257] 'applied index is now lower than readState.Index' (duration: 206.623µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:48:44.978645Z","caller":"traceutil/trace.go:171","msg":"trace[936102323] transaction","detail":"{read_only:false; response_revision:2793; number_of_response:1; }","duration":"605.73112ms","start":"2026-05-30T01:48:44.372899Z","end":"2026-05-30T01:48:44.97863Z","steps":["trace[936102323] 'process raft request' (duration: 605.351356ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:44.978802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:44.372881Z","time spent":"605.833783ms","remote":"127.0.0.1:40200","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9268,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:48:44.979027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"472.778767ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" ","response":"range_response_count:1 size:1445"} {"level":"info","ts":"2026-05-30T01:48:44.979218Z","caller":"traceutil/trace.go:171","msg":"trace[1462038299] range","detail":"{range_begin:/registry/services/specs/auth-system/keycloak-metrics; range_end:; response_count:1; response_revision:2793; }","duration":"473.174911ms","start":"2026-05-30T01:48:44.506022Z","end":"2026-05-30T01:48:44.979197Z","steps":["trace[1462038299] 'agreement among raft nodes before linearized reading' (duration: 472.617143ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:44.979308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:44.506011Z","time spent":"473.281642ms","remote":"127.0.0.1:40218","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":1468,"request content":"key:\"/registry/services/specs/auth-system/keycloak-metrics\" "} {"level":"info","ts":"2026-05-30T01:48:44.982229Z","caller":"traceutil/trace.go:171","msg":"trace[2043497904] transaction","detail":"{read_only:false; response_revision:2794; number_of_response:1; }","duration":"343.893076ms","start":"2026-05-30T01:48:44.638314Z","end":"2026-05-30T01:48:44.982207Z","steps":["trace[2043497904] 'process raft request' (duration: 343.42947ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:44.982367Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:44.638291Z","time spent":"344.004857ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:48:44.982701Z","caller":"traceutil/trace.go:171","msg":"trace[1993160494] transaction","detail":"{read_only:false; response_revision:2796; number_of_response:1; }","duration":"153.153731ms","start":"2026-05-30T01:48:44.829535Z","end":"2026-05-30T01:48:44.982688Z","steps":["trace[1993160494] 'process raft request' (duration: 152.925868ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:44.982851Z","caller":"traceutil/trace.go:171","msg":"trace[712630707] transaction","detail":"{read_only:false; response_revision:2795; number_of_response:1; }","duration":"175.162552ms","start":"2026-05-30T01:48:44.807676Z","end":"2026-05-30T01:48:44.982838Z","steps":["trace[712630707] 'process raft request' (duration: 174.495563ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:44.982985Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.553343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ingress/\" range_end:\"/registry/ingress0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T01:48:44.982995Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"426.659257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.204.45.19\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-05-30T01:48:44.983041Z","caller":"traceutil/trace.go:171","msg":"trace[169194427] range","detail":"{range_begin:/registry/ingress/; range_end:/registry/ingress0; response_count:0; response_revision:2796; }","duration":"122.653724ms","start":"2026-05-30T01:48:44.860375Z","end":"2026-05-30T01:48:44.983029Z","steps":["trace[169194427] 'agreement among raft nodes before linearized reading' (duration: 122.552673ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:48:44.983118Z","caller":"traceutil/trace.go:171","msg":"trace[456741409] range","detail":"{range_begin:/registry/masterleases/199.204.45.19; range_end:; response_count:1; response_revision:2796; }","duration":"426.814758ms","start":"2026-05-30T01:48:44.55622Z","end":"2026-05-30T01:48:44.983035Z","steps":["trace[456741409] 'agreement among raft nodes before linearized reading' (duration: 426.356782ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:48:44.983156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:48:44.556206Z","time spent":"426.9411ms","remote":"127.0.0.1:41684","response type":"/etcdserverpb.KV/Range","request count":0,"request size":38,"response count":1,"response size":156,"request content":"key:\"/registry/masterleases/199.204.45.19\" "} {"level":"warn","ts":"2026-05-30T01:51:38.965526Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.944042ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:51:38.965753Z","caller":"traceutil/trace.go:171","msg":"trace[757826853] transaction","detail":"{read_only:false; response_revision:3871; number_of_response:1; }","duration":"241.79616ms","start":"2026-05-30T01:51:38.723939Z","end":"2026-05-30T01:51:38.965735Z","steps":["trace[757826853] 'process raft request' (duration: 39.579181ms)","trace[757826853] 'compare' (duration: 201.714077ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:51:38.965776Z","caller":"traceutil/trace.go:171","msg":"trace[1691802472] transaction","detail":"{read_only:false; response_revision:3872; number_of_response:1; }","duration":"241.483822ms","start":"2026-05-30T01:51:38.724265Z","end":"2026-05-30T01:51:38.965749Z","steps":["trace[1691802472] 'process raft request' (duration: 241.338198ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:51:38.965951Z","caller":"traceutil/trace.go:171","msg":"trace[1252310405] transaction","detail":"{read_only:false; response_revision:3873; number_of_response:1; }","duration":"241.614266ms","start":"2026-05-30T01:51:38.72433Z","end":"2026-05-30T01:51:38.965944Z","steps":["trace[1252310405] 'process raft request' (duration: 241.329519ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:51:38.966153Z","caller":"traceutil/trace.go:171","msg":"trace[314470321] transaction","detail":"{read_only:false; response_revision:3875; number_of_response:1; }","duration":"241.062121ms","start":"2026-05-30T01:51:38.725084Z","end":"2026-05-30T01:51:38.966146Z","steps":["trace[314470321] 'process raft request' (duration: 241.038631ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:51:38.966204Z","caller":"traceutil/trace.go:171","msg":"trace[1383486839] transaction","detail":"{read_only:false; response_revision:3874; number_of_response:1; }","duration":"241.145204ms","start":"2026-05-30T01:51:38.725055Z","end":"2026-05-30T01:51:38.9662Z","steps":["trace[1383486839] 'process raft request' (duration: 240.858187ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:51:39.3005Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.007204ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:51:39.300626Z","caller":"traceutil/trace.go:171","msg":"trace[1018846876] transaction","detail":"{read_only:false; response_revision:3876; number_of_response:1; }","duration":"244.04303ms","start":"2026-05-30T01:51:39.056563Z","end":"2026-05-30T01:51:39.300606Z","steps":["trace[1018846876] 'process raft request' (duration: 118.8505ms)","trace[1018846876] 'compare' (duration: 124.876361ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:52:10.54045Z","caller":"traceutil/trace.go:171","msg":"trace[2095417952] transaction","detail":"{read_only:false; response_revision:4071; number_of_response:1; }","duration":"128.705965ms","start":"2026-05-30T01:52:10.411717Z","end":"2026-05-30T01:52:10.540423Z","steps":["trace[2095417952] 'process raft request' (duration: 128.521951ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:10.609392Z","caller":"traceutil/trace.go:171","msg":"trace[412657202] transaction","detail":"{read_only:false; response_revision:4072; number_of_response:1; }","duration":"156.753104ms","start":"2026-05-30T01:52:10.452611Z","end":"2026-05-30T01:52:10.609364Z","steps":["trace[412657202] 'process raft request' (duration: 156.58474ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:11.481517Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.760058ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:52:11.481616Z","caller":"traceutil/trace.go:171","msg":"trace[774559088] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4077; }","duration":"128.913112ms","start":"2026-05-30T01:52:11.352675Z","end":"2026-05-30T01:52:11.481589Z","steps":["trace[774559088] 'range keys from in-memory index tree' (duration: 128.655526ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.132397Z","caller":"traceutil/trace.go:171","msg":"trace[1644301839] transaction","detail":"{read_only:false; response_revision:4289; number_of_response:1; }","duration":"112.435144ms","start":"2026-05-30T01:52:12.01994Z","end":"2026-05-30T01:52:12.132375Z","steps":["trace[1644301839] 'process raft request' (duration: 111.8347ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.132589Z","caller":"traceutil/trace.go:171","msg":"trace[1012274884] transaction","detail":"{read_only:false; response_revision:4290; number_of_response:1; }","duration":"112.557788ms","start":"2026-05-30T01:52:12.020017Z","end":"2026-05-30T01:52:12.132575Z","steps":["trace[1012274884] 'process raft request' (duration: 111.881022ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.132707Z","caller":"traceutil/trace.go:171","msg":"trace[1973973810] transaction","detail":"{read_only:false; response_revision:4291; number_of_response:1; }","duration":"112.591257ms","start":"2026-05-30T01:52:12.020097Z","end":"2026-05-30T01:52:12.132689Z","steps":["trace[1973973810] 'process raft request' (duration: 111.84529ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.132903Z","caller":"traceutil/trace.go:171","msg":"trace[581616022] transaction","detail":"{read_only:false; response_revision:4301; number_of_response:1; }","duration":"110.366547ms","start":"2026-05-30T01:52:12.022511Z","end":"2026-05-30T01:52:12.132878Z","steps":["trace[581616022] 'process raft request' (duration: 109.720332ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.133Z","caller":"traceutil/trace.go:171","msg":"trace[600349976] transaction","detail":"{read_only:false; response_revision:4302; number_of_response:1; }","duration":"109.936907ms","start":"2026-05-30T01:52:12.023048Z","end":"2026-05-30T01:52:12.132985Z","steps":["trace[600349976] 'process raft request' (duration: 109.20918ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.13311Z","caller":"traceutil/trace.go:171","msg":"trace[1242926379] transaction","detail":"{read_only:false; response_revision:4292; number_of_response:1; }","duration":"111.38275ms","start":"2026-05-30T01:52:12.021716Z","end":"2026-05-30T01:52:12.133099Z","steps":["trace[1242926379] 'process raft request' (duration: 110.258844ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.133173Z","caller":"traceutil/trace.go:171","msg":"trace[1704733593] transaction","detail":"{read_only:false; response_revision:4303; number_of_response:1; }","duration":"109.61469ms","start":"2026-05-30T01:52:12.023544Z","end":"2026-05-30T01:52:12.133159Z","steps":["trace[1704733593] 'process raft request' (duration: 108.73538ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.133263Z","caller":"traceutil/trace.go:171","msg":"trace[292476308] transaction","detail":"{read_only:false; response_revision:4293; number_of_response:1; }","duration":"111.466252ms","start":"2026-05-30T01:52:12.021781Z","end":"2026-05-30T01:52:12.133247Z","steps":["trace[292476308] 'process raft request' (duration: 110.219183ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.133444Z","caller":"traceutil/trace.go:171","msg":"trace[998673860] transaction","detail":"{read_only:false; response_revision:4294; number_of_response:1; }","duration":"111.492852ms","start":"2026-05-30T01:52:12.021937Z","end":"2026-05-30T01:52:12.13343Z","steps":["trace[998673860] 'process raft request' (duration: 110.09147ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.133608Z","caller":"traceutil/trace.go:171","msg":"trace[1656534693] transaction","detail":"{read_only:false; response_revision:4295; number_of_response:1; }","duration":"111.616846ms","start":"2026-05-30T01:52:12.021981Z","end":"2026-05-30T01:52:12.133597Z","steps":["trace[1656534693] 'process raft request' (duration: 110.074059ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.133729Z","caller":"traceutil/trace.go:171","msg":"trace[1315430071] transaction","detail":"{read_only:false; response_revision:4296; number_of_response:1; }","duration":"111.700858ms","start":"2026-05-30T01:52:12.022021Z","end":"2026-05-30T01:52:12.133721Z","steps":["trace[1315430071] 'process raft request' (duration: 110.06048ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.13386Z","caller":"traceutil/trace.go:171","msg":"trace[960462899] transaction","detail":"{read_only:false; response_revision:4297; number_of_response:1; }","duration":"111.725148ms","start":"2026-05-30T01:52:12.022127Z","end":"2026-05-30T01:52:12.133852Z","steps":["trace[960462899] 'process raft request' (duration: 109.987489ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.134097Z","caller":"traceutil/trace.go:171","msg":"trace[1723209205] transaction","detail":"{read_only:false; response_revision:4298; number_of_response:1; }","duration":"111.900812ms","start":"2026-05-30T01:52:12.022187Z","end":"2026-05-30T01:52:12.134087Z","steps":["trace[1723209205] 'process raft request' (duration: 109.954897ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.13422Z","caller":"traceutil/trace.go:171","msg":"trace[659623160] transaction","detail":"{read_only:false; response_revision:4299; number_of_response:1; }","duration":"111.894152ms","start":"2026-05-30T01:52:12.022317Z","end":"2026-05-30T01:52:12.134211Z","steps":["trace[659623160] 'process raft request' (duration: 109.853225ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:12.134334Z","caller":"traceutil/trace.go:171","msg":"trace[1842272338] transaction","detail":"{read_only:false; response_revision:4300; number_of_response:1; }","duration":"111.946894ms","start":"2026-05-30T01:52:12.022376Z","end":"2026-05-30T01:52:12.134322Z","steps":["trace[1842272338] 'process raft request' (duration: 109.827815ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:13.173519Z","caller":"traceutil/trace.go:171","msg":"trace[1695363134] transaction","detail":"{read_only:false; response_revision:4384; number_of_response:1; }","duration":"140.794471ms","start":"2026-05-30T01:52:13.032703Z","end":"2026-05-30T01:52:13.173497Z","steps":["trace[1695363134] 'process raft request' (duration: 140.480784ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:13.420016Z","caller":"traceutil/trace.go:171","msg":"trace[1118774385] transaction","detail":"{read_only:false; response_revision:4385; number_of_response:1; }","duration":"348.205254ms","start":"2026-05-30T01:52:13.071783Z","end":"2026-05-30T01:52:13.419989Z","steps":["trace[1118774385] 'process raft request' (duration: 344.5317ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:13.420059Z","caller":"traceutil/trace.go:171","msg":"trace[802300829] transaction","detail":"{read_only:false; response_revision:4386; number_of_response:1; }","duration":"251.605921ms","start":"2026-05-30T01:52:13.168414Z","end":"2026-05-30T01:52:13.42002Z","steps":["trace[802300829] 'process raft request' (duration: 251.327625ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:13.420165Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:13.071768Z","time spent":"348.321386ms","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2992,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:13.420233Z","caller":"traceutil/trace.go:171","msg":"trace[635455648] linearizableReadLoop","detail":"{readStateIndex:4558; appliedIndex:4556; }","duration":"310.948447ms","start":"2026-05-30T01:52:13.109233Z","end":"2026-05-30T01:52:13.420181Z","steps":["trace[635455648] 'read index received' (duration: 63.84115ms)","trace[635455648] 'applied index is now lower than readState.Index' (duration: 247.104627ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:52:13.420497Z","caller":"traceutil/trace.go:171","msg":"trace[1301062241] transaction","detail":"{read_only:false; response_revision:4387; number_of_response:1; }","duration":"214.277893ms","start":"2026-05-30T01:52:13.205992Z","end":"2026-05-30T01:52:13.42027Z","steps":["trace[1301062241] 'process raft request' (duration: 214.019747ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:13.420648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"311.402178ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-tls\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-05-30T01:52:13.420677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.139291ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T01:52:13.420742Z","caller":"traceutil/trace.go:171","msg":"trace[1708338395] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-tls; range_end:; response_count:0; response_revision:4387; }","duration":"311.548711ms","start":"2026-05-30T01:52:13.109179Z","end":"2026-05-30T01:52:13.420728Z","steps":["trace[1708338395] 'agreement among raft nodes before linearized reading' (duration: 311.252575ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:13.420781Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:13.109158Z","time spent":"311.614372ms","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":0,"response size":28,"request content":"key:\"/registry/secrets/monitoring/alertmanager-tls\" "} {"level":"warn","ts":"2026-05-30T01:52:13.42082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.21596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:436"} {"level":"warn","ts":"2026-05-30T01:52:13.420837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"208.356645ms","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-05-30T01:52:13.420879Z","caller":"traceutil/trace.go:171","msg":"trace[164642762] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4387; }","duration":"211.298162ms","start":"2026-05-30T01:52:13.209567Z","end":"2026-05-30T01:52:13.420865Z","steps":["trace[164642762] 'agreement among raft nodes before linearized reading' (duration: 211.021726ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:13.420915Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.383952ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T01:52:13.420909Z","caller":"traceutil/trace.go:171","msg":"trace[2141021399] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4387; }","duration":"208.434397ms","start":"2026-05-30T01:52:13.212452Z","end":"2026-05-30T01:52:13.420886Z","steps":["trace[2141021399] 'agreement among raft nodes before linearized reading' (duration: 208.13345ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:13.420947Z","caller":"traceutil/trace.go:171","msg":"trace[1480377464] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:4387; }","duration":"190.438014ms","start":"2026-05-30T01:52:13.2305Z","end":"2026-05-30T01:52:13.420938Z","steps":["trace[1480377464] 'agreement among raft nodes before linearized reading' (duration: 190.393313ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:13.421075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.805263ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-05-30T01:52:13.421053Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.525575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-05-30T01:52:13.421116Z","caller":"traceutil/trace.go:171","msg":"trace[1879313249] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4387; }","duration":"216.615216ms","start":"2026-05-30T01:52:13.204493Z","end":"2026-05-30T01:52:13.421108Z","steps":["trace[1879313249] 'agreement among raft nodes before linearized reading' (duration: 216.486164ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:13.421114Z","caller":"traceutil/trace.go:171","msg":"trace[1487034786] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4387; }","duration":"207.842164ms","start":"2026-05-30T01:52:13.213261Z","end":"2026-05-30T01:52:13.421103Z","steps":["trace[1487034786] 'agreement among raft nodes before linearized reading' (duration: 207.747372ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:13.420749Z","caller":"traceutil/trace.go:171","msg":"trace[931852955] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:0; response_revision:4387; }","duration":"208.245522ms","start":"2026-05-30T01:52:13.212491Z","end":"2026-05-30T01:52:13.420736Z","steps":["trace[931852955] 'agreement among raft nodes before linearized reading' (duration: 208.064308ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:13.421079Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.45588ms","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-05-30T01:52:13.421873Z","caller":"traceutil/trace.go:171","msg":"trace[235409058] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4387; }","duration":"299.306319ms","start":"2026-05-30T01:52:13.12255Z","end":"2026-05-30T01:52:13.421857Z","steps":["trace[235409058] 'agreement among raft nodes before linearized reading' (duration: 297.903627ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:19.572977Z","caller":"traceutil/trace.go:171","msg":"trace[1755508866] linearizableReadLoop","detail":"{readStateIndex:4720; appliedIndex:4719; }","duration":"114.60562ms","start":"2026-05-30T01:52:19.458351Z","end":"2026-05-30T01:52:19.572957Z","steps":["trace[1755508866] 'read index received' (duration: 114.425116ms)","trace[1755508866] 'applied index is now lower than readState.Index' (duration: 179.734µs)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:52:19.573285Z","caller":"traceutil/trace.go:171","msg":"trace[1448246021] transaction","detail":"{read_only:false; response_revision:4544; number_of_response:1; }","duration":"123.669095ms","start":"2026-05-30T01:52:19.449605Z","end":"2026-05-30T01:52:19.573274Z","steps":["trace[1448246021] 'process raft request' (duration: 123.226305ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:19.573529Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.166293ms","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-05-30T01:52:19.573558Z","caller":"traceutil/trace.go:171","msg":"trace[51239301] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4544; }","duration":"115.229205ms","start":"2026-05-30T01:52:19.458322Z","end":"2026-05-30T01:52:19.573551Z","steps":["trace[51239301] 'agreement among raft nodes before linearized reading' (duration: 115.122272ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:19.591406Z","caller":"traceutil/trace.go:171","msg":"trace[1150045915] transaction","detail":"{read_only:false; response_revision:4545; number_of_response:1; }","duration":"101.946112ms","start":"2026-05-30T01:52:19.489442Z","end":"2026-05-30T01:52:19.591389Z","steps":["trace[1150045915] 'process raft request' (duration: 101.512862ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:19.59158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.528959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f82fdceb-1141-479b-8480-e81b161a604d\" ","response":"range_response_count:1 size:3773"} {"level":"info","ts":"2026-05-30T01:52:19.591647Z","caller":"traceutil/trace.go:171","msg":"trace[928746121] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f82fdceb-1141-479b-8480-e81b161a604d; range_end:; response_count:1; response_revision:4546; }","duration":"122.621452ms","start":"2026-05-30T01:52:19.469008Z","end":"2026-05-30T01:52:19.591629Z","steps":["trace[928746121] 'agreement among raft nodes before linearized reading' (duration: 122.408866ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:19.591792Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.401774ms","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-05-30T01:52:19.592052Z","caller":"traceutil/trace.go:171","msg":"trace[834752488] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4546; }","duration":"128.73649ms","start":"2026-05-30T01:52:19.463307Z","end":"2026-05-30T01:52:19.592043Z","steps":["trace[834752488] 'agreement among raft nodes before linearized reading' (duration: 128.398843ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:19.591952Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.374115ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T01:52:19.592158Z","caller":"traceutil/trace.go:171","msg":"trace[1202341090] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4546; }","duration":"129.60531ms","start":"2026-05-30T01:52:19.462547Z","end":"2026-05-30T01:52:19.592152Z","steps":["trace[1202341090] 'agreement among raft nodes before linearized reading' (duration: 129.343054ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:19.591987Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.222399ms","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-05-30T01:52:19.592248Z","caller":"traceutil/trace.go:171","msg":"trace[286285528] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4546; }","duration":"132.498496ms","start":"2026-05-30T01:52:19.459743Z","end":"2026-05-30T01:52:19.592242Z","steps":["trace[286285528] 'agreement among raft nodes before linearized reading' (duration: 132.173829ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:19.592013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.569576ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T01:52:19.592345Z","caller":"traceutil/trace.go:171","msg":"trace[126287357] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4546; }","duration":"124.915484ms","start":"2026-05-30T01:52:19.467424Z","end":"2026-05-30T01:52:19.592339Z","steps":["trace[126287357] 'agreement among raft nodes before linearized reading' (duration: 124.550655ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:28.728342Z","caller":"traceutil/trace.go:171","msg":"trace[219565945] transaction","detail":"{read_only:false; response_revision:4683; number_of_response:1; }","duration":"155.509574ms","start":"2026-05-30T01:52:28.57281Z","end":"2026-05-30T01:52:28.728319Z","steps":["trace[219565945] 'process raft request' (duration: 133.187688ms)","trace[219565945] 'compare' (duration: 22.156122ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:52:29.616592Z","caller":"traceutil/trace.go:171","msg":"trace[1092791822] transaction","detail":"{read_only:false; response_revision:4691; number_of_response:1; }","duration":"197.372504ms","start":"2026-05-30T01:52:29.419193Z","end":"2026-05-30T01:52:29.616565Z","steps":["trace[1092791822] 'process raft request' (duration: 197.18894ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:36.898382Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.115591451s","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:52:36.89853Z","caller":"traceutil/trace.go:171","msg":"trace[119537054] transaction","detail":"{read_only:false; response_revision:4836; number_of_response:1; }","duration":"1.282804687s","start":"2026-05-30T01:52:35.615705Z","end":"2026-05-30T01:52:36.898509Z","steps":["trace[119537054] 'process raft request' (duration: 166.979222ms)","trace[119537054] 'compare' (duration: 1.114840744s)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:52:36.898602Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.615692Z","time spent":"1.28287942s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:52:36.915933Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.133345899s","expected-duration":"1s"} {"level":"info","ts":"2026-05-30T01:52:36.916407Z","caller":"traceutil/trace.go:171","msg":"trace[267107501] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4836; }","duration":"1.30032517s","start":"2026-05-30T01:52:35.616043Z","end":"2026-05-30T01:52:36.916368Z","steps":["trace[267107501] 'process raft request' (duration: 1.300133896s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:36.9165Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.299238367s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-123283f4-99a8-4386-a73b-a093fdd91b2e\" ","response":"range_response_count:1 size:3645"} {"level":"info","ts":"2026-05-30T01:52:36.916559Z","caller":"traceutil/trace.go:171","msg":"trace[1504473649] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-123283f4-99a8-4386-a73b-a093fdd91b2e; range_end:; response_count:1; response_revision:4837; }","duration":"1.299323909s","start":"2026-05-30T01:52:35.617222Z","end":"2026-05-30T01:52:36.916546Z","steps":["trace[1504473649] 'agreement among raft nodes before linearized reading' (duration: 1.299152885s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:36.916585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.617216Z","time spent":"1.299364099s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-123283f4-99a8-4386-a73b-a093fdd91b2e\" "} {"level":"warn","ts":"2026-05-30T01:52:36.916586Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.616035Z","time spent":"1.300453102s","remote":"127.0.0.1:58290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":103,"response count":0,"response size":2777,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:36.916798Z","caller":"traceutil/trace.go:171","msg":"trace[1176708202] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5021; }","duration":"1.299133615s","start":"2026-05-30T01:52:35.617236Z","end":"2026-05-30T01:52:36.916369Z","steps":["trace[1176708202] 'read index received' (duration: 165.460479ms)","trace[1176708202] 'applied index is now lower than readState.Index' (duration: 1.133672086s)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:52:36.916865Z","caller":"traceutil/trace.go:171","msg":"trace[1299210718] transaction","detail":"{read_only:false; response_revision:4837; number_of_response:1; }","duration":"1.249347236s","start":"2026-05-30T01:52:35.66751Z","end":"2026-05-30T01:52:36.916857Z","steps":["trace[1299210718] 'process raft request' (duration: 1.248767743s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:36.916923Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.667475Z","time spent":"1.249405937s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:37.121898Z","caller":"traceutil/trace.go:171","msg":"trace[10481671] transaction","detail":"{read_only:false; response_revision:4838; number_of_response:1; }","duration":"1.202877814s","start":"2026-05-30T01:52:35.918999Z","end":"2026-05-30T01:52:37.121877Z","steps":["trace[10481671] 'process raft request' (duration: 1.194271346s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.122015Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.918955Z","time spent":"1.202998367s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:37.122182Z","caller":"traceutil/trace.go:171","msg":"trace[1614621057] linearizableReadLoop","detail":"{readStateIndex:5027; appliedIndex:5024; }","duration":"205.340154ms","start":"2026-05-30T01:52:36.916818Z","end":"2026-05-30T01:52:37.122158Z","steps":["trace[1614621057] 'read index received' (duration: 196.512871ms)","trace[1614621057] 'applied index is now lower than readState.Index' (duration: 8.826293ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:52:37.122394Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.430974362s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"warn","ts":"2026-05-30T01:52:37.122401Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.424546612s","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-05-30T01:52:37.122432Z","caller":"traceutil/trace.go:171","msg":"trace[1046436245] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4840; }","duration":"1.431024193s","start":"2026-05-30T01:52:35.6914Z","end":"2026-05-30T01:52:37.122424Z","steps":["trace[1046436245] 'agreement among raft nodes before linearized reading' (duration: 1.43091181s)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:37.122442Z","caller":"traceutil/trace.go:171","msg":"trace[1861261268] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4840; }","duration":"1.424631643s","start":"2026-05-30T01:52:35.697798Z","end":"2026-05-30T01:52:37.12243Z","steps":["trace[1861261268] 'agreement among raft nodes before linearized reading' (duration: 1.42447805s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.122458Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.691394Z","time spent":"1.431059343s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":515,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-05-30T01:52:37.122474Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.69776Z","time spent":"1.424706544s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":503,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-05-30T01:52:37.122522Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.426212277s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T01:52:37.122585Z","caller":"traceutil/trace.go:171","msg":"trace[1366703011] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4840; }","duration":"1.42629493s","start":"2026-05-30T01:52:35.696276Z","end":"2026-05-30T01:52:37.122571Z","steps":["trace[1366703011] 'agreement among raft nodes before linearized reading' (duration: 1.426110065s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.122588Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.434925929s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-05-30T01:52:37.122614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.69627Z","time spent":"1.426337691s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-05-30T01:52:37.122639Z","caller":"traceutil/trace.go:171","msg":"trace[167989830] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4840; }","duration":"1.435014821s","start":"2026-05-30T01:52:35.687609Z","end":"2026-05-30T01:52:37.122624Z","steps":["trace[167989830] 'agreement among raft nodes before linearized reading' (duration: 1.434893997s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.122693Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.687592Z","time spent":"1.435088932s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-05-30T01:52:37.122727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.502807193s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" ","response":"range_response_count:1 size:1343"} {"level":"warn","ts":"2026-05-30T01:52:37.122753Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"763.208496ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-05-30T01:52:37.122783Z","caller":"traceutil/trace.go:171","msg":"trace[1817506918] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4840; }","duration":"763.287968ms","start":"2026-05-30T01:52:36.359489Z","end":"2026-05-30T01:52:37.122777Z","steps":["trace[1817506918] 'agreement among raft nodes before linearized reading' (duration: 763.212606ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.122802Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:36.359465Z","time spent":"763.332418ms","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-05-30T01:52:37.122842Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"769.946283ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:52:37.122868Z","caller":"traceutil/trace.go:171","msg":"trace[22226125] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4840; }","duration":"769.998774ms","start":"2026-05-30T01:52:36.352862Z","end":"2026-05-30T01:52:37.122861Z","steps":["trace[22226125] 'agreement among raft nodes before linearized reading' (duration: 769.957584ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:37.122867Z","caller":"traceutil/trace.go:171","msg":"trace[827767062] range","detail":"{range_begin:/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated; range_end:; response_count:1; response_revision:4840; }","duration":"1.502863534s","start":"2026-05-30T01:52:35.619885Z","end":"2026-05-30T01:52:37.122748Z","steps":["trace[827767062] 'agreement among raft nodes before linearized reading' (duration: 1.502773252s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.122891Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:36.352846Z","time spent":"770.041995ms","remote":"127.0.0.1:41648","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-05-30T01:52:37.122909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.619872Z","time spent":"1.503026187s","remote":"127.0.0.1:41754","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":1,"response size":1366,"request content":"key:\"/registry/secrets/monitoring/alertmanager-kube-prometheus-stack-alertmanager-generated\" "} {"level":"info","ts":"2026-05-30T01:52:37.1226Z","caller":"traceutil/trace.go:171","msg":"trace[475900344] transaction","detail":"{read_only:false; response_revision:4839; number_of_response:1; }","duration":"1.20317706s","start":"2026-05-30T01:52:35.919414Z","end":"2026-05-30T01:52:37.122591Z","steps":["trace[475900344] 'process raft request' (duration: 1.202397402s)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:37.122913Z","caller":"traceutil/trace.go:171","msg":"trace[1885229017] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"365.234043ms","start":"2026-05-30T01:52:36.757672Z","end":"2026-05-30T01:52:37.122906Z","steps":["trace[1885229017] 'process raft request' (duration: 364.414306ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.123105Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.919402Z","time spent":"1.203550288s","remote":"127.0.0.1:40290","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-05-30T01:52:37.12316Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.315857113s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2206966"} {"level":"warn","ts":"2026-05-30T01:52:37.123184Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:36.75763Z","time spent":"365.487509ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:37.123203Z","caller":"traceutil/trace.go:171","msg":"trace[50938229] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4840; }","duration":"1.315944475s","start":"2026-05-30T01:52:35.807248Z","end":"2026-05-30T01:52:37.123193Z","steps":["trace[50938229] 'agreement among raft nodes before linearized reading' (duration: 1.314988885s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.122462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.45697939s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-123283f4-99a8-4386-a73b-a093fdd91b2e\" ","response":"range_response_count:1 size:3645"} {"level":"warn","ts":"2026-05-30T01:52:37.123237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.807228Z","time spent":"1.316000767s","remote":"127.0.0.1:41764","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2206989,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-05-30T01:52:37.123238Z","caller":"traceutil/trace.go:171","msg":"trace[243223122] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-123283f4-99a8-4386-a73b-a093fdd91b2e; range_end:; response_count:1; response_revision:4840; }","duration":"1.457809728s","start":"2026-05-30T01:52:35.665419Z","end":"2026-05-30T01:52:37.123229Z","steps":["trace[243223122] 'agreement among raft nodes before linearized reading' (duration: 1.456917469s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.123268Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.665398Z","time spent":"1.457860589s","remote":"127.0.0.1:40214","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3668,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-123283f4-99a8-4386-a73b-a093fdd91b2e\" "} {"level":"warn","ts":"2026-05-30T01:52:37.125271Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429154832s","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-05-30T01:52:37.125747Z","caller":"traceutil/trace.go:171","msg":"trace[590082042] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4840; }","duration":"1.429549921s","start":"2026-05-30T01:52:35.696073Z","end":"2026-05-30T01:52:37.125623Z","steps":["trace[590082042] 'agreement among raft nodes before linearized reading' (duration: 1.426373841s)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.125914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:35.696064Z","time spent":"1.429834186s","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":530,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-05-30T01:52:37.131279Z","caller":"traceutil/trace.go:171","msg":"trace[2074380104] transaction","detail":"{read_only:false; response_revision:4841; number_of_response:1; }","duration":"210.191579ms","start":"2026-05-30T01:52:36.921076Z","end":"2026-05-30T01:52:37.131267Z","steps":["trace[2074380104] 'process raft request' (duration: 210.097607ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.131433Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.987972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:2743"} {"level":"info","ts":"2026-05-30T01:52:37.131473Z","caller":"traceutil/trace.go:171","msg":"trace[342024929] range","detail":"{range_begin:/registry/cert-manager.io/certificates/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4841; }","duration":"214.062454ms","start":"2026-05-30T01:52:36.9174Z","end":"2026-05-30T01:52:37.131463Z","steps":["trace[342024929] 'agreement among raft nodes before linearized reading' (duration: 213.954272ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:37.131472Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.946129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls\" ","response":"range_response_count:1 size:4792"} {"level":"info","ts":"2026-05-30T01:52:37.131513Z","caller":"traceutil/trace.go:171","msg":"trace[1809720954] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus-0-tls; range_end:; response_count:1; response_revision:4841; }","duration":"207.075272ms","start":"2026-05-30T01:52:36.924428Z","end":"2026-05-30T01:52:37.131503Z","steps":["trace[1809720954] 'agreement among raft nodes before linearized reading' (duration: 206.924089ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:43.161708Z","caller":"traceutil/trace.go:171","msg":"trace[1003302167] transaction","detail":"{read_only:false; response_revision:4922; number_of_response:1; }","duration":"224.453758ms","start":"2026-05-30T01:52:42.937233Z","end":"2026-05-30T01:52:43.161687Z","steps":["trace[1003302167] 'process raft request' (duration: 224.307424ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:48.123266Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.872094ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-05-30T01:52:48.123636Z","caller":"traceutil/trace.go:171","msg":"trace[103570358] linearizableReadLoop","detail":"{readStateIndex:5145; appliedIndex:5144; }","duration":"316.499182ms","start":"2026-05-30T01:52:47.807116Z","end":"2026-05-30T01:52:48.123615Z","steps":["trace[103570358] 'read index received' (duration: 201.297572ms)","trace[103570358] 'applied index is now lower than readState.Index' (duration: 115.19927ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:52:48.123672Z","caller":"traceutil/trace.go:171","msg":"trace[411809007] transaction","detail":"{read_only:false; response_revision:4957; number_of_response:1; }","duration":"315.824828ms","start":"2026-05-30T01:52:47.807823Z","end":"2026-05-30T01:52:48.123647Z","steps":["trace[411809007] 'process raft request' (duration: 315.546432ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:48.123821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:47.807806Z","time spent":"315.93992ms","remote":"127.0.0.1:40188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":893,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:48.123858Z","caller":"traceutil/trace.go:171","msg":"trace[1002119637] transaction","detail":"{read_only:false; response_revision:4956; number_of_response:1; }","duration":"316.81777ms","start":"2026-05-30T01:52:47.80703Z","end":"2026-05-30T01:52:48.123848Z","steps":["trace[1002119637] 'process raft request' (duration: 201.305982ms)","trace[1002119637] 'compare' (duration: 114.665229ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:52:48.123913Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.369221ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-05-30T01:52:48.123962Z","caller":"traceutil/trace.go:171","msg":"trace[1143496136] range","detail":"{range_begin:/registry/monitoring.coreos.com/thanosrulers/; range_end:/registry/monitoring.coreos.com/thanosrulers0; response_count:0; response_revision:4959; }","duration":"309.418192ms","start":"2026-05-30T01:52:47.814534Z","end":"2026-05-30T01:52:48.123953Z","steps":["trace[1143496136] 'agreement among raft nodes before linearized reading' (duration: 309.35284ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:48.123984Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:47.814503Z","time spent":"309.474192ms","remote":"127.0.0.1:44134","response type":"/etcdserverpb.KV/Range","request count":0,"request size":96,"response count":0,"response size":28,"request content":"key:\"/registry/monitoring.coreos.com/thanosrulers/\" range_end:\"/registry/monitoring.coreos.com/thanosrulers0\" count_only:true "} {"level":"warn","ts":"2026-05-30T01:52:48.124015Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.88471ms","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":"warn","ts":"2026-05-30T01:52:48.124046Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:47.807006Z","time spent":"316.922381ms","remote":"127.0.0.1:40306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1429,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:48.124084Z","caller":"traceutil/trace.go:171","msg":"trace[2103315407] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-keystone-server-0; range_end:; response_count:1; response_revision:4959; }","duration":"316.988543ms","start":"2026-05-30T01:52:47.807076Z","end":"2026-05-30T01:52:48.124064Z","steps":["trace[2103315407] 'agreement among raft nodes before linearized reading' (duration: 316.809109ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:48.124142Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:47.807057Z","time spent":"317.071244ms","remote":"127.0.0.1:40178","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-05-30T01:52:48.123668Z","caller":"traceutil/trace.go:171","msg":"trace[1552803331] transaction","detail":"{read_only:false; response_revision:4959; number_of_response:1; }","duration":"315.780567ms","start":"2026-05-30T01:52:47.807878Z","end":"2026-05-30T01:52:48.123658Z","steps":["trace[1552803331] 'process raft request' (duration: 315.564683ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:48.123691Z","caller":"traceutil/trace.go:171","msg":"trace[1650382149] transaction","detail":"{read_only:false; response_revision:4958; number_of_response:1; }","duration":"315.802407ms","start":"2026-05-30T01:52:47.807883Z","end":"2026-05-30T01:52:48.123685Z","steps":["trace[1650382149] 'process raft request' (duration: 315.533962ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:52:48.124258Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:47.807813Z","time spent":"316.39927ms","remote":"127.0.0.1:40188","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":951,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:52:48.124315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:52:47.807873Z","time spent":"316.41781ms","remote":"127.0.0.1:40306","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1506,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:52:55.407855Z","caller":"traceutil/trace.go:171","msg":"trace[1117107118] transaction","detail":"{read_only:false; response_revision:5002; number_of_response:1; }","duration":"105.771119ms","start":"2026-05-30T01:52:55.302058Z","end":"2026-05-30T01:52:55.407829Z","steps":["trace[1117107118] 'process raft request' (duration: 105.557035ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:52:55.407997Z","caller":"traceutil/trace.go:171","msg":"trace[1343562487] transaction","detail":"{read_only:false; response_revision:5003; number_of_response:1; }","duration":"105.671717ms","start":"2026-05-30T01:52:55.302269Z","end":"2026-05-30T01:52:55.407941Z","steps":["trace[1343562487] 'process raft request' (duration: 105.477113ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:15.832985Z","caller":"traceutil/trace.go:171","msg":"trace[899061094] transaction","detail":"{read_only:false; response_revision:5220; number_of_response:1; }","duration":"128.185152ms","start":"2026-05-30T01:53:15.70477Z","end":"2026-05-30T01:53:15.832955Z","steps":["trace[899061094] 'process raft request' (duration: 128.016379ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:21.689896Z","caller":"traceutil/trace.go:171","msg":"trace[637060349] transaction","detail":"{read_only:false; response_revision:5256; number_of_response:1; }","duration":"103.297128ms","start":"2026-05-30T01:53:21.586577Z","end":"2026-05-30T01:53:21.689874Z","steps":["trace[637060349] 'process raft request' (duration: 103.258397ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:21.690021Z","caller":"traceutil/trace.go:171","msg":"trace[1967121539] transaction","detail":"{read_only:false; response_revision:5255; number_of_response:1; }","duration":"137.055993ms","start":"2026-05-30T01:53:21.552958Z","end":"2026-05-30T01:53:21.690014Z","steps":["trace[1967121539] 'process raft request' (duration: 113.254347ms)","trace[1967121539] 'compare' (duration: 23.533081ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:53:21.690091Z","caller":"traceutil/trace.go:171","msg":"trace[17665962] linearizableReadLoop","detail":"{readStateIndex:5452; appliedIndex:5451; }","duration":"107.369468ms","start":"2026-05-30T01:53:21.582706Z","end":"2026-05-30T01:53:21.690076Z","steps":["trace[17665962] 'read index received' (duration: 83.587903ms)","trace[17665962] 'applied index is now lower than readState.Index' (duration: 23.780475ms)"],"step_count":2} {"level":"warn","ts":"2026-05-30T01:53:21.690279Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.710196ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-05-30T01:53:21.690317Z","caller":"traceutil/trace.go:171","msg":"trace[746503841] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5256; }","duration":"137.770137ms","start":"2026-05-30T01:53:21.552534Z","end":"2026-05-30T01:53:21.690304Z","steps":["trace[746503841] 'agreement among raft nodes before linearized reading' (duration: 137.600313ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:53:23.786917Z","caller":"traceutil/trace.go:171","msg":"trace[713031511] transaction","detail":"{read_only:false; response_revision:5267; number_of_response:1; }","duration":"102.697259ms","start":"2026-05-30T01:53:23.684193Z","end":"2026-05-30T01:53:23.78689Z","steps":["trace[713031511] 'process raft request' (duration: 83.427655ms)","trace[713031511] 'compare' (duration: 18.193363ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:53:43.81779Z","caller":"traceutil/trace.go:171","msg":"trace[1445036956] transaction","detail":"{read_only:false; response_revision:5415; number_of_response:1; }","duration":"140.1469ms","start":"2026-05-30T01:53:43.677615Z","end":"2026-05-30T01:53:43.817762Z","steps":["trace[1445036956] 'process raft request' (duration: 139.890446ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:53:43.817837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.250774ms","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-05-30T01:53:43.817903Z","caller":"traceutil/trace.go:171","msg":"trace[512858321] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5415; }","duration":"108.345906ms","start":"2026-05-30T01:53:43.709537Z","end":"2026-05-30T01:53:43.817883Z","steps":["trace[512858321] 'agreement among raft nodes before linearized reading' (duration: 108.133362ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:01.889429Z","caller":"traceutil/trace.go:171","msg":"trace[550639188] transaction","detail":"{read_only:false; response_revision:5543; number_of_response:1; }","duration":"392.024868ms","start":"2026-05-30T01:54:01.497378Z","end":"2026-05-30T01:54:01.889403Z","steps":["trace[550639188] 'process raft request' (duration: 391.902035ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:01.889702Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:54:01.497357Z","time spent":"392.161571ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:54:01.965135Z","caller":"traceutil/trace.go:171","msg":"trace[1656868195] transaction","detail":"{read_only:false; response_revision:5544; number_of_response:1; }","duration":"350.307301ms","start":"2026-05-30T01:54:01.614798Z","end":"2026-05-30T01:54:01.965105Z","steps":["trace[1656868195] 'process raft request' (duration: 350.029005ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:01.96534Z","caller":"traceutil/trace.go:171","msg":"trace[753004008] transaction","detail":"{read_only:false; response_revision:5548; number_of_response:1; }","duration":"160.684052ms","start":"2026-05-30T01:54:01.804643Z","end":"2026-05-30T01:54:01.965327Z","steps":["trace[753004008] 'process raft request' (duration: 160.446317ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:01.965298Z","caller":"traceutil/trace.go:171","msg":"trace[897698114] transaction","detail":"{read_only:false; response_revision:5547; number_of_response:1; }","duration":"288.265399ms","start":"2026-05-30T01:54:01.677006Z","end":"2026-05-30T01:54:01.965271Z","steps":["trace[897698114] 'process raft request' (duration: 288.050505ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:01.965149Z","caller":"traceutil/trace.go:171","msg":"trace[1898540299] linearizableReadLoop","detail":"{readStateIndex:5753; appliedIndex:5748; }","duration":"211.845687ms","start":"2026-05-30T01:54:01.753286Z","end":"2026-05-30T01:54:01.965131Z","steps":["trace[1898540299] 'read index received' (duration: 135.865943ms)","trace[1898540299] 'applied index is now lower than readState.Index' (duration: 75.978814ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:01.965414Z","caller":"traceutil/trace.go:171","msg":"trace[130356011] transaction","detail":"{read_only:false; response_revision:5546; number_of_response:1; }","duration":"288.749359ms","start":"2026-05-30T01:54:01.676641Z","end":"2026-05-30T01:54:01.96539Z","steps":["trace[130356011] 'process raft request' (duration: 288.378031ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:01.96518Z","caller":"traceutil/trace.go:171","msg":"trace[1158518120] transaction","detail":"{read_only:false; response_revision:5545; number_of_response:1; }","duration":"336.849256ms","start":"2026-05-30T01:54:01.628294Z","end":"2026-05-30T01:54:01.965143Z","steps":["trace[1158518120] 'process raft request' (duration: 336.655712ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:01.965768Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:54:01.62828Z","time spent":"337.382526ms","remote":"127.0.0.1:41668","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":25,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-05-30T01:54:01.965292Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"211.978929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-05-30T01:54:01.965952Z","caller":"traceutil/trace.go:171","msg":"trace[564846160] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:5548; }","duration":"212.641442ms","start":"2026-05-30T01:54:01.753247Z","end":"2026-05-30T01:54:01.965888Z","steps":["trace[564846160] 'agreement among raft nodes before linearized reading' (duration: 211.939869ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:01.966821Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-05-30T01:54:01.614774Z","time spent":"351.997452ms","remote":"127.0.0.1:40290","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":521,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-05-30T01:54:02.033298Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2881} {"level":"info","ts":"2026-05-30T01:54:02.098149Z","caller":"traceutil/trace.go:171","msg":"trace[1138259394] transaction","detail":"{read_only:false; response_revision:5550; number_of_response:1; }","duration":"125.378795ms","start":"2026-05-30T01:54:01.972752Z","end":"2026-05-30T01:54:02.09813Z","steps":["trace[1138259394] 'process raft request' (duration: 125.303832ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:02.098199Z","caller":"traceutil/trace.go:171","msg":"trace[126085227] transaction","detail":"{read_only:false; response_revision:5549; number_of_response:1; }","duration":"125.994076ms","start":"2026-05-30T01:54:01.972139Z","end":"2026-05-30T01:54:02.098133Z","steps":["trace[126085227] 'process raft request' (duration: 63.309034ms)","trace[126085227] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/leases/kube-system/kube-controller-manager; req_size:488; } (duration: 62.481678ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:02.098316Z","caller":"traceutil/trace.go:171","msg":"trace[545003580] linearizableReadLoop","detail":"{readStateIndex:5758; appliedIndex:5754; }","duration":"101.711838ms","start":"2026-05-30T01:54:01.996583Z","end":"2026-05-30T01:54:02.098295Z","steps":["trace[545003580] 'read index received' (duration: 2.462207ms)","trace[545003580] 'applied index is now lower than readState.Index' (duration: 99.248211ms)"],"step_count":2} {"level":"info","ts":"2026-05-30T01:54:02.098359Z","caller":"traceutil/trace.go:171","msg":"trace[695073914] transaction","detail":"{read_only:false; response_revision:5551; number_of_response:1; }","duration":"125.524956ms","start":"2026-05-30T01:54:01.97282Z","end":"2026-05-30T01:54:02.098345Z","steps":["trace[695073914] 'process raft request' (duration: 125.280051ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:02.098478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.887471ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:437"} {"level":"info","ts":"2026-05-30T01:54:02.098504Z","caller":"traceutil/trace.go:171","msg":"trace[1348191190] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5551; }","duration":"101.954572ms","start":"2026-05-30T01:54:01.996542Z","end":"2026-05-30T01:54:02.098497Z","steps":["trace[1348191190] 'agreement among raft nodes before linearized reading' (duration: 101.84804ms)"],"step_count":1} {"level":"warn","ts":"2026-05-30T01:54:02.098504Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.2851ms","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-05-30T01:54:02.098531Z","caller":"traceutil/trace.go:171","msg":"trace[1678137343] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5551; }","duration":"100.338361ms","start":"2026-05-30T01:54:01.998185Z","end":"2026-05-30T01:54:02.098523Z","steps":["trace[1678137343] 'agreement among raft nodes before linearized reading' (duration: 100.23753ms)"],"step_count":1} {"level":"info","ts":"2026-05-30T01:54:02.139864Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2881,"took":"105.06068ms","hash":3516126646,"current-db-size-bytes":53612544,"current-db-size":"54 MB","current-db-size-in-use-bytes":29036544,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-05-30T01:54:02.139921Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3516126646,"revision":2881,"compact-revision":-1} {"level":"info","ts":"2026-05-30T01:59:02.040726Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5545} {"level":"info","ts":"2026-05-30T01:59:02.116688Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5545,"took":"74.553763ms","hash":3799849370,"current-db-size-bytes":53612544,"current-db-size":"54 MB","current-db-size-in-use-bytes":18239488,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-05-30T01:59:02.116755Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3799849370,"revision":5545,"compact-revision":2881} {"level":"info","ts":"2026-05-30T02:00:22.121214Z","caller":"traceutil/trace.go:171","msg":"trace[752821594] transaction","detail":"{read_only:false; response_revision:7805; number_of_response:1; }","duration":"111.54778ms","start":"2026-05-30T02:00:22.009634Z","end":"2026-05-30T02:00:22.121182Z","steps":["trace[752821594] 'process raft request' (duration: 97.229352ms)","trace[752821594] 'compare' (duration: 14.046521ms)"],"step_count":2}