{"level":"warn","ts":"2026-06-06T02:04:09.324739Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-06T02:04:09.324864Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.235: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.235:2380","--initial-cluster=instance=https://199.204.45.235:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.235:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.235:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-06-06T02:04:09.324947Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-06-06T02:04:09.324958Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-06-06T02:04:09.32498Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-06T02:04:09.325689Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"]} {"level":"info","ts":"2026-06-06T02:04:09.325775Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":16,"max-cpu-available":16,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.235:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-06-06T02:04:09.329623Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.632435ms"} {"level":"info","ts":"2026-06-06T02:04:09.336686Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"aab6040abcf11","cluster-id":"2bae7d3d8857c059"} {"level":"info","ts":"2026-06-06T02:04:09.336773Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=()"} {"level":"info","ts":"2026-06-06T02:04:09.336799Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 0"} {"level":"info","ts":"2026-06-06T02:04:09.336815Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft aab6040abcf11 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-06-06T02:04:09.336836Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became follower at term 1"} {"level":"info","ts":"2026-06-06T02:04:09.336881Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"warn","ts":"2026-06-06T02:04:09.341686Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-06-06T02:04:09.343172Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-06-06T02:04:09.344382Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-06-06T02:04:09.346888Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"aab6040abcf11","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-06-06T02:04:09.347117Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"aab6040abcf11","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-06-06T02:04:09.347182Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-06T02:04:09.347341Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-06T02:04:09.347371Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-06-06T02:04:09.357561Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 switched to configuration voters=(3003179657318161)"} {"level":"info","ts":"2026-06-06T02:04:09.357785Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","added-peer-id":"aab6040abcf11","added-peer-peer-urls":["https://199.204.45.235:2380"]} {"level":"info","ts":"2026-06-06T02:04:09.360396Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-06-06T02:04:09.360521Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-06-06T02:04:09.360579Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.235:2380"} {"level":"info","ts":"2026-06-06T02:04:09.360876Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"aab6040abcf11","initial-advertise-peer-urls":["https://199.204.45.235:2380"],"listen-peer-urls":["https://199.204.45.235:2380"],"advertise-client-urls":["https://199.204.45.235:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.235:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-06-06T02:04:09.360963Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-06-06T02:04:10.337462Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 is starting a new election at term 1"} {"level":"info","ts":"2026-06-06T02:04:10.337564Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became pre-candidate at term 1"} {"level":"info","ts":"2026-06-06T02:04:10.337607Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgPreVoteResp from aab6040abcf11 at term 1"} {"level":"info","ts":"2026-06-06T02:04:10.337638Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became candidate at term 2"} {"level":"info","ts":"2026-06-06T02:04:10.337649Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 received MsgVoteResp from aab6040abcf11 at term 2"} {"level":"info","ts":"2026-06-06T02:04:10.337668Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"aab6040abcf11 became leader at term 2"} {"level":"info","ts":"2026-06-06T02:04:10.337684Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: aab6040abcf11 elected leader aab6040abcf11 at term 2"} {"level":"info","ts":"2026-06-06T02:04:10.338675Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T02:04:10.339581Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"aab6040abcf11","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.235:2379]}","request-path":"/0/members/aab6040abcf11/attributes","cluster-id":"2bae7d3d8857c059","publish-timeout":"7s"} {"level":"info","ts":"2026-06-06T02:04:10.339785Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-06T02:04:10.339949Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-06-06T02:04:10.340283Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-06-06T02:04:10.340383Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-06-06T02:04:10.34065Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"2bae7d3d8857c059","local-member-id":"aab6040abcf11","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T02:04:10.340844Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T02:04:10.340924Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-06-06T02:04:10.343689Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.235:2379"} {"level":"info","ts":"2026-06-06T02:04:10.344856Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-06-06T02:04:36.570633Z","caller":"traceutil/trace.go:171","msg":"trace[1828703505] transaction","detail":"{read_only:false; response_revision:462; number_of_response:1; }","duration":"186.611813ms","start":"2026-06-06T02:04:36.383988Z","end":"2026-06-06T02:04:36.5706Z","steps":["trace[1828703505] 'process raft request' (duration: 87.040592ms)","trace[1828703505] 'compare' (duration: 99.345276ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:04:36.5707Z","caller":"traceutil/trace.go:171","msg":"trace[649248508] transaction","detail":"{read_only:false; response_revision:464; number_of_response:1; }","duration":"179.65382ms","start":"2026-06-06T02:04:36.391014Z","end":"2026-06-06T02:04:36.570668Z","steps":["trace[649248508] 'process raft request' (duration: 179.574328ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:04:36.570752Z","caller":"traceutil/trace.go:171","msg":"trace[1907639543] transaction","detail":"{read_only:false; response_revision:463; number_of_response:1; }","duration":"185.928219ms","start":"2026-06-06T02:04:36.384771Z","end":"2026-06-06T02:04:36.570699Z","steps":["trace[1907639543] 'process raft request' (duration: 185.744175ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:04:52.50722Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"246.157338ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:477"} {"level":"info","ts":"2026-06-06T02:04:52.50737Z","caller":"traceutil/trace.go:171","msg":"trace[713484204] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:603; }","duration":"246.364653ms","start":"2026-06-06T02:04:52.260983Z","end":"2026-06-06T02:04:52.507348Z","steps":["trace[713484204] 'range keys from in-memory index tree' (duration: 246.008874ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:04:52.52175Z","caller":"traceutil/trace.go:171","msg":"trace[2014074577] transaction","detail":"{read_only:false; response_revision:604; number_of_response:1; }","duration":"258.242719ms","start":"2026-06-06T02:04:52.263486Z","end":"2026-06-06T02:04:52.521729Z","steps":["trace[2014074577] 'process raft request' (duration: 257.883891ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:04:52.531942Z","caller":"traceutil/trace.go:171","msg":"trace[1575529424] transaction","detail":"{read_only:false; response_revision:605; number_of_response:1; }","duration":"216.840164ms","start":"2026-06-06T02:04:52.315081Z","end":"2026-06-06T02:04:52.531921Z","steps":["trace[1575529424] 'process raft request' (duration: 216.683651ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:04:52.532114Z","caller":"traceutil/trace.go:171","msg":"trace[1406192443] transaction","detail":"{read_only:false; response_revision:606; number_of_response:1; }","duration":"165.850734ms","start":"2026-06-06T02:04:52.36625Z","end":"2026-06-06T02:04:52.532101Z","steps":["trace[1406192443] 'process raft request' (duration: 165.62505ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:04:58.513505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.047981ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:26"} {"level":"info","ts":"2026-06-06T02:04:59.431184Z","caller":"traceutil/trace.go:171","msg":"trace[1394114923] transaction","detail":"{read_only:false; response_revision:653; number_of_response:1; }","duration":"339.718164ms","start":"2026-06-06T02:04:59.091419Z","end":"2026-06-06T02:04:59.431137Z","steps":["trace[1394114923] 'process raft request' (duration: 339.315746ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:04:59.431928Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:04:59.091373Z","time spent":"339.915488ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":17134,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T02:05:14.243263Z","caller":"traceutil/trace.go:171","msg":"trace[2001260811] transaction","detail":"{read_only:false; response_revision:809; number_of_response:1; }","duration":"270.220204ms","start":"2026-06-06T02:05:13.972998Z","end":"2026-06-06T02:05:14.243218Z","steps":["trace[2001260811] 'process raft request' (duration: 231.667341ms)","trace[2001260811] 'compare' (duration: 38.257817ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:06:35.184257Z","caller":"traceutil/trace.go:171","msg":"trace[235079822] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"177.716547ms","start":"2026-06-06T02:06:35.006364Z","end":"2026-06-06T02:06:35.18408Z","steps":["trace[235079822] 'process raft request' (duration: 177.379ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:06:47.755191Z","caller":"traceutil/trace.go:171","msg":"trace[1474309246] transaction","detail":"{read_only:false; response_revision:2006; number_of_response:1; }","duration":"170.639412ms","start":"2026-06-06T02:06:47.584527Z","end":"2026-06-06T02:06:47.755167Z","steps":["trace[1474309246] 'process raft request' (duration: 170.480829ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:06:47.756289Z","caller":"traceutil/trace.go:171","msg":"trace[1847847219] transaction","detail":"{read_only:false; response_revision:2007; number_of_response:1; }","duration":"119.015693ms","start":"2026-06-06T02:06:47.637232Z","end":"2026-06-06T02:06:47.756247Z","steps":["trace[1847847219] 'process raft request' (duration: 118.722507ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:07:20.943905Z","caller":"traceutil/trace.go:171","msg":"trace[1006112503] transaction","detail":"{read_only:false; response_revision:2203; number_of_response:1; }","duration":"147.314933ms","start":"2026-06-06T02:07:20.79656Z","end":"2026-06-06T02:07:20.943875Z","steps":["trace[1006112503] 'process raft request' (duration: 147.121089ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:07:26.898357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"360.500807ms","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-06-06T02:07:26.898425Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.937343ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-06-06T02:07:26.898406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"322.711633ms","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-06-06T02:07:26.898519Z","caller":"traceutil/trace.go:171","msg":"trace[684472536] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2233; }","duration":"360.740862ms","start":"2026-06-06T02:07:26.537746Z","end":"2026-06-06T02:07:26.898487Z","steps":["trace[684472536] 'range keys from in-memory index tree' (duration: 360.269942ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:07:26.89855Z","caller":"traceutil/trace.go:171","msg":"trace[603592047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2233; }","duration":"221.109146ms","start":"2026-06-06T02:07:26.677407Z","end":"2026-06-06T02:07:26.898516Z","steps":["trace[603592047] 'range keys from in-memory index tree' (duration: 220.740639ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:07:26.898573Z","caller":"traceutil/trace.go:171","msg":"trace[451886882] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2233; }","duration":"322.901717ms","start":"2026-06-06T02:07:26.575647Z","end":"2026-06-06T02:07:26.898549Z","steps":["trace[451886882] 'range keys from in-memory index tree' (duration: 322.537589ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:07:26.898593Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:07:26.537721Z","time spent":"360.855765ms","remote":"127.0.0.1:46176","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-06-06T02:07:26.898627Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:07:26.575637Z","time spent":"322.975588ms","remote":"127.0.0.1:47660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":74,"response count":1,"response size":5433,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" "} {"level":"warn","ts":"2026-06-06T02:07:26.89838Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"346.677779ms","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-06-06T02:07:26.898959Z","caller":"traceutil/trace.go:171","msg":"trace[811690690] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:2233; }","duration":"347.318191ms","start":"2026-06-06T02:07:26.551625Z","end":"2026-06-06T02:07:26.898943Z","steps":["trace[811690690] 'count revisions from in-memory index tree' (duration: 346.583395ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:07:26.899009Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:07:26.551615Z","time spent":"347.374012ms","remote":"127.0.0.1:37338","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":26,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"info","ts":"2026-06-06T02:07:27.05562Z","caller":"traceutil/trace.go:171","msg":"trace[1126157456] transaction","detail":"{read_only:false; response_revision:2234; number_of_response:1; }","duration":"151.818253ms","start":"2026-06-06T02:07:26.903776Z","end":"2026-06-06T02:07:27.055594Z","steps":["trace[1126157456] 'process raft request' (duration: 151.64813ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:07:27.068742Z","caller":"traceutil/trace.go:171","msg":"trace[929152698] linearizableReadLoop","detail":"{readStateIndex:2318; appliedIndex:2316; }","duration":"102.161847ms","start":"2026-06-06T02:07:26.966528Z","end":"2026-06-06T02:07:27.06869Z","steps":["trace[929152698] 'read index received' (duration: 88.95323ms)","trace[929152698] 'applied index is now lower than readState.Index' (duration: 13.206957ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:07:27.068829Z","caller":"traceutil/trace.go:171","msg":"trace[1409574639] transaction","detail":"{read_only:false; response_revision:2235; number_of_response:1; }","duration":"102.887942ms","start":"2026-06-06T02:07:26.96591Z","end":"2026-06-06T02:07:27.068798Z","steps":["trace[1409574639] 'process raft request' (duration: 102.614977ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:07:27.069051Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.494965ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-06-06T02:07:27.069126Z","caller":"traceutil/trace.go:171","msg":"trace[6271366] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:2235; }","duration":"102.646187ms","start":"2026-06-06T02:07:26.966461Z","end":"2026-06-06T02:07:27.069107Z","steps":["trace[6271366] 'agreement among raft nodes before linearized reading' (duration: 102.392702ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:08:14.831665Z","caller":"traceutil/trace.go:171","msg":"trace[62392589] transaction","detail":"{read_only:false; response_revision:2665; number_of_response:1; }","duration":"186.535186ms","start":"2026-06-06T02:08:14.645092Z","end":"2026-06-06T02:08:14.831627Z","steps":["trace[62392589] 'process raft request' (duration: 186.330632ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:08:14.840304Z","caller":"traceutil/trace.go:171","msg":"trace[1234428079] linearizableReadLoop","detail":"{readStateIndex:2767; appliedIndex:2765; }","duration":"103.912918ms","start":"2026-06-06T02:08:14.736373Z","end":"2026-06-06T02:08:14.840286Z","steps":["trace[1234428079] 'read index received' (duration: 95.032468ms)","trace[1234428079] 'applied index is now lower than readState.Index' (duration: 8.87946ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:08:14.840389Z","caller":"traceutil/trace.go:171","msg":"trace[485073015] transaction","detail":"{read_only:false; response_revision:2666; number_of_response:1; }","duration":"190.539017ms","start":"2026-06-06T02:08:14.649834Z","end":"2026-06-06T02:08:14.840373Z","steps":["trace[485073015] 'process raft request' (duration: 190.314842ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:08:14.84042Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.024281ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/csidrivers/\" range_end:\"/registry/csidrivers0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T02:08:14.840451Z","caller":"traceutil/trace.go:171","msg":"trace[1985524830] range","detail":"{range_begin:/registry/csidrivers/; range_end:/registry/csidrivers0; response_count:0; response_revision:2666; }","duration":"104.084152ms","start":"2026-06-06T02:08:14.736359Z","end":"2026-06-06T02:08:14.840443Z","steps":["trace[1985524830] 'agreement among raft nodes before linearized reading' (duration: 104.000381ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:08:48.783802Z","caller":"traceutil/trace.go:171","msg":"trace[1941717330] linearizableReadLoop","detail":"{readStateIndex:2979; appliedIndex:2978; }","duration":"105.214135ms","start":"2026-06-06T02:08:48.678557Z","end":"2026-06-06T02:08:48.783771Z","steps":["trace[1941717330] 'read index received' (duration: 92.731651ms)","trace[1941717330] 'applied index is now lower than readState.Index' (duration: 12.477134ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:08:48.783966Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.387289ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T02:08:48.784013Z","caller":"traceutil/trace.go:171","msg":"trace[1308200274] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2870; }","duration":"105.503262ms","start":"2026-06-06T02:08:48.678497Z","end":"2026-06-06T02:08:48.784Z","steps":["trace[1308200274] 'agreement among raft nodes before linearized reading' (duration: 105.393749ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:08:49.221095Z","caller":"traceutil/trace.go:171","msg":"trace[1344789225] transaction","detail":"{read_only:false; response_revision:2872; number_of_response:1; }","duration":"231.214792ms","start":"2026-06-06T02:08:48.989838Z","end":"2026-06-06T02:08:49.221052Z","steps":["trace[1344789225] 'process raft request' (duration: 173.94373ms)","trace[1344789225] 'compare' (duration: 57.114079ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:12:55.47873Z","caller":"traceutil/trace.go:171","msg":"trace[708021038] transaction","detail":"{read_only:false; response_revision:5299; number_of_response:1; }","duration":"103.595306ms","start":"2026-06-06T02:12:55.375106Z","end":"2026-06-06T02:12:55.478701Z","steps":["trace[708021038] 'process raft request' (duration: 103.486964ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:12:55.4789Z","caller":"traceutil/trace.go:171","msg":"trace[9992050] transaction","detail":"{read_only:false; response_revision:5298; number_of_response:1; }","duration":"104.081126ms","start":"2026-06-06T02:12:55.374768Z","end":"2026-06-06T02:12:55.478849Z","steps":["trace[9992050] 'process raft request' (duration: 56.779593ms)","trace[9992050] 'compare' (duration: 46.538648ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:12:55.978338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"249.28849ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-06T02:12:55.978564Z","caller":"traceutil/trace.go:171","msg":"trace[1163520395] linearizableReadLoop","detail":"{readStateIndex:5502; appliedIndex:5500; }","duration":"295.682496ms","start":"2026-06-06T02:12:55.682862Z","end":"2026-06-06T02:12:55.978545Z","steps":["trace[1163520395] 'read index received' (duration: 10.622714ms)","trace[1163520395] 'applied index is now lower than readState.Index' (duration: 285.058812ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:12:55.978671Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"295.809638ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T02:12:55.978704Z","caller":"traceutil/trace.go:171","msg":"trace[1213928986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5305; }","duration":"295.909471ms","start":"2026-06-06T02:12:55.682784Z","end":"2026-06-06T02:12:55.978693Z","steps":["trace[1213928986] 'agreement among raft nodes before linearized reading' (duration: 295.816509ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:12:55.978689Z","caller":"traceutil/trace.go:171","msg":"trace[1350860454] transaction","detail":"{read_only:false; response_revision:5305; number_of_response:1; }","duration":"288.832668ms","start":"2026-06-06T02:12:55.689806Z","end":"2026-06-06T02:12:55.978638Z","steps":["trace[1350860454] 'process raft request' (duration: 288.635654ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:12:55.978689Z","caller":"traceutil/trace.go:171","msg":"trace[1846972106] transaction","detail":"{read_only:false; response_revision:5304; number_of_response:1; }","duration":"294.527813ms","start":"2026-06-06T02:12:55.68411Z","end":"2026-06-06T02:12:55.978638Z","steps":["trace[1846972106] 'process raft request' (duration: 44.832793ms)","trace[1846972106] 'get key's previous created_revision and leaseID' {req_type:put; key:/registry/services/endpoints/openstack/memcached; req_size:678; } (duration: 248.899322ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:13:03.854521Z","caller":"traceutil/trace.go:171","msg":"trace[56731303] linearizableReadLoop","detail":"{readStateIndex:5678; appliedIndex:5677; }","duration":"116.161719ms","start":"2026-06-06T02:13:03.738336Z","end":"2026-06-06T02:13:03.854498Z","steps":["trace[56731303] 'read index received' (duration: 115.933265ms)","trace[56731303] 'applied index is now lower than readState.Index' (duration: 227.564µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:13:03.854573Z","caller":"traceutil/trace.go:171","msg":"trace[692560209] transaction","detail":"{read_only:false; response_revision:5473; number_of_response:1; }","duration":"165.877651ms","start":"2026-06-06T02:13:03.688661Z","end":"2026-06-06T02:13:03.854539Z","steps":["trace[692560209] 'process raft request' (duration: 165.669917ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:13:03.854734Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"116.377873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-06-06T02:13:03.854776Z","caller":"traceutil/trace.go:171","msg":"trace[1797520401] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5473; }","duration":"116.483445ms","start":"2026-06-06T02:13:03.738282Z","end":"2026-06-06T02:13:03.854766Z","steps":["trace[1797520401] 'agreement among raft nodes before linearized reading' (duration: 116.322392ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:14:10.376048Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2993} {"level":"info","ts":"2026-06-06T02:14:10.444477Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2993,"took":"66.357014ms","hash":1839865033,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":33959936,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-06T02:14:10.444531Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1839865033,"revision":2993,"compact-revision":-1} {"level":"info","ts":"2026-06-06T02:19:10.383121Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6087} {"level":"info","ts":"2026-06-06T02:19:10.479163Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6087,"took":"94.017816ms","hash":2580407657,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":23379968,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-06-06T02:19:10.479261Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2580407657,"revision":6087,"compact-revision":2993} {"level":"warn","ts":"2026-06-06T02:19:18.404879Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.28152ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/servicemonitors/\" range_end:\"/registry/monitoring.coreos.com/servicemonitors0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-06T02:19:18.404964Z","caller":"traceutil/trace.go:171","msg":"trace[1827747083] range","detail":"{range_begin:/registry/monitoring.coreos.com/servicemonitors/; range_end:/registry/monitoring.coreos.com/servicemonitors0; response_count:0; response_revision:8331; }","duration":"120.416543ms","start":"2026-06-06T02:19:18.284525Z","end":"2026-06-06T02:19:18.404941Z","steps":["trace[1827747083] 'count revisions from in-memory index tree' (duration: 120.180277ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:19:19.390874Z","caller":"traceutil/trace.go:171","msg":"trace[2135724681] linearizableReadLoop","detail":"{readStateIndex:8630; appliedIndex:8629; }","duration":"144.528564ms","start":"2026-06-06T02:19:19.246328Z","end":"2026-06-06T02:19:19.390857Z","steps":["trace[2135724681] 'read index received' (duration: 144.372511ms)","trace[2135724681] 'applied index is now lower than readState.Index' (duration: 155.523µs)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:19:19.391006Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.660837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-06T02:19:19.391033Z","caller":"traceutil/trace.go:171","msg":"trace[1498328219] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8336; }","duration":"144.747169ms","start":"2026-06-06T02:19:19.246278Z","end":"2026-06-06T02:19:19.391026Z","steps":["trace[1498328219] 'agreement among raft nodes before linearized reading' (duration: 144.670257ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:19:19.390996Z","caller":"traceutil/trace.go:171","msg":"trace[2082366183] transaction","detail":"{read_only:false; response_revision:8336; number_of_response:1; }","duration":"324.359821ms","start":"2026-06-06T02:19:19.066601Z","end":"2026-06-06T02:19:19.39096Z","steps":["trace[2082366183] 'process raft request' (duration: 324.155017ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:19:19.391177Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:19:19.066588Z","time spent":"324.487845ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":462,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T02:19:48.050338Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"374.485581ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T02:19:48.050432Z","caller":"traceutil/trace.go:171","msg":"trace[1795144481] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8545; }","duration":"374.643564ms","start":"2026-06-06T02:19:47.675771Z","end":"2026-06-06T02:19:48.050414Z","steps":["trace[1795144481] 'range keys from in-memory index tree' (duration: 374.355009ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:19:48.050463Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:19:47.675736Z","time spent":"374.720396ms","remote":"127.0.0.1:45942","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":26,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-06T02:19:48.050866Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.572507ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-06-06T02:19:48.050983Z","caller":"traceutil/trace.go:171","msg":"trace[555267560] transaction","detail":"{read_only:false; response_revision:8546; number_of_response:1; }","duration":"369.36954ms","start":"2026-06-06T02:19:47.681591Z","end":"2026-06-06T02:19:48.05096Z","steps":["trace[555267560] 'process raft request' (duration: 245.600639ms)","trace[555267560] 'compare' (duration: 123.087876ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:19:48.051065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:19:47.681566Z","time spent":"369.451511ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":540,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T02:19:48.118722Z","caller":"traceutil/trace.go:171","msg":"trace[2053749908] linearizableReadLoop","detail":"{readStateIndex:8849; appliedIndex:8847; }","duration":"365.610285ms","start":"2026-06-06T02:19:47.753077Z","end":"2026-06-06T02:19:48.118687Z","steps":["trace[2053749908] 'read index received' (duration: 174.40886ms)","trace[2053749908] 'applied index is now lower than readState.Index' (duration: 191.200215ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:19:48.118982Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"365.889541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-06-06T02:19:48.119047Z","caller":"traceutil/trace.go:171","msg":"trace[57010026] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/; range_end:/registry/pxc.percona.com/perconaxtradbclusters0; response_count:0; response_revision:8547; }","duration":"366.004162ms","start":"2026-06-06T02:19:47.753027Z","end":"2026-06-06T02:19:48.119032Z","steps":["trace[57010026] 'agreement among raft nodes before linearized reading' (duration: 365.86174ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:19:48.119015Z","caller":"traceutil/trace.go:171","msg":"trace[1908414060] transaction","detail":"{read_only:false; response_revision:8547; number_of_response:1; }","duration":"366.930631ms","start":"2026-06-06T02:19:47.752022Z","end":"2026-06-06T02:19:48.118953Z","steps":["trace[1908414060] 'process raft request' (duration: 366.528123ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:19:48.119102Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:19:47.753009Z","time spent":"366.086345ms","remote":"127.0.0.1:47660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":102,"response count":1,"response size":28,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusters0\" count_only:true "} {"level":"warn","ts":"2026-06-06T02:19:48.119315Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:19:47.752002Z","time spent":"367.136256ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T02:19:48.119072Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.469703ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/policies/\" range_end:\"/registry/rabbitmq.com/policies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T02:19:48.119443Z","caller":"traceutil/trace.go:171","msg":"trace[133411002] range","detail":"{range_begin:/registry/rabbitmq.com/policies/; range_end:/registry/rabbitmq.com/policies0; response_count:0; response_revision:8547; }","duration":"150.89933ms","start":"2026-06-06T02:19:47.968535Z","end":"2026-06-06T02:19:48.119434Z","steps":["trace[133411002] 'agreement among raft nodes before linearized reading' (duration: 150.480532ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:19:50.351756Z","caller":"traceutil/trace.go:171","msg":"trace[1252948594] transaction","detail":"{read_only:false; response_revision:8557; number_of_response:1; }","duration":"125.490604ms","start":"2026-06-06T02:19:50.226236Z","end":"2026-06-06T02:19:50.351726Z","steps":["trace[1252948594] 'process raft request' (duration: 125.2878ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:20:01.378249Z","caller":"traceutil/trace.go:171","msg":"trace[1818598352] transaction","detail":"{read_only:false; response_revision:8661; number_of_response:1; }","duration":"108.819181ms","start":"2026-06-06T02:20:01.269396Z","end":"2026-06-06T02:20:01.378215Z","steps":["trace[1818598352] 'process raft request' (duration: 108.605767ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:20:01.758185Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.328268ms","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-06-06T02:20:01.75827Z","caller":"traceutil/trace.go:171","msg":"trace[1793591531] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8662; }","duration":"162.468511ms","start":"2026-06-06T02:20:01.595782Z","end":"2026-06-06T02:20:01.758251Z","steps":["trace[1793591531] 'range keys from in-memory index tree' (duration: 162.079734ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:20:01.758438Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.051095ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fz5gc\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-06T02:20:01.758597Z","caller":"traceutil/trace.go:171","msg":"trace[2073517310] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fz5gc; range_end:; response_count:1; response_revision:8662; }","duration":"120.261699ms","start":"2026-06-06T02:20:01.638309Z","end":"2026-06-06T02:20:01.75857Z","steps":["trace[2073517310] 'range keys from in-memory index tree' (duration: 119.871081ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:20:01.76029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"104.816851ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:57 size:2224963"} {"level":"info","ts":"2026-06-06T02:20:01.760379Z","caller":"traceutil/trace.go:171","msg":"trace[1911304506] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:57; response_revision:8662; }","duration":"104.941723ms","start":"2026-06-06T02:20:01.655419Z","end":"2026-06-06T02:20:01.76036Z","steps":["trace[1911304506] 'range keys from in-memory index tree' (duration: 103.386333ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:20:46.478819Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024ad.wal"} {"level":"info","ts":"2026-06-06T02:21:16.328267Z","caller":"traceutil/trace.go:171","msg":"trace[691360170] linearizableReadLoop","detail":"{readStateIndex:9732; appliedIndex:9731; }","duration":"103.248885ms","start":"2026-06-06T02:21:16.224991Z","end":"2026-06-06T02:21:16.32824Z","steps":["trace[691360170] 'read index received' (duration: 103.00393ms)","trace[691360170] 'applied index is now lower than readState.Index' (duration: 243.735µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:21:16.328338Z","caller":"traceutil/trace.go:171","msg":"trace[102621742] transaction","detail":"{read_only:false; response_revision:9405; number_of_response:1; }","duration":"182.02458ms","start":"2026-06-06T02:21:16.146277Z","end":"2026-06-06T02:21:16.328302Z","steps":["trace[102621742] 'process raft request' (duration: 181.778245ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:21:16.328543Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"103.5227ms","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-06-06T02:21:16.328608Z","caller":"traceutil/trace.go:171","msg":"trace[1271609319] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:9405; }","duration":"103.660813ms","start":"2026-06-06T02:21:16.224932Z","end":"2026-06-06T02:21:16.328593Z","steps":["trace[1271609319] 'agreement among raft nodes before linearized reading' (duration: 103.459949ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:21:51.191941Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-06T02:21:51.198155Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-06-06T02:21:51.198332Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-06-06T02:24:10.401904Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8288} {"level":"info","ts":"2026-06-06T02:24:10.515529Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8288,"took":"111.153836ms","hash":1309504766,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":26431488,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-06-06T02:24:10.515584Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1309504766,"revision":8288,"compact-revision":6087} {"level":"info","ts":"2026-06-06T02:24:42.442839Z","caller":"traceutil/trace.go:171","msg":"trace[1643051357] transaction","detail":"{read_only:false; response_revision:11150; number_of_response:1; }","duration":"102.259339ms","start":"2026-06-06T02:24:42.340556Z","end":"2026-06-06T02:24:42.442815Z","steps":["trace[1643051357] 'process raft request' (duration: 102.103556ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:24:42.451959Z","caller":"traceutil/trace.go:171","msg":"trace[127008806] transaction","detail":"{read_only:false; response_revision:11151; number_of_response:1; }","duration":"111.079726ms","start":"2026-06-06T02:24:42.340862Z","end":"2026-06-06T02:24:42.451942Z","steps":["trace[127008806] 'process raft request' (duration: 110.964734ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:24:42.452155Z","caller":"traceutil/trace.go:171","msg":"trace[1102975121] transaction","detail":"{read_only:false; response_revision:11152; number_of_response:1; }","duration":"110.402593ms","start":"2026-06-06T02:24:42.341697Z","end":"2026-06-06T02:24:42.452099Z","steps":["trace[1102975121] 'process raft request' (duration: 110.203489ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:25:04.804048Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.71365ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T02:25:04.804154Z","caller":"traceutil/trace.go:171","msg":"trace[1400989384] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:11275; }","duration":"127.880393ms","start":"2026-06-06T02:25:04.676255Z","end":"2026-06-06T02:25:04.804135Z","steps":["trace[1400989384] 'range keys from in-memory index tree' (duration: 127.600598ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:25:05.476462Z","caller":"traceutil/trace.go:171","msg":"trace[11688030] transaction","detail":"{read_only:false; response_revision:11278; number_of_response:1; }","duration":"172.831204ms","start":"2026-06-06T02:25:05.303607Z","end":"2026-06-06T02:25:05.476438Z","steps":["trace[11688030] 'process raft request' (duration: 172.696901ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:29:10.40771Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10782} {"level":"info","ts":"2026-06-06T02:29:10.489104Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10782,"took":"78.628986ms","hash":1961307401,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":27389952,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-06-06T02:29:10.489159Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1961307401,"revision":10782,"compact-revision":8288} {"level":"warn","ts":"2026-06-06T02:31:18.097227Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.850713ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12213"} {"level":"info","ts":"2026-06-06T02:31:18.097298Z","caller":"traceutil/trace.go:171","msg":"trace[784655714] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:13793; }","duration":"126.019566ms","start":"2026-06-06T02:31:17.971262Z","end":"2026-06-06T02:31:18.097281Z","steps":["trace[784655714] 'range keys from in-memory index tree' (duration: 125.677279ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:31:35.085786Z","caller":"traceutil/trace.go:171","msg":"trace[811501147] linearizableReadLoop","detail":"{readStateIndex:14366; appliedIndex:14365; }","duration":"303.211716ms","start":"2026-06-06T02:31:34.782549Z","end":"2026-06-06T02:31:35.085761Z","steps":["trace[811501147] 'read index received' (duration: 247.690844ms)","trace[811501147] 'applied index is now lower than readState.Index' (duration: 55.519752ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:31:35.085844Z","caller":"traceutil/trace.go:171","msg":"trace[8975207] transaction","detail":"{read_only:false; response_revision:13891; number_of_response:1; }","duration":"312.022233ms","start":"2026-06-06T02:31:34.773749Z","end":"2026-06-06T02:31:35.085771Z","steps":["trace[8975207] 'process raft request' (duration: 256.42914ms)","trace[8975207] 'compare' (duration: 55.484061ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:31:35.086002Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:31:34.773719Z","time spent":"312.201477ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T02:31:35.086035Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"371.373023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-06-06T02:31:35.086074Z","caller":"traceutil/trace.go:171","msg":"trace[1425136539] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:13891; }","duration":"371.472685ms","start":"2026-06-06T02:31:34.714589Z","end":"2026-06-06T02:31:35.086062Z","steps":["trace[1425136539] 'agreement among raft nodes before linearized reading' (duration: 371.308771ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:31:35.086046Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"307.969612ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/openvswitch-q9n5c\" ","response":"range_response_count:1 size:11628"} {"level":"warn","ts":"2026-06-06T02:31:35.086069Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"373.821771ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-06-06T02:31:35.086118Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:31:34.714565Z","time spent":"371.544337ms","remote":"127.0.0.1:46176","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":"info","ts":"2026-06-06T02:31:35.086141Z","caller":"traceutil/trace.go:171","msg":"trace[1426413646] range","detail":"{range_begin:/registry/pods/openstack/openvswitch-q9n5c; range_end:; response_count:1; response_revision:13891; }","duration":"308.126045ms","start":"2026-06-06T02:31:34.777993Z","end":"2026-06-06T02:31:35.086119Z","steps":["trace[1426413646] 'agreement among raft nodes before linearized reading' (duration: 307.830579ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:31:35.086153Z","caller":"traceutil/trace.go:171","msg":"trace[2027217288] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:13891; }","duration":"373.972484ms","start":"2026-06-06T02:31:34.712159Z","end":"2026-06-06T02:31:35.086131Z","steps":["trace[2027217288] 'agreement among raft nodes before linearized reading' (duration: 373.75146ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:31:35.086198Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:31:34.777974Z","time spent":"308.215456ms","remote":"127.0.0.1:46110","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":11649,"request content":"key:\"/registry/pods/openstack/openvswitch-q9n5c\" "} {"level":"warn","ts":"2026-06-06T02:31:35.0862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:31:34.712116Z","time spent":"374.075276ms","remote":"127.0.0.1:46176","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-06-06T02:31:35.090588Z","caller":"traceutil/trace.go:171","msg":"trace[1354009698] transaction","detail":"{read_only:false; response_revision:13892; number_of_response:1; }","duration":"304.375969ms","start":"2026-06-06T02:31:34.786188Z","end":"2026-06-06T02:31:35.090564Z","steps":["trace[1354009698] 'process raft request' (duration: 304.136984ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:31:35.090718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:31:34.786168Z","time spent":"304.479412ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":37,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T02:31:35.090598Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"201.210465ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/envoyproxies/\" range_end:\"/registry/gateway.envoyproxy.io/envoyproxies0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-06-06T02:31:35.090797Z","caller":"traceutil/trace.go:171","msg":"trace[1457846052] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:13893; }","duration":"201.44322ms","start":"2026-06-06T02:31:34.889325Z","end":"2026-06-06T02:31:35.090769Z","steps":["trace[1457846052] 'agreement among raft nodes before linearized reading' (duration: 201.210646ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:31:35.090604Z","caller":"traceutil/trace.go:171","msg":"trace[826643689] transaction","detail":"{read_only:false; response_revision:13893; number_of_response:1; }","duration":"171.609897ms","start":"2026-06-06T02:31:34.918974Z","end":"2026-06-06T02:31:35.090584Z","steps":["trace[826643689] 'process raft request' (duration: 171.502225ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:31:57.999157Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.412564ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-ee017ad8-e81c-4f10-8b6d-b36ed485a5dc\" ","response":"range_response_count:1 size:3637"} {"level":"info","ts":"2026-06-06T02:31:57.999275Z","caller":"traceutil/trace.go:171","msg":"trace[842860395] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-ee017ad8-e81c-4f10-8b6d-b36ed485a5dc; range_end:; response_count:1; response_revision:14210; }","duration":"130.577957ms","start":"2026-06-06T02:31:57.868671Z","end":"2026-06-06T02:31:57.999249Z","steps":["trace[842860395] 'range keys from in-memory index tree' (duration: 130.21034ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:31:58.201505Z","caller":"traceutil/trace.go:171","msg":"trace[1740570523] transaction","detail":"{read_only:false; response_revision:14211; number_of_response:1; }","duration":"125.578547ms","start":"2026-06-06T02:31:58.075879Z","end":"2026-06-06T02:31:58.201458Z","steps":["trace[1740570523] 'process raft request' (duration: 125.376732ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:32:49.918182Z","caller":"traceutil/trace.go:171","msg":"trace[918556950] linearizableReadLoop","detail":"{readStateIndex:15346; appliedIndex:15345; }","duration":"119.213178ms","start":"2026-06-06T02:32:49.798944Z","end":"2026-06-06T02:32:49.918157Z","steps":["trace[918556950] 'read index received' (duration: 118.992484ms)","trace[918556950] 'applied index is now lower than readState.Index' (duration: 219.394µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:32:49.918246Z","caller":"traceutil/trace.go:171","msg":"trace[155177196] transaction","detail":"{read_only:false; response_revision:14843; number_of_response:1; }","duration":"131.932206ms","start":"2026-06-06T02:32:49.786289Z","end":"2026-06-06T02:32:49.918221Z","steps":["trace[155177196] 'process raft request' (duration: 131.699371ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:32:49.918455Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.496735ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-fz5gc\" ","response":"range_response_count:1 size:6451"} {"level":"info","ts":"2026-06-06T02:32:49.91851Z","caller":"traceutil/trace.go:171","msg":"trace[1173029960] range","detail":"{range_begin:/registry/pods/openstack/keepalived-fz5gc; range_end:; response_count:1; response_revision:14843; }","duration":"119.599556ms","start":"2026-06-06T02:32:49.798895Z","end":"2026-06-06T02:32:49.918495Z","steps":["trace[1173029960] 'agreement among raft nodes before linearized reading' (duration: 119.420813ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:34:10.414303Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12861} {"level":"info","ts":"2026-06-06T02:34:10.489705Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12861,"took":"72.839301ms","hash":4065183840,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":30199808,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-06-06T02:34:10.489759Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":4065183840,"revision":12861,"compact-revision":10782} {"level":"info","ts":"2026-06-06T02:39:10.422045Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":15324} {"level":"info","ts":"2026-06-06T02:39:10.517377Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":15324,"took":"92.220168ms","hash":3330798740,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":31576064,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-06T02:39:10.517437Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3330798740,"revision":15324,"compact-revision":12861} {"level":"info","ts":"2026-06-06T02:39:12.597645Z","caller":"traceutil/trace.go:171","msg":"trace[253084912] transaction","detail":"{read_only:false; response_revision:17605; number_of_response:1; }","duration":"164.623651ms","start":"2026-06-06T02:39:12.433002Z","end":"2026-06-06T02:39:12.597626Z","steps":["trace[253084912] 'process raft request' (duration: 164.460928ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:39:18.401027Z","caller":"traceutil/trace.go:171","msg":"trace[1264816821] transaction","detail":"{read_only:false; response_revision:17641; number_of_response:1; }","duration":"171.344459ms","start":"2026-06-06T02:39:18.229624Z","end":"2026-06-06T02:39:18.400968Z","steps":["trace[1264816821] 'process raft request' (duration: 171.098494ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:39:18.842333Z","caller":"traceutil/trace.go:171","msg":"trace[448519990] linearizableReadLoop","detail":"{readStateIndex:18240; appliedIndex:18239; }","duration":"164.328916ms","start":"2026-06-06T02:39:18.677964Z","end":"2026-06-06T02:39:18.842293Z","steps":["trace[448519990] 'read index received' (duration: 164.04529ms)","trace[448519990] 'applied index is now lower than readState.Index' (duration: 281.956µs)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:39:18.842354Z","caller":"traceutil/trace.go:171","msg":"trace[424542151] transaction","detail":"{read_only:false; response_revision:17643; number_of_response:1; }","duration":"224.870519ms","start":"2026-06-06T02:39:18.617448Z","end":"2026-06-06T02:39:18.842319Z","steps":["trace[424542151] 'process raft request' (duration: 224.577402ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:39:18.842731Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.724834ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T02:39:18.842914Z","caller":"traceutil/trace.go:171","msg":"trace[1628164835] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17643; }","duration":"164.976189ms","start":"2026-06-06T02:39:18.677905Z","end":"2026-06-06T02:39:18.842881Z","steps":["trace[1628164835] 'agreement among raft nodes before linearized reading' (duration: 164.52202ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:39:18.887989Z","caller":"traceutil/trace.go:171","msg":"trace[1331869868] transaction","detail":"{read_only:false; response_revision:17645; number_of_response:1; }","duration":"176.286739ms","start":"2026-06-06T02:39:18.711667Z","end":"2026-06-06T02:39:18.887954Z","steps":["trace[1331869868] 'process raft request' (duration: 176.184337ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:39:18.888012Z","caller":"traceutil/trace.go:171","msg":"trace[1968545868] transaction","detail":"{read_only:false; response_revision:17644; number_of_response:1; }","duration":"178.571857ms","start":"2026-06-06T02:39:18.709403Z","end":"2026-06-06T02:39:18.887974Z","steps":["trace[1968545868] 'process raft request' (duration: 178.26526ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:39:18.88833Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.597666ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/schemareplications/\" range_end:\"/registry/rabbitmq.com/schemareplications0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T02:39:18.88842Z","caller":"traceutil/trace.go:171","msg":"trace[1931511893] range","detail":"{range_begin:/registry/rabbitmq.com/schemareplications/; range_end:/registry/rabbitmq.com/schemareplications0; response_count:0; response_revision:17646; }","duration":"176.747569ms","start":"2026-06-06T02:39:18.711651Z","end":"2026-06-06T02:39:18.888398Z","steps":["trace[1931511893] 'agreement among raft nodes before linearized reading' (duration: 176.592836ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:39:19.392403Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"486.479466ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-06-06T02:39:19.392509Z","caller":"traceutil/trace.go:171","msg":"trace[1868718776] linearizableReadLoop","detail":"{readStateIndex:18244; appliedIndex:18243; }","duration":"504.346779ms","start":"2026-06-06T02:39:18.888143Z","end":"2026-06-06T02:39:19.39249Z","steps":["trace[1868718776] 'read index received' (duration: 17.658889ms)","trace[1868718776] 'applied index is now lower than readState.Index' (duration: 486.68637ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:39:19.392647Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"548.0891ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-06-06T02:39:19.392682Z","caller":"traceutil/trace.go:171","msg":"trace[33636047] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:17646; }","duration":"548.170842ms","start":"2026-06-06T02:39:18.844503Z","end":"2026-06-06T02:39:19.392674Z","steps":["trace[33636047] 'agreement among raft nodes before linearized reading' (duration: 548.093211ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:39:19.392714Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:39:18.844484Z","time spent":"548.222853ms","remote":"127.0.0.1:45944","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-06-06T02:39:19.392773Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"335.020312ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-06T02:39:19.392859Z","caller":"traceutil/trace.go:171","msg":"trace[389265416] range","detail":"{range_begin:/registry/statefulsets/; range_end:/registry/statefulsets0; response_count:0; response_revision:17646; }","duration":"335.139484ms","start":"2026-06-06T02:39:19.057697Z","end":"2026-06-06T02:39:19.392836Z","steps":["trace[389265416] 'agreement among raft nodes before linearized reading' (duration: 334.952691ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:39:19.3929Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:39:19.057599Z","time spent":"335.291967ms","remote":"127.0.0.1:46378","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":15,"response size":29,"request content":"key:\"/registry/statefulsets/\" range_end:\"/registry/statefulsets0\" count_only:true "} {"level":"info","ts":"2026-06-06T02:42:46.967229Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"aab6040abcf11","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-06-06T02:42:46.974053Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-06-06T02:42:46.97426Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-06-06T02:44:10.428378Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17576} {"level":"info","ts":"2026-06-06T02:44:10.529877Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17576,"took":"98.126334ms","hash":1038896856,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":34099200,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-06-06T02:44:10.529928Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1038896856,"revision":17576,"compact-revision":15324} {"level":"info","ts":"2026-06-06T02:45:02.230415Z","caller":"traceutil/trace.go:171","msg":"trace[1074402750] transaction","detail":"{read_only:false; response_revision:20325; number_of_response:1; }","duration":"233.259715ms","start":"2026-06-06T02:45:01.997122Z","end":"2026-06-06T02:45:02.230382Z","steps":["trace[1074402750] 'process raft request' (duration: 233.112262ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:45:02.39488Z","caller":"traceutil/trace.go:171","msg":"trace[706275517] transaction","detail":"{read_only:false; response_revision:20328; number_of_response:1; }","duration":"253.556206ms","start":"2026-06-06T02:45:02.141295Z","end":"2026-06-06T02:45:02.394852Z","steps":["trace[706275517] 'process raft request' (duration: 253.486725ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:45:02.394911Z","caller":"traceutil/trace.go:171","msg":"trace[949904564] transaction","detail":"{read_only:false; response_revision:20326; number_of_response:1; }","duration":"329.375019ms","start":"2026-06-06T02:45:02.0655Z","end":"2026-06-06T02:45:02.394875Z","steps":["trace[949904564] 'process raft request' (duration: 329.092333ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:45:02.395088Z","caller":"traceutil/trace.go:171","msg":"trace[1696781616] transaction","detail":"{read_only:false; response_revision:20327; number_of_response:1; }","duration":"317.546479ms","start":"2026-06-06T02:45:02.077511Z","end":"2026-06-06T02:45:02.395058Z","steps":["trace[1696781616] 'process raft request' (duration: 317.228293ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:45:02.395228Z","caller":"traceutil/trace.go:171","msg":"trace[412336440] linearizableReadLoop","detail":"{readStateIndex:21014; appliedIndex:21012; }","duration":"323.06803ms","start":"2026-06-06T02:45:02.072139Z","end":"2026-06-06T02:45:02.395207Z","steps":["trace[412336440] 'read index received' (duration: 158.081895ms)","trace[412336440] 'applied index is now lower than readState.Index' (duration: 164.985015ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:45:02.395242Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:45:02.077484Z","time spent":"317.678792ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":508,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-06-06T02:45:02.395269Z","caller":"traceutil/trace.go:171","msg":"trace[211022583] transaction","detail":"{read_only:false; response_revision:20329; number_of_response:1; }","duration":"238.691775ms","start":"2026-06-06T02:45:02.156552Z","end":"2026-06-06T02:45:02.395243Z","steps":["trace[211022583] 'process raft request' (duration: 238.267917ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:45:02.395346Z","caller":"traceutil/trace.go:171","msg":"trace[1917875038] transaction","detail":"{read_only:false; response_revision:20330; number_of_response:1; }","duration":"238.200216ms","start":"2026-06-06T02:45:02.157136Z","end":"2026-06-06T02:45:02.395336Z","steps":["trace[1917875038] 'process raft request' (duration: 237.929191ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:45:02.395452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"323.302016ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-06-06T02:45:02.395498Z","caller":"traceutil/trace.go:171","msg":"trace[1493115974] range","detail":"{range_begin:/registry/flowschemas/; range_end:/registry/flowschemas0; response_count:0; response_revision:20330; }","duration":"323.412368ms","start":"2026-06-06T02:45:02.072075Z","end":"2026-06-06T02:45:02.395488Z","steps":["trace[1493115974] 'agreement among raft nodes before linearized reading' (duration: 323.307216ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:45:02.395534Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:45:02.072054Z","time spent":"323.469189ms","remote":"127.0.0.1:46356","response type":"/etcdserverpb.KV/Range","request count":0,"request size":50,"response count":13,"response size":29,"request content":"key:\"/registry/flowschemas/\" range_end:\"/registry/flowschemas0\" count_only:true "} {"level":"warn","ts":"2026-06-06T02:45:02.395613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"256.570256ms","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-06-06T02:45:02.395709Z","caller":"traceutil/trace.go:171","msg":"trace[408174139] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:20330; }","duration":"256.715429ms","start":"2026-06-06T02:45:02.138972Z","end":"2026-06-06T02:45:02.395687Z","steps":["trace[408174139] 'agreement among raft nodes before linearized reading' (duration: 256.428773ms)"],"step_count":1} {"level":"warn","ts":"2026-06-06T02:45:02.395851Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-06-06T02:45:02.065481Z","time spent":"329.622114ms","remote":"127.0.0.1:46176","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":520,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-06-06T02:45:02.6225Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.520961ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-06-06T02:45:02.622633Z","caller":"traceutil/trace.go:171","msg":"trace[988374768] transaction","detail":"{read_only:false; response_revision:20331; number_of_response:1; }","duration":"222.16297ms","start":"2026-06-06T02:45:02.400444Z","end":"2026-06-06T02:45:02.622607Z","steps":["trace[988374768] 'process raft request' (duration: 77.427675ms)","trace[988374768] 'compare' (duration: 144.227545ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:45:02.626967Z","caller":"traceutil/trace.go:171","msg":"trace[541541262] transaction","detail":"{read_only:false; response_revision:20332; number_of_response:1; }","duration":"135.467469ms","start":"2026-06-06T02:45:02.49148Z","end":"2026-06-06T02:45:02.626947Z","steps":["trace[541541262] 'process raft request' (duration: 135.346196ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:45:03.7765Z","caller":"traceutil/trace.go:171","msg":"trace[1103122518] linearizableReadLoop","detail":"{readStateIndex:21025; appliedIndex:21024; }","duration":"167.517167ms","start":"2026-06-06T02:45:03.608955Z","end":"2026-06-06T02:45:03.776472Z","steps":["trace[1103122518] 'read index received' (duration: 91.617753ms)","trace[1103122518] 'applied index is now lower than readState.Index' (duration: 75.898374ms)"],"step_count":2} {"level":"warn","ts":"2026-06-06T02:45:03.776804Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.835223ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:481"} {"level":"info","ts":"2026-06-06T02:45:03.776859Z","caller":"traceutil/trace.go:171","msg":"trace[1939426340] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:20336; }","duration":"167.947806ms","start":"2026-06-06T02:45:03.608898Z","end":"2026-06-06T02:45:03.776846Z","steps":["trace[1939426340] 'agreement among raft nodes before linearized reading' (duration: 167.699831ms)"],"step_count":1} {"level":"info","ts":"2026-06-06T02:45:03.777087Z","caller":"traceutil/trace.go:171","msg":"trace[1475573757] transaction","detail":"{read_only:false; response_revision:20336; number_of_response:1; }","duration":"222.557899ms","start":"2026-06-06T02:45:03.554517Z","end":"2026-06-06T02:45:03.777075Z","steps":["trace[1475573757] 'process raft request' (duration: 146.158305ms)","trace[1475573757] 'compare' (duration: 75.371914ms)"],"step_count":2} {"level":"info","ts":"2026-06-06T02:49:10.434506Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":20042} {"level":"info","ts":"2026-06-06T02:49:10.545114Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":20042,"took":"106.885431ms","hash":1942952073,"current-db-size-bytes":58265600,"current-db-size":"58 MB","current-db-size-in-use-bytes":31518720,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-06-06T02:49:10.545193Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1942952073,"revision":20042,"compact-revision":17576}