{"level":"warn","ts":"2026-04-20T05:42:44.756745Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T05:42:44.756928Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.78: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.78:2380","--initial-cluster=instance=https://199.204.45.78:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.78:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.78: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-04-20T05:42:44.757108Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-20T05:42:44.757142Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-20T05:42:44.757195Z","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-04-20T05:42:44.759218Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"]} {"level":"info","ts":"2026-04-20T05:42:44.759325Z","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.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.78: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-04-20T05:42:44.764752Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"5.035501ms"} {"level":"info","ts":"2026-04-20T05:42:44.775726Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"6eb8766b1ec86e92","cluster-id":"9bbfe9e5d45d3718"} {"level":"info","ts":"2026-04-20T05:42:44.775807Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=()"} {"level":"info","ts":"2026-04-20T05:42:44.77583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 0"} {"level":"info","ts":"2026-04-20T05:42:44.77584Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 6eb8766b1ec86e92 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-20T05:42:44.775847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became follower at term 1"} {"level":"info","ts":"2026-04-20T05:42:44.775885Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"warn","ts":"2026-04-20T05:42:44.784061Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-20T05:42:44.78734Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-20T05:42:44.788763Z","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-04-20T05:42:44.792262Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"6eb8766b1ec86e92","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-20T05:42:44.793304Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"6eb8766b1ec86e92","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-20T05:42:44.793394Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 switched to configuration voters=(7978256942336863890)"} {"level":"info","ts":"2026-04-20T05:42:44.793552Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","added-peer-id":"6eb8766b1ec86e92","added-peer-peer-urls":["https://199.204.45.78:2380"]} {"level":"info","ts":"2026-04-20T05:42:44.79363Z","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-04-20T05:42:44.793711Z","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-04-20T05:42:44.793743Z","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-04-20T05:42:44.799347Z","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-04-20T05:42:44.799516Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-20T05:42:44.799545Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.78:2380"} {"level":"info","ts":"2026-04-20T05:42:44.799556Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"6eb8766b1ec86e92","initial-advertise-peer-urls":["https://199.204.45.78:2380"],"listen-peer-urls":["https://199.204.45.78:2380"],"advertise-client-urls":["https://199.204.45.78:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.78:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-20T05:42:44.799588Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-20T05:42:45.278005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 is starting a new election at term 1"} {"level":"info","ts":"2026-04-20T05:42:45.278051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became pre-candidate at term 1"} {"level":"info","ts":"2026-04-20T05:42:45.278075Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgPreVoteResp from 6eb8766b1ec86e92 at term 1"} {"level":"info","ts":"2026-04-20T05:42:45.278087Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became candidate at term 2"} {"level":"info","ts":"2026-04-20T05:42:45.278093Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 received MsgVoteResp from 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-20T05:42:45.2781Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"6eb8766b1ec86e92 became leader at term 2"} {"level":"info","ts":"2026-04-20T05:42:45.278108Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 6eb8766b1ec86e92 elected leader 6eb8766b1ec86e92 at term 2"} {"level":"info","ts":"2026-04-20T05:42:45.278908Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"6eb8766b1ec86e92","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.78:2379]}","request-path":"/0/members/6eb8766b1ec86e92/attributes","cluster-id":"9bbfe9e5d45d3718","publish-timeout":"7s"} {"level":"info","ts":"2026-04-20T05:42:45.278981Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:42:45.278943Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:42:45.279113Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-20T05:42:45.279264Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-20T05:42:45.279297Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-20T05:42:45.279951Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"9bbfe9e5d45d3718","local-member-id":"6eb8766b1ec86e92","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:42:45.280023Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:42:45.280046Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-20T05:42:45.287681Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.78:2379"} {"level":"info","ts":"2026-04-20T05:42:45.289137Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-20T05:42:48.063378Z","caller":"traceutil/trace.go:171","msg":"trace[83117540] linearizableReadLoop","detail":"{readStateIndex:118; appliedIndex:117; }","duration":"405.288686ms","start":"2026-04-20T05:42:47.658064Z","end":"2026-04-20T05:42:48.063353Z","steps":["trace[83117540] 'read index received' (duration: 405.09812ms)","trace[83117540] 'applied index is now lower than readState.Index' (duration: 189.566µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:42:48.063527Z","caller":"traceutil/trace.go:171","msg":"trace[404921018] transaction","detail":"{read_only:false; response_revision:113; number_of_response:1; }","duration":"407.183653ms","start":"2026-04-20T05:42:47.656309Z","end":"2026-04-20T05:42:48.063492Z","steps":["trace[404921018] 'process raft request' (duration: 406.905845ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:42:48.063716Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"391.073099ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T05:42:48.063762Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"405.668627ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/system:aggregate-to-admin\" ","response":"range_response_count:0 size:4"} {"level":"info","ts":"2026-04-20T05:42:48.06381Z","caller":"traceutil/trace.go:171","msg":"trace[1177631888] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:113; }","duration":"391.222603ms","start":"2026-04-20T05:42:47.672573Z","end":"2026-04-20T05:42:48.063796Z","steps":["trace[1177631888] 'agreement among raft nodes before linearized reading' (duration: 390.961196ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:42:48.063853Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:42:47.672555Z","time spent":"391.289077ms","remote":"127.0.0.1:53324","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-04-20T05:42:48.063885Z","caller":"traceutil/trace.go:171","msg":"trace[2055144140] range","detail":"{range_begin:/registry/clusterroles/system:aggregate-to-admin; range_end:; response_count:0; response_revision:113; }","duration":"405.784391ms","start":"2026-04-20T05:42:47.658042Z","end":"2026-04-20T05:42:48.063827Z","steps":["trace[2055144140] 'agreement among raft nodes before linearized reading' (duration: 405.482102ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:42:48.064005Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:42:47.658033Z","time spent":"405.887484ms","remote":"127.0.0.1:53614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/system:aggregate-to-admin\" "} {"level":"warn","ts":"2026-04-20T05:42:48.064129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:42:47.656291Z","time spent":"407.310407ms","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":429,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T05:42:48.77669Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"519.461939ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:14"} {"level":"info","ts":"2026-04-20T05:42:48.776795Z","caller":"traceutil/trace.go:171","msg":"trace[1693349616] linearizableReadLoop","detail":"{readStateIndex:119; appliedIndex:118; }","duration":"706.910505ms","start":"2026-04-20T05:42:48.069868Z","end":"2026-04-20T05:42:48.776779Z","steps":["trace[1693349616] 'read index received' (duration: 187.186568ms)","trace[1693349616] 'applied index is now lower than readState.Index' (duration: 519.722897ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:42:48.776898Z","caller":"traceutil/trace.go:171","msg":"trace[577473102] transaction","detail":"{read_only:false; response_revision:114; number_of_response:1; }","duration":"708.132632ms","start":"2026-04-20T05:42:48.068698Z","end":"2026-04-20T05:42:48.776831Z","steps":["trace[577473102] 'process raft request' (duration: 188.318682ms)","trace[577473102] 'compare' (duration: 519.345716ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:42:48.776954Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.07568ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/edit\" ","response":"range_response_count:0 size:4"} {"level":"warn","ts":"2026-04-20T05:42:48.777117Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:42:48.068683Z","time spent":"708.343018ms","remote":"127.0.0.1:53628","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":464,"response count":0,"response size":37,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-04-20T05:42:48.777158Z","caller":"traceutil/trace.go:171","msg":"trace[919549337] range","detail":"{range_begin:/registry/clusterroles/edit; range_end:; response_count:0; response_revision:114; }","duration":"707.300237ms","start":"2026-04-20T05:42:48.069836Z","end":"2026-04-20T05:42:48.777136Z","steps":["trace[919549337] 'agreement among raft nodes before linearized reading' (duration: 707.030459ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:42:48.777262Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:42:48.069823Z","time spent":"707.41248ms","remote":"127.0.0.1:53614","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":0,"response size":27,"request content":"key:\"/registry/clusterroles/edit\" "} {"level":"info","ts":"2026-04-20T05:43:20.500688Z","caller":"traceutil/trace.go:171","msg":"trace[1524195456] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"223.448881ms","start":"2026-04-20T05:43:20.277204Z","end":"2026-04-20T05:43:20.500653Z","steps":["trace[1524195456] 'process raft request' (duration: 222.872173ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:43:20.760109Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.211827ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:43:20.760245Z","caller":"traceutil/trace.go:171","msg":"trace[530124038] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:607; }","duration":"166.375311ms","start":"2026-04-20T05:43:20.59385Z","end":"2026-04-20T05:43:20.760225Z","steps":["trace[530124038] 'range keys from in-memory index tree' (duration: 166.181946ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:43:20.760922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"128.72019ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:43:20.761072Z","caller":"traceutil/trace.go:171","msg":"trace[88326898] transaction","detail":"{read_only:false; response_revision:608; number_of_response:1; }","duration":"257.013308ms","start":"2026-04-20T05:43:20.504001Z","end":"2026-04-20T05:43:20.761014Z","steps":["trace[88326898] 'process raft request' (duration: 128.002278ms)","trace[88326898] 'compare' (duration: 128.415521ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:43:21.122352Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.847613ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:43:21.122529Z","caller":"traceutil/trace.go:171","msg":"trace[1355640660] linearizableReadLoop","detail":"{readStateIndex:632; appliedIndex:630; }","duration":"147.427558ms","start":"2026-04-20T05:43:20.975085Z","end":"2026-04-20T05:43:21.122512Z","steps":["trace[1355640660] 'read index received' (duration: 58.603µs)","trace[1355640660] 'applied index is now lower than readState.Index' (duration: 147.367965ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:43:21.122623Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.544321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:43:21.122657Z","caller":"traceutil/trace.go:171","msg":"trace[159000874] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:610; }","duration":"147.613784ms","start":"2026-04-20T05:43:20.975033Z","end":"2026-04-20T05:43:21.122646Z","steps":["trace[159000874] 'agreement among raft nodes before linearized reading' (duration: 147.534512ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:43:21.122655Z","caller":"traceutil/trace.go:171","msg":"trace[390465682] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"606.865488ms","start":"2026-04-20T05:43:20.515747Z","end":"2026-04-20T05:43:21.122613Z","steps":["trace[390465682] 'process raft request' (duration: 453.678896ms)","trace[390465682] 'compare' (duration: 152.740329ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:43:21.122771Z","caller":"traceutil/trace.go:171","msg":"trace[555305777] transaction","detail":"{read_only:false; response_revision:610; number_of_response:1; }","duration":"572.247489ms","start":"2026-04-20T05:43:20.550493Z","end":"2026-04-20T05:43:21.122741Z","steps":["trace[555305777] 'process raft request' (duration: 571.95024ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:43:21.122906Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:43:20.550475Z","time spent":"572.366693ms","remote":"127.0.0.1:53624","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-04-20T05:43:21.122791Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:43:20.515731Z","time spent":"606.985242ms","remote":"127.0.0.1:53482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17130,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:43:21.874166Z","caller":"traceutil/trace.go:171","msg":"trace[1564679011] linearizableReadLoop","detail":"{readStateIndex:633; appliedIndex:632; }","duration":"258.390571ms","start":"2026-04-20T05:43:21.615728Z","end":"2026-04-20T05:43:21.874119Z","steps":["trace[1564679011] 'read index received' (duration: 248.885553ms)","trace[1564679011] 'applied index is now lower than readState.Index' (duration: 9.504288ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:43:21.874186Z","caller":"traceutil/trace.go:171","msg":"trace[651994783] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"337.927222ms","start":"2026-04-20T05:43:21.536234Z","end":"2026-04-20T05:43:21.874161Z","steps":["trace[651994783] 'process raft request' (duration: 329.158495ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:43:21.874355Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"258.611907ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"warn","ts":"2026-04-20T05:43:21.874387Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:43:21.536213Z","time spent":"338.111807ms","remote":"127.0.0.1:53394","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036277,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:43:21.874429Z","caller":"traceutil/trace.go:171","msg":"trace[703556016] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:611; }","duration":"258.722571ms","start":"2026-04-20T05:43:21.615681Z","end":"2026-04-20T05:43:21.874404Z","steps":["trace[703556016] 'agreement among raft nodes before linearized reading' (duration: 258.543345ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:43:21.876082Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.691655ms","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-04-20T05:43:21.876156Z","caller":"traceutil/trace.go:171","msg":"trace[2023298856] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:612; }","duration":"145.800478ms","start":"2026-04-20T05:43:21.730338Z","end":"2026-04-20T05:43:21.876138Z","steps":["trace[2023298856] 'agreement among raft nodes before linearized reading' (duration: 145.647054ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:43:37.372132Z","caller":"traceutil/trace.go:171","msg":"trace[158013965] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"161.983368ms","start":"2026-04-20T05:43:37.210127Z","end":"2026-04-20T05:43:37.37211Z","steps":["trace[158013965] 'process raft request' (duration: 161.816623ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:44:05.305166Z","caller":"traceutil/trace.go:171","msg":"trace[454401123] transaction","detail":"{read_only:false; response_revision:1175; number_of_response:1; }","duration":"311.913899ms","start":"2026-04-20T05:44:04.993231Z","end":"2026-04-20T05:44:05.305145Z","steps":["trace[454401123] 'process raft request' (duration: 311.780535ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:05.305304Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:04.993213Z","time spent":"312.016901ms","remote":"127.0.0.1:53560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:44:31.080612Z","caller":"traceutil/trace.go:171","msg":"trace[1750768474] transaction","detail":"{read_only:false; response_revision:1477; number_of_response:1; }","duration":"122.408358ms","start":"2026-04-20T05:44:30.958175Z","end":"2026-04-20T05:44:31.080584Z","steps":["trace[1750768474] 'process raft request' (duration: 93.562907ms)","trace[1750768474] 'compare' (duration: 28.57014ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:44:31.080663Z","caller":"traceutil/trace.go:171","msg":"trace[707778348] transaction","detail":"{read_only:false; response_revision:1478; number_of_response:1; }","duration":"121.221045ms","start":"2026-04-20T05:44:30.959407Z","end":"2026-04-20T05:44:31.080628Z","steps":["trace[707778348] 'process raft request' (duration: 121.050235ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:44:31.080602Z","caller":"traceutil/trace.go:171","msg":"trace[1867780755] linearizableReadLoop","detail":"{readStateIndex:1521; appliedIndex:1518; }","duration":"107.048865ms","start":"2026-04-20T05:44:30.973529Z","end":"2026-04-20T05:44:31.080578Z","steps":["trace[1867780755] 'read index received' (duration: 17.014027ms)","trace[1867780755] 'applied index is now lower than readState.Index' (duration: 90.033898ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:44:31.080875Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.574697ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/ingress-nginx/ingress-nginx-leader\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:44:31.0809Z","caller":"traceutil/trace.go:171","msg":"trace[1017033147] range","detail":"{range_begin:/registry/leases/ingress-nginx/ingress-nginx-leader; range_end:; response_count:0; response_revision:1479; }","duration":"100.640218ms","start":"2026-04-20T05:44:30.980254Z","end":"2026-04-20T05:44:31.080894Z","steps":["trace[1017033147] 'agreement among raft nodes before linearized reading' (duration: 100.541367ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:31.080864Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"107.321295ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:44:31.08098Z","caller":"traceutil/trace.go:171","msg":"trace[884349638] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1479; }","duration":"107.488447ms","start":"2026-04-20T05:44:30.973476Z","end":"2026-04-20T05:44:31.080965Z","steps":["trace[884349638] 'agreement among raft nodes before linearized reading' (duration: 107.176816ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:44:52.146988Z","caller":"traceutil/trace.go:171","msg":"trace[1617488729] transaction","detail":"{read_only:false; response_revision:1851; number_of_response:1; }","duration":"384.865454ms","start":"2026-04-20T05:44:51.762095Z","end":"2026-04-20T05:44:52.146961Z","steps":["trace[1617488729] 'process raft request' (duration: 384.668042ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.147145Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:51.762065Z","time spent":"384.996326ms","remote":"127.0.0.1:53560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:44:52.339262Z","caller":"traceutil/trace.go:171","msg":"trace[1143729823] linearizableReadLoop","detail":"{readStateIndex:1921; appliedIndex:1919; }","duration":"381.034108ms","start":"2026-04-20T05:44:51.958204Z","end":"2026-04-20T05:44:52.339238Z","steps":["trace[1143729823] 'read index received' (duration: 188.65334ms)","trace[1143729823] 'applied index is now lower than readState.Index' (duration: 192.379808ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:44:52.339379Z","caller":"traceutil/trace.go:171","msg":"trace[1869660028] transaction","detail":"{read_only:false; response_revision:1852; number_of_response:1; }","duration":"428.844064ms","start":"2026-04-20T05:44:51.910521Z","end":"2026-04-20T05:44:52.339365Z","steps":["trace[1869660028] 'process raft request' (duration: 389.706741ms)","trace[1869660028] 'compare' (duration: 38.891ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:44:52.339483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.456931ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:44:52.339505Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:51.910505Z","time spent":"428.900554ms","remote":"127.0.0.1:53560","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-04-20T05:44:52.339538Z","caller":"traceutil/trace.go:171","msg":"trace[1632192648] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1852; }","duration":"364.581304ms","start":"2026-04-20T05:44:51.974942Z","end":"2026-04-20T05:44:52.339523Z","steps":["trace[1632192648] 'agreement among raft nodes before linearized reading' (duration: 364.465152ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.339614Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:51.974923Z","time spent":"364.640214ms","remote":"127.0.0.1:53324","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-04-20T05:44:52.339986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.743407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-948ac47f-5bd2-4589-90ed-40cab449f86f\" ","response":"range_response_count:1 size:3626"} {"level":"info","ts":"2026-04-20T05:44:52.340074Z","caller":"traceutil/trace.go:171","msg":"trace[216753213] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-948ac47f-5bd2-4589-90ed-40cab449f86f; range_end:; response_count:1; response_revision:1852; }","duration":"381.903758ms","start":"2026-04-20T05:44:51.95815Z","end":"2026-04-20T05:44:52.340054Z","steps":["trace[216753213] 'agreement among raft nodes before linearized reading' (duration: 381.605765ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.34019Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:51.958127Z","time spent":"381.984088ms","remote":"127.0.0.1:53482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3649,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-948ac47f-5bd2-4589-90ed-40cab449f86f\" "} {"level":"info","ts":"2026-04-20T05:44:52.671062Z","caller":"traceutil/trace.go:171","msg":"trace[622060347] linearizableReadLoop","detail":"{readStateIndex:1923; appliedIndex:1921; }","duration":"318.905514ms","start":"2026-04-20T05:44:52.352134Z","end":"2026-04-20T05:44:52.671039Z","steps":["trace[622060347] 'read index received' (duration: 10.964776ms)","trace[622060347] 'applied index is now lower than readState.Index' (duration: 307.939668ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:44:52.671176Z","caller":"traceutil/trace.go:171","msg":"trace[1371528948] transaction","detail":"{read_only:false; response_revision:1854; number_of_response:1; }","duration":"323.557289ms","start":"2026-04-20T05:44:52.347566Z","end":"2026-04-20T05:44:52.671123Z","steps":["trace[1371528948] 'process raft request' (duration: 255.456805ms)","trace[1371528948] 'compare' (duration: 67.898313ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:44:52.671262Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"319.118935ms","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-04-20T05:44:52.671315Z","caller":"traceutil/trace.go:171","msg":"trace[715682397] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1854; }","duration":"319.224488ms","start":"2026-04-20T05:44:52.352078Z","end":"2026-04-20T05:44:52.671302Z","steps":["trace[715682397] 'agreement among raft nodes before linearized reading' (duration: 319.069806ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.671537Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:52.352058Z","time spent":"319.46978ms","remote":"127.0.0.1:42050","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-04-20T05:44:52.671559Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:52.347546Z","time spent":"323.719731ms","remote":"127.0.0.1:53482","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3728,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:44:52.717567Z","caller":"traceutil/trace.go:171","msg":"trace[670976790] transaction","detail":"{read_only:false; response_revision:1855; number_of_response:1; }","duration":"254.417185ms","start":"2026-04-20T05:44:52.463115Z","end":"2026-04-20T05:44:52.717532Z","steps":["trace[670976790] 'process raft request' (duration: 254.211552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.71783Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"344.505394ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-948ac47f-5bd2-4589-90ed-40cab449f86f\" ","response":"range_response_count:1 size:3743"} {"level":"info","ts":"2026-04-20T05:44:52.717884Z","caller":"traceutil/trace.go:171","msg":"trace[1710613978] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-948ac47f-5bd2-4589-90ed-40cab449f86f; range_end:; response_count:1; response_revision:1856; }","duration":"344.600326ms","start":"2026-04-20T05:44:52.373268Z","end":"2026-04-20T05:44:52.717869Z","steps":["trace[1710613978] 'agreement among raft nodes before linearized reading' (duration: 344.470005ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.717918Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:52.373252Z","time spent":"344.657416ms","remote":"127.0.0.1:53482","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-948ac47f-5bd2-4589-90ed-40cab449f86f\" "} {"level":"info","ts":"2026-04-20T05:44:52.717925Z","caller":"traceutil/trace.go:171","msg":"trace[627176558] transaction","detail":"{read_only:false; response_revision:1856; number_of_response:1; }","duration":"254.010671ms","start":"2026-04-20T05:44:52.463876Z","end":"2026-04-20T05:44:52.717886Z","steps":["trace[627176558] 'process raft request' (duration: 253.614317ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.718234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.023736ms","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-04-20T05:44:52.718312Z","caller":"traceutil/trace.go:171","msg":"trace[655290186] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1856; }","duration":"318.150737ms","start":"2026-04-20T05:44:52.400137Z","end":"2026-04-20T05:44:52.718288Z","steps":["trace[655290186] 'agreement among raft nodes before linearized reading' (duration: 317.898294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:44:52.718359Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:44:52.400114Z","time spent":"318.232107ms","remote":"127.0.0.1:53560","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-04-20T05:44:52.809296Z","caller":"traceutil/trace.go:171","msg":"trace[275094261] transaction","detail":"{read_only:false; response_revision:1857; number_of_response:1; }","duration":"109.498619ms","start":"2026-04-20T05:44:52.699767Z","end":"2026-04-20T05:44:52.809266Z","steps":["trace[275094261] 'process raft request' (duration: 102.124747ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:04.929024Z","caller":"traceutil/trace.go:171","msg":"trace[1491425052] transaction","detail":"{read_only:false; response_revision:1959; number_of_response:1; }","duration":"168.710789ms","start":"2026-04-20T05:45:04.760292Z","end":"2026-04-20T05:45:04.929003Z","steps":["trace[1491425052] 'process raft request' (duration: 168.514086ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:08.568956Z","caller":"traceutil/trace.go:171","msg":"trace[2129903871] transaction","detail":"{read_only:false; response_revision:1986; number_of_response:1; }","duration":"125.62099ms","start":"2026-04-20T05:45:08.443306Z","end":"2026-04-20T05:45:08.568927Z","steps":["trace[2129903871] 'process raft request' (duration: 122.422637ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:18.200576Z","caller":"traceutil/trace.go:171","msg":"trace[1264030565] transaction","detail":"{read_only:false; response_revision:2037; number_of_response:1; }","duration":"104.84484ms","start":"2026-04-20T05:45:18.095701Z","end":"2026-04-20T05:45:18.200546Z","steps":["trace[1264030565] 'process raft request' (duration: 104.540905ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:32.208131Z","caller":"traceutil/trace.go:171","msg":"trace[1889168686] linearizableReadLoop","detail":"{readStateIndex:2199; appliedIndex:2198; }","duration":"269.842329ms","start":"2026-04-20T05:45:31.93826Z","end":"2026-04-20T05:45:32.208102Z","steps":["trace[1889168686] 'read index received' (duration: 269.579084ms)","trace[1889168686] 'applied index is now lower than readState.Index' (duration: 262.225µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:45:32.208169Z","caller":"traceutil/trace.go:171","msg":"trace[1630265180] transaction","detail":"{read_only:false; response_revision:2121; number_of_response:1; }","duration":"444.917967ms","start":"2026-04-20T05:45:31.763226Z","end":"2026-04-20T05:45:32.208144Z","steps":["trace[1630265180] 'process raft request' (duration: 444.688552ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:45:32.208322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:45:31.763204Z","time spent":"445.04279ms","remote":"127.0.0.1:53560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:45:32.208362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"270.100203ms","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-04-20T05:45:32.208401Z","caller":"traceutil/trace.go:171","msg":"trace[1926804241] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2121; }","duration":"270.180995ms","start":"2026-04-20T05:45:31.938207Z","end":"2026-04-20T05:45:32.208388Z","steps":["trace[1926804241] 'agreement among raft nodes before linearized reading' (duration: 270.023792ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:33.178972Z","caller":"traceutil/trace.go:171","msg":"trace[411629359] transaction","detail":"{read_only:false; response_revision:2125; number_of_response:1; }","duration":"263.755065ms","start":"2026-04-20T05:45:32.915178Z","end":"2026-04-20T05:45:33.178933Z","steps":["trace[411629359] 'process raft request' (duration: 228.855593ms)","trace[411629359] 'compare' (duration: 34.79192ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:45:33.179007Z","caller":"traceutil/trace.go:171","msg":"trace[1525746690] linearizableReadLoop","detail":"{readStateIndex:2203; appliedIndex:2202; }","duration":"216.46061ms","start":"2026-04-20T05:45:32.962525Z","end":"2026-04-20T05:45:33.178986Z","steps":["trace[1525746690] 'read index received' (duration: 181.521957ms)","trace[1525746690] 'applied index is now lower than readState.Index' (duration: 34.935533ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:45:33.179172Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.602643ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T05:45:33.179266Z","caller":"traceutil/trace.go:171","msg":"trace[172834973] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:2125; }","duration":"216.760285ms","start":"2026-04-20T05:45:32.962484Z","end":"2026-04-20T05:45:33.179244Z","steps":["trace[172834973] 'agreement among raft nodes before linearized reading' (duration: 216.581212ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:45:33.179594Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.494506ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoypatchpolicies/\" range_end:\"/registry/gateway.envoyproxy.io/envoypatchpolicies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:45:33.17966Z","caller":"traceutil/trace.go:171","msg":"trace[69625958] transaction","detail":"{read_only:false; response_revision:2127; number_of_response:1; }","duration":"161.795071ms","start":"2026-04-20T05:45:33.01785Z","end":"2026-04-20T05:45:33.179645Z","steps":["trace[69625958] 'process raft request' (duration: 161.585107ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:33.179724Z","caller":"traceutil/trace.go:171","msg":"trace[363592624] transaction","detail":"{read_only:false; response_revision:2126; number_of_response:1; }","duration":"162.109057ms","start":"2026-04-20T05:45:33.01759Z","end":"2026-04-20T05:45:33.179699Z","steps":["trace[363592624] 'process raft request' (duration: 161.355274ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:45:33.179858Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.764861ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:45:33.179877Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.292309ms","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-04-20T05:45:33.179937Z","caller":"traceutil/trace.go:171","msg":"trace[599318145] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2127; }","duration":"205.912903ms","start":"2026-04-20T05:45:32.974007Z","end":"2026-04-20T05:45:33.17992Z","steps":["trace[599318145] 'agreement among raft nodes before linearized reading' (duration: 205.791731ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:33.179949Z","caller":"traceutil/trace.go:171","msg":"trace[1131792346] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2127; }","duration":"108.400771ms","start":"2026-04-20T05:45:33.071531Z","end":"2026-04-20T05:45:33.179931Z","steps":["trace[1131792346] 'agreement among raft nodes before linearized reading' (duration: 108.130065ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:45:33.180043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.205433ms","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-04-20T05:45:33.180095Z","caller":"traceutil/trace.go:171","msg":"trace[1069179669] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2127; }","duration":"110.296234ms","start":"2026-04-20T05:45:33.069775Z","end":"2026-04-20T05:45:33.180071Z","steps":["trace[1069179669] 'agreement among raft nodes before linearized reading' (duration: 109.867626ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:45:33.179661Z","caller":"traceutil/trace.go:171","msg":"trace[1216971038] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoypatchpolicies/; range_end:/registry/gateway.envoyproxy.io/envoypatchpolicies0; response_count:0; response_revision:2127; }","duration":"213.578338ms","start":"2026-04-20T05:45:32.966067Z","end":"2026-04-20T05:45:33.179645Z","steps":["trace[1216971038] 'agreement among raft nodes before linearized reading' (duration: 213.451236ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:46:31.637462Z","caller":"traceutil/trace.go:171","msg":"trace[1571935311] transaction","detail":"{read_only:false; response_revision:2541; number_of_response:1; }","duration":"256.637024ms","start":"2026-04-20T05:46:31.38078Z","end":"2026-04-20T05:46:31.637417Z","steps":["trace[1571935311] 'process raft request' (duration: 256.445769ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:46:31.647906Z","caller":"traceutil/trace.go:171","msg":"trace[575809792] transaction","detail":"{read_only:false; response_revision:2543; number_of_response:1; }","duration":"225.038582ms","start":"2026-04-20T05:46:31.422843Z","end":"2026-04-20T05:46:31.647882Z","steps":["trace[575809792] 'process raft request' (duration: 224.95842ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:46:31.647943Z","caller":"traceutil/trace.go:171","msg":"trace[454596881] transaction","detail":"{read_only:false; response_revision:2542; number_of_response:1; }","duration":"228.900592ms","start":"2026-04-20T05:46:31.419021Z","end":"2026-04-20T05:46:31.647922Z","steps":["trace[454596881] 'process raft request' (duration: 228.460452ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:46:31.648067Z","caller":"traceutil/trace.go:171","msg":"trace[1742184125] transaction","detail":"{read_only:false; response_revision:2544; number_of_response:1; }","duration":"217.561571ms","start":"2026-04-20T05:46:31.430486Z","end":"2026-04-20T05:46:31.648048Z","steps":["trace[1742184125] 'process raft request' (duration: 217.360775ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:46:31.648089Z","caller":"traceutil/trace.go:171","msg":"trace[1986409358] linearizableReadLoop","detail":"{readStateIndex:2637; appliedIndex:2632; }","duration":"177.909534ms","start":"2026-04-20T05:46:31.470159Z","end":"2026-04-20T05:46:31.648069Z","steps":["trace[1986409358] 'read index received' (duration: 167.120435ms)","trace[1986409358] 'applied index is now lower than readState.Index' (duration: 10.788219ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:46:31.648111Z","caller":"traceutil/trace.go:171","msg":"trace[1653622161] transaction","detail":"{read_only:false; response_revision:2545; number_of_response:1; }","duration":"186.844321ms","start":"2026-04-20T05:46:31.461252Z","end":"2026-04-20T05:46:31.648097Z","steps":["trace[1653622161] 'process raft request' (duration: 186.728337ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:46:31.648264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"178.096009ms","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-04-20T05:46:31.648323Z","caller":"traceutil/trace.go:171","msg":"trace[397698609] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2545; }","duration":"178.197321ms","start":"2026-04-20T05:46:31.470112Z","end":"2026-04-20T05:46:31.648309Z","steps":["trace[397698609] 'agreement among raft nodes before linearized reading' (duration: 178.033907ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:46:31.648374Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.611046ms","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-04-20T05:46:31.648452Z","caller":"traceutil/trace.go:171","msg":"trace[2122330538] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:2545; }","duration":"167.742358ms","start":"2026-04-20T05:46:31.480692Z","end":"2026-04-20T05:46:31.648434Z","steps":["trace[2122330538] 'agreement among raft nodes before linearized reading' (duration: 167.499753ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:47:04.213986Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"226.259637ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:47:04.214196Z","caller":"traceutil/trace.go:171","msg":"trace[1916588670] transaction","detail":"{read_only:false; response_revision:2723; number_of_response:1; }","duration":"390.616429ms","start":"2026-04-20T05:47:03.82355Z","end":"2026-04-20T05:47:04.214166Z","steps":["trace[1916588670] 'process raft request' (duration: 164.058654ms)","trace[1916588670] 'compare' (duration: 226.051061ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:47:04.21425Z","caller":"traceutil/trace.go:171","msg":"trace[1901328130] linearizableReadLoop","detail":"{readStateIndex:2822; appliedIndex:2821; }","duration":"279.637607ms","start":"2026-04-20T05:47:03.934454Z","end":"2026-04-20T05:47:04.214091Z","steps":["trace[1901328130] 'read index received' (duration: 53.183764ms)","trace[1901328130] 'applied index is now lower than readState.Index' (duration: 226.451543ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:47:04.214471Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:47:03.823535Z","time spent":"390.765543ms","remote":"127.0.0.1:53560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":491,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:47:04.214586Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"241.426889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:47:04.214603Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"280.122768ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/\" range_end:\"/registry/persistentvolumeclaims0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-04-20T05:47:04.214688Z","caller":"traceutil/trace.go:171","msg":"trace[904903442] range","detail":"{range_begin:/registry/persistentvolumeclaims/; range_end:/registry/persistentvolumeclaims0; response_count:0; response_revision:2723; }","duration":"280.260042ms","start":"2026-04-20T05:47:03.93441Z","end":"2026-04-20T05:47:04.21467Z","steps":["trace[904903442] 'agreement among raft nodes before linearized reading' (duration: 280.095318ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:47:04.214634Z","caller":"traceutil/trace.go:171","msg":"trace[1506192993] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2723; }","duration":"241.522291ms","start":"2026-04-20T05:47:03.973099Z","end":"2026-04-20T05:47:04.214621Z","steps":["trace[1506192993] 'agreement among raft nodes before linearized reading' (duration: 241.426109ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:49:54.689489Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.325424ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-20T05:49:54.689641Z","caller":"traceutil/trace.go:171","msg":"trace[946616241] transaction","detail":"{read_only:false; response_revision:3715; number_of_response:1; }","duration":"181.409646ms","start":"2026-04-20T05:49:54.508209Z","end":"2026-04-20T05:49:54.689618Z","steps":["trace[946616241] 'process raft request' (duration: 54.866558ms)","trace[946616241] 'compare' (duration: 126.169602ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:49:54.712576Z","caller":"traceutil/trace.go:171","msg":"trace[123064408] transaction","detail":"{read_only:false; response_revision:3716; number_of_response:1; }","duration":"202.583484ms","start":"2026-04-20T05:49:54.509969Z","end":"2026-04-20T05:49:54.712553Z","steps":["trace[123064408] 'process raft request' (duration: 202.430422ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:44.725444Z","caller":"traceutil/trace.go:171","msg":"trace[1446654525] linearizableReadLoop","detail":"{readStateIndex:4596; appliedIndex:4595; }","duration":"118.317228ms","start":"2026-04-20T05:50:44.607109Z","end":"2026-04-20T05:50:44.725426Z","steps":["trace[1446654525] 'read index received' (duration: 118.241657ms)","trace[1446654525] 'applied index is now lower than readState.Index' (duration: 74.891µs)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:44.725561Z","caller":"traceutil/trace.go:171","msg":"trace[508852338] transaction","detail":"{read_only:false; response_revision:4426; number_of_response:1; }","duration":"135.462254ms","start":"2026-04-20T05:50:44.590064Z","end":"2026-04-20T05:50:44.725526Z","steps":["trace[508852338] 'process raft request' (duration: 135.263331ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:44.725659Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.534632ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-20T05:50:44.725704Z","caller":"traceutil/trace.go:171","msg":"trace[1881260284] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4426; }","duration":"118.630704ms","start":"2026-04-20T05:50:44.607061Z","end":"2026-04-20T05:50:44.725691Z","steps":["trace[1881260284] 'agreement among raft nodes before linearized reading' (duration: 118.464201ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:44.730078Z","caller":"traceutil/trace.go:171","msg":"trace[184428669] transaction","detail":"{read_only:false; response_revision:4427; number_of_response:1; }","duration":"112.316927ms","start":"2026-04-20T05:50:44.61774Z","end":"2026-04-20T05:50:44.730057Z","steps":["trace[184428669] 'process raft request' (duration: 111.723657ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:44.730142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"117.478983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/storageclasses/general\" ","response":"range_response_count:1 size:1124"} {"level":"info","ts":"2026-04-20T05:50:44.730188Z","caller":"traceutil/trace.go:171","msg":"trace[108203554] range","detail":"{range_begin:/registry/storageclasses/general; range_end:; response_count:1; response_revision:4429; }","duration":"117.528493ms","start":"2026-04-20T05:50:44.612647Z","end":"2026-04-20T05:50:44.730175Z","steps":["trace[108203554] 'agreement among raft nodes before linearized reading' (duration: 117.406821ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:44.730433Z","caller":"traceutil/trace.go:171","msg":"trace[606759940] transaction","detail":"{read_only:false; response_revision:4428; number_of_response:1; }","duration":"112.536982ms","start":"2026-04-20T05:50:44.617883Z","end":"2026-04-20T05:50:44.73042Z","steps":["trace[606759940] 'process raft request' (duration: 111.695937ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:50.209891Z","caller":"traceutil/trace.go:171","msg":"trace[1333149733] linearizableReadLoop","detail":"{readStateIndex:4763; appliedIndex:4761; }","duration":"315.871878ms","start":"2026-04-20T05:50:49.894002Z","end":"2026-04-20T05:50:50.209874Z","steps":["trace[1333149733] 'read index received' (duration: 309.871987ms)","trace[1333149733] 'applied index is now lower than readState.Index' (duration: 5.999211ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:50.209914Z","caller":"traceutil/trace.go:171","msg":"trace[1853208571] transaction","detail":"{read_only:false; response_revision:4587; number_of_response:1; }","duration":"350.915952ms","start":"2026-04-20T05:50:49.858969Z","end":"2026-04-20T05:50:50.209885Z","steps":["trace[1853208571] 'process raft request' (duration: 350.847991ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:50.210035Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:49.858945Z","time spent":"351.020104ms","remote":"127.0.0.1:53560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:50:50.210054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"316.046631ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:11454"} {"level":"info","ts":"2026-04-20T05:50:50.210081Z","caller":"traceutil/trace.go:171","msg":"trace[524206390] range","detail":"{range_begin:/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4587; }","duration":"316.108643ms","start":"2026-04-20T05:50:49.893965Z","end":"2026-04-20T05:50:50.210074Z","steps":["trace[524206390] 'agreement among raft nodes before linearized reading' (duration: 315.994401ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:50.210067Z","caller":"traceutil/trace.go:171","msg":"trace[84052524] transaction","detail":"{read_only:false; response_revision:4586; number_of_response:1; }","duration":"354.64512ms","start":"2026-04-20T05:50:49.855399Z","end":"2026-04-20T05:50:50.210044Z","steps":["trace[84052524] 'process raft request' (duration: 348.459375ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:50.210243Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:49.855375Z","time spent":"354.760843ms","remote":"127.0.0.1:53346","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":118,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-20T05:50:50.210102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:49.893934Z","time spent":"316.163573ms","remote":"127.0.0.1:53482","response type":"/etcdserverpb.KV/Range","request count":0,"request size":77,"response count":1,"response size":11477,"request content":"key:\"/registry/pods/monitoring/alertmanager-kube-prometheus-stack-alertmanager-0\" "} {"level":"info","ts":"2026-04-20T05:50:50.220299Z","caller":"traceutil/trace.go:171","msg":"trace[2000747454] transaction","detail":"{read_only:false; response_revision:4589; number_of_response:1; }","duration":"267.518517ms","start":"2026-04-20T05:50:49.952757Z","end":"2026-04-20T05:50:50.220275Z","steps":["trace[2000747454] 'process raft request' (duration: 267.354194ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:50.220382Z","caller":"traceutil/trace.go:171","msg":"trace[1715842501] transaction","detail":"{read_only:false; response_revision:4588; number_of_response:1; }","duration":"325.64996ms","start":"2026-04-20T05:50:49.894715Z","end":"2026-04-20T05:50:50.220365Z","steps":["trace[1715842501] 'process raft request' (duration: 325.288873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:50.220464Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:50:49.894697Z","time spent":"325.728142ms","remote":"127.0.0.1:53384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":816,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-20T05:50:50.221008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.148669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/controllers/\" range_end:\"/registry/controllers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-04-20T05:50:50.221021Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"247.451063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-20T05:50:50.221054Z","caller":"traceutil/trace.go:171","msg":"trace[1557419111] range","detail":"{range_begin:/registry/controllers/; range_end:/registry/controllers0; response_count:0; response_revision:4590; }","duration":"209.20925ms","start":"2026-04-20T05:50:50.011834Z","end":"2026-04-20T05:50:50.221043Z","steps":["trace[1557419111] 'agreement among raft nodes before linearized reading' (duration: 209.141889ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:50.221064Z","caller":"traceutil/trace.go:171","msg":"trace[295549523] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4590; }","duration":"247.537725ms","start":"2026-04-20T05:50:49.973515Z","end":"2026-04-20T05:50:50.221053Z","steps":["trace[295549523] 'agreement among raft nodes before linearized reading' (duration: 247.463484ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:50.221238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"229.475498ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-04-20T05:50:50.221281Z","caller":"traceutil/trace.go:171","msg":"trace[1641147732] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4590; }","duration":"229.541449ms","start":"2026-04-20T05:50:49.991727Z","end":"2026-04-20T05:50:50.221269Z","steps":["trace[1641147732] 'agreement among raft nodes before linearized reading' (duration: 229.420377ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:56.051616Z","caller":"traceutil/trace.go:171","msg":"trace[1609529807] transaction","detail":"{read_only:false; response_revision:4706; number_of_response:1; }","duration":"112.459859ms","start":"2026-04-20T05:50:55.939124Z","end":"2026-04-20T05:50:56.051584Z","steps":["trace[1609529807] 'process raft request' (duration: 112.079072ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:56.394595Z","caller":"traceutil/trace.go:171","msg":"trace[276122119] linearizableReadLoop","detail":"{readStateIndex:4893; appliedIndex:4889; }","duration":"163.636662ms","start":"2026-04-20T05:50:56.230938Z","end":"2026-04-20T05:50:56.394575Z","steps":["trace[276122119] 'read index received' (duration: 142.343149ms)","trace[276122119] 'applied index is now lower than readState.Index' (duration: 21.292553ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:56.394704Z","caller":"traceutil/trace.go:171","msg":"trace[1755482137] transaction","detail":"{read_only:false; response_revision:4714; number_of_response:1; }","duration":"229.578793ms","start":"2026-04-20T05:50:56.165112Z","end":"2026-04-20T05:50:56.394691Z","steps":["trace[1755482137] 'process raft request' (duration: 229.322528ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:56.394863Z","caller":"traceutil/trace.go:171","msg":"trace[1169230583] transaction","detail":"{read_only:false; response_revision:4713; number_of_response:1; }","duration":"230.028581ms","start":"2026-04-20T05:50:56.164811Z","end":"2026-04-20T05:50:56.39484Z","steps":["trace[1169230583] 'process raft request' (duration: 208.459072ms)","trace[1169230583] 'compare' (duration: 21.037199ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:50:56.394988Z","caller":"traceutil/trace.go:171","msg":"trace[165603378] transaction","detail":"{read_only:false; response_revision:4716; number_of_response:1; }","duration":"226.953453ms","start":"2026-04-20T05:50:56.16803Z","end":"2026-04-20T05:50:56.394983Z","steps":["trace[165603378] 'process raft request' (duration: 226.505375ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:56.39514Z","caller":"traceutil/trace.go:171","msg":"trace[11313855] transaction","detail":"{read_only:false; response_revision:4715; number_of_response:1; }","duration":"229.390639ms","start":"2026-04-20T05:50:56.165706Z","end":"2026-04-20T05:50:56.395096Z","steps":["trace[11313855] 'process raft request' (duration: 228.786947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:56.395167Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.203564ms","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-04-20T05:50:56.395258Z","caller":"traceutil/trace.go:171","msg":"trace[1917917948] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4716; }","duration":"164.355817ms","start":"2026-04-20T05:50:56.230883Z","end":"2026-04-20T05:50:56.395239Z","steps":["trace[1917917948] 'agreement among raft nodes before linearized reading' (duration: 164.107401ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:50:56.448279Z","caller":"traceutil/trace.go:171","msg":"trace[297217372] transaction","detail":"{read_only:false; response_revision:4717; number_of_response:1; }","duration":"205.664838ms","start":"2026-04-20T05:50:56.242587Z","end":"2026-04-20T05:50:56.448252Z","steps":["trace[297217372] 'process raft request' (duration: 205.488105ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:50:56.448379Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.293016ms","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-04-20T05:50:56.448459Z","caller":"traceutil/trace.go:171","msg":"trace[230439961] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4717; }","duration":"163.412018ms","start":"2026-04-20T05:50:56.285027Z","end":"2026-04-20T05:50:56.448439Z","steps":["trace[230439961] 'agreement among raft nodes before linearized reading' (duration: 163.210063ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:05.233795Z","caller":"traceutil/trace.go:171","msg":"trace[1975717129] linearizableReadLoop","detail":"{readStateIndex:5023; appliedIndex:5022; }","duration":"116.108315ms","start":"2026-04-20T05:51:05.117661Z","end":"2026-04-20T05:51:05.233769Z","steps":["trace[1975717129] 'read index received' (duration: 57.091014ms)","trace[1975717129] 'applied index is now lower than readState.Index' (duration: 59.016291ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:51:05.234016Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.337669ms","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-04-20T05:51:05.233998Z","caller":"traceutil/trace.go:171","msg":"trace[543354513] transaction","detail":"{read_only:false; response_revision:4840; number_of_response:1; }","duration":"146.454291ms","start":"2026-04-20T05:51:05.087517Z","end":"2026-04-20T05:51:05.233971Z","steps":["trace[543354513] 'process raft request' (duration: 87.233516ms)","trace[543354513] 'compare' (duration: 58.802617ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:05.234055Z","caller":"traceutil/trace.go:171","msg":"trace[797138210] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:4840; }","duration":"116.413801ms","start":"2026-04-20T05:51:05.117628Z","end":"2026-04-20T05:51:05.234041Z","steps":["trace[797138210] 'agreement among raft nodes before linearized reading' (duration: 116.243628ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:10.994506Z","caller":"traceutil/trace.go:171","msg":"trace[579918837] transaction","detail":"{read_only:false; response_revision:4896; number_of_response:1; }","duration":"413.930978ms","start":"2026-04-20T05:51:10.580547Z","end":"2026-04-20T05:51:10.994478Z","steps":["trace[579918837] 'process raft request' (duration: 413.740934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:10.994663Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:10.580528Z","time spent":"414.05529ms","remote":"127.0.0.1:53560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:51:11.015935Z","caller":"traceutil/trace.go:171","msg":"trace[1873271968] transaction","detail":"{read_only:false; response_revision:4897; number_of_response:1; }","duration":"435.247444ms","start":"2026-04-20T05:51:10.580619Z","end":"2026-04-20T05:51:11.015866Z","steps":["trace[1873271968] 'process raft request' (duration: 434.955458ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:11.016141Z","caller":"traceutil/trace.go:171","msg":"trace[1206194174] transaction","detail":"{read_only:false; response_revision:4898; number_of_response:1; }","duration":"435.04052ms","start":"2026-04-20T05:51:10.581057Z","end":"2026-04-20T05:51:11.016097Z","steps":["trace[1206194174] 'process raft request' (duration: 434.706974ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:11.016207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:10.580593Z","time spent":"435.458888ms","remote":"127.0.0.1:53560","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-04-20T05:51:11.016321Z","caller":"traceutil/trace.go:171","msg":"trace[797562750] transaction","detail":"{read_only:false; response_revision:4899; number_of_response:1; }","duration":"166.221247ms","start":"2026-04-20T05:51:10.85008Z","end":"2026-04-20T05:51:11.016302Z","steps":["trace[797562750] 'process raft request' (duration: 165.973873ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:51:11.016325Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-20T05:51:10.581033Z","time spent":"435.201073ms","remote":"127.0.0.1:53560","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":476,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-20T05:51:11.298096Z","caller":"traceutil/trace.go:171","msg":"trace[1432667084] transaction","detail":"{read_only:false; response_revision:4904; number_of_response:1; }","duration":"103.356013ms","start":"2026-04-20T05:51:11.194717Z","end":"2026-04-20T05:51:11.298073Z","steps":["trace[1432667084] 'process raft request' (duration: 103.18621ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:11.298467Z","caller":"traceutil/trace.go:171","msg":"trace[1977942463] transaction","detail":"{read_only:false; response_revision:4905; number_of_response:1; }","duration":"100.190742ms","start":"2026-04-20T05:51:11.198256Z","end":"2026-04-20T05:51:11.298447Z","steps":["trace[1977942463] 'process raft request' (duration: 99.749723ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:11.298922Z","caller":"traceutil/trace.go:171","msg":"trace[8537309] transaction","detail":"{read_only:false; response_revision:4903; number_of_response:1; }","duration":"106.122137ms","start":"2026-04-20T05:51:11.19189Z","end":"2026-04-20T05:51:11.298013Z","steps":["trace[8537309] 'process raft request' (duration: 59.26081ms)","trace[8537309] 'compare' (duration: 46.538681ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:11.540799Z","caller":"traceutil/trace.go:171","msg":"trace[2002306755] transaction","detail":"{read_only:false; response_revision:4912; number_of_response:1; }","duration":"159.605264ms","start":"2026-04-20T05:51:11.381158Z","end":"2026-04-20T05:51:11.540763Z","steps":["trace[2002306755] 'process raft request' (duration: 96.803755ms)","trace[2002306755] 'compare' (duration: 62.608025ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:51:49.559148Z","caller":"traceutil/trace.go:171","msg":"trace[461554910] transaction","detail":"{read_only:false; response_revision:5226; number_of_response:1; }","duration":"141.289576ms","start":"2026-04-20T05:51:49.417833Z","end":"2026-04-20T05:51:49.559123Z","steps":["trace[461554910] 'process raft request' (duration: 141.073692ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:51:56.075125Z","caller":"traceutil/trace.go:171","msg":"trace[935982618] transaction","detail":"{read_only:false; response_revision:5263; number_of_response:1; }","duration":"224.280686ms","start":"2026-04-20T05:51:55.850816Z","end":"2026-04-20T05:51:56.075096Z","steps":["trace[935982618] 'process raft request' (duration: 224.110672ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:21.884248Z","caller":"traceutil/trace.go:171","msg":"trace[1183045824] transaction","detail":"{read_only:false; response_revision:5461; number_of_response:1; }","duration":"178.16481ms","start":"2026-04-20T05:52:21.706039Z","end":"2026-04-20T05:52:21.884204Z","steps":["trace[1183045824] 'process raft request' (duration: 104.74512ms)","trace[1183045824] 'compare' (duration: 73.258127ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:52:21.884301Z","caller":"traceutil/trace.go:171","msg":"trace[150957354] linearizableReadLoop","detail":"{readStateIndex:5662; appliedIndex:5661; }","duration":"163.128684ms","start":"2026-04-20T05:52:21.721146Z","end":"2026-04-20T05:52:21.884275Z","steps":["trace[150957354] 'read index received' (duration: 89.658202ms)","trace[150957354] 'applied index is now lower than readState.Index' (duration: 73.467272ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:52:21.884734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.573345ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-db-sync\" ","response":"range_response_count:1 size:8132"} {"level":"warn","ts":"2026-04-20T05:52:21.884758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"160.468727ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/keystone-fernet-setup\" ","response":"range_response_count:1 size:6092"} {"level":"info","ts":"2026-04-20T05:52:21.884789Z","caller":"traceutil/trace.go:171","msg":"trace[643883250] range","detail":"{range_begin:/registry/jobs/openstack/keystone-db-sync; range_end:; response_count:1; response_revision:5462; }","duration":"163.670746ms","start":"2026-04-20T05:52:21.721105Z","end":"2026-04-20T05:52:21.884775Z","steps":["trace[643883250] 'agreement among raft nodes before linearized reading' (duration: 163.439811ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:21.884806Z","caller":"traceutil/trace.go:171","msg":"trace[1103473973] range","detail":"{range_begin:/registry/jobs/openstack/keystone-fernet-setup; range_end:; response_count:1; response_revision:5462; }","duration":"160.56884ms","start":"2026-04-20T05:52:21.724223Z","end":"2026-04-20T05:52:21.884792Z","steps":["trace[1103473973] 'agreement among raft nodes before linearized reading' (duration: 160.377326ms)"],"step_count":1} {"level":"warn","ts":"2026-04-20T05:52:21.884873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.813481ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-04-20T05:52:21.884911Z","caller":"traceutil/trace.go:171","msg":"trace[1972449302] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5462; }","duration":"104.911923ms","start":"2026-04-20T05:52:21.779989Z","end":"2026-04-20T05:52:21.884901Z","steps":["trace[1972449302] 'agreement among raft nodes before linearized reading' (duration: 104.78379ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:21.884287Z","caller":"traceutil/trace.go:171","msg":"trace[613560405] transaction","detail":"{read_only:false; response_revision:5462; number_of_response:1; }","duration":"144.321497ms","start":"2026-04-20T05:52:21.73993Z","end":"2026-04-20T05:52:21.884251Z","steps":["trace[613560405] 'process raft request' (duration: 144.260056ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:52:45.463754Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2939} {"level":"info","ts":"2026-04-20T05:52:45.552999Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2939,"took":"87.803985ms","hash":1078184108,"current-db-size-bytes":53321728,"current-db-size":"53 MB","current-db-size-in-use-bytes":29286400,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-04-20T05:52:45.553062Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1078184108,"revision":2939,"compact-revision":-1} {"level":"info","ts":"2026-04-20T05:54:51.587499Z","caller":"traceutil/trace.go:171","msg":"trace[75659137] transaction","detail":"{read_only:false; response_revision:6491; number_of_response:1; }","duration":"105.546466ms","start":"2026-04-20T05:54:51.481863Z","end":"2026-04-20T05:54:51.58741Z","steps":["trace[75659137] 'process raft request' (duration: 105.403102ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:55:12.269054Z","caller":"traceutil/trace.go:171","msg":"trace[1334223527] linearizableReadLoop","detail":"{readStateIndex:6893; appliedIndex:6892; }","duration":"104.998007ms","start":"2026-04-20T05:55:12.164037Z","end":"2026-04-20T05:55:12.269035Z","steps":["trace[1334223527] 'read index received' (duration: 85.093463ms)","trace[1334223527] 'applied index is now lower than readState.Index' (duration: 19.903954ms)"],"step_count":2} {"level":"info","ts":"2026-04-20T05:55:12.269348Z","caller":"traceutil/trace.go:171","msg":"trace[634078299] transaction","detail":"{read_only:false; response_revision:6648; number_of_response:1; }","duration":"147.760993ms","start":"2026-04-20T05:55:12.121554Z","end":"2026-04-20T05:55:12.269315Z","steps":["trace[634078299] 'process raft request' (duration: 127.610194ms)","trace[634078299] 'compare' (duration: 19.793831ms)"],"step_count":2} {"level":"warn","ts":"2026-04-20T05:55:12.269624Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.59361ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/\" range_end:\"/registry/secrets/ingress-nginx0\" ","response":"range_response_count:2 size:107259"} {"level":"info","ts":"2026-04-20T05:55:12.269657Z","caller":"traceutil/trace.go:171","msg":"trace[1322557824] range","detail":"{range_begin:/registry/secrets/ingress-nginx/; range_end:/registry/secrets/ingress-nginx0; response_count:2; response_revision:6648; }","duration":"105.772655ms","start":"2026-04-20T05:55:12.163876Z","end":"2026-04-20T05:55:12.269649Z","steps":["trace[1322557824] 'agreement among raft nodes before linearized reading' (duration: 105.227693ms)"],"step_count":1} {"level":"info","ts":"2026-04-20T05:57:45.471669Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5630} {"level":"info","ts":"2026-04-20T05:57:45.571197Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5630,"took":"98.209848ms","hash":286568594,"current-db-size-bytes":53321728,"current-db-size":"53 MB","current-db-size-in-use-bytes":18259968,"current-db-size-in-use":"18 MB"} {"level":"info","ts":"2026-04-20T05:57:45.571254Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":286568594,"revision":5630,"compact-revision":2939}