{"level":"warn","ts":"2026-07-01T10:35:36.058211Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T10:35:36.058292Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.116: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.116:2380","--initial-cluster=instance=https://199.204.45.116:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.116:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.116:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-07-01T10:35:36.058349Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-07-01T10:35:36.058362Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-07-01T10:35:36.05838Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-01T10:35:36.058948Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"]} {"level":"info","ts":"2026-07-01T10:35:36.059021Z","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.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.116:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-07-01T10:35:36.067516Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"7.241418ms"} {"level":"info","ts":"2026-07-01T10:35:36.072867Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"5caa70ef1dd6dc04","cluster-id":"45afccab143d2c82"} {"level":"info","ts":"2026-07-01T10:35:36.072937Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=()"} {"level":"info","ts":"2026-07-01T10:35:36.072963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 0"} {"level":"info","ts":"2026-07-01T10:35:36.072977Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 5caa70ef1dd6dc04 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-01T10:35:36.072992Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became follower at term 1"} {"level":"info","ts":"2026-07-01T10:35:36.073028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"warn","ts":"2026-07-01T10:35:36.077001Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-01T10:35:36.07842Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-01T10:35:36.079628Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-07-01T10:35:36.085084Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"5caa70ef1dd6dc04","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-01T10:35:36.085328Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"5caa70ef1dd6dc04","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-01T10:35:36.085424Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-01T10:35:36.085528Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-01T10:35:36.085539Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-07-01T10:35:36.086264Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 switched to configuration voters=(6677273569830296580)"} {"level":"info","ts":"2026-07-01T10:35:36.08742Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","added-peer-id":"5caa70ef1dd6dc04","added-peer-peer-urls":["https://199.204.45.116:2380"]} {"level":"info","ts":"2026-07-01T10:35:36.089895Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-07-01T10:35:36.090088Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"5caa70ef1dd6dc04","initial-advertise-peer-urls":["https://199.204.45.116:2380"],"listen-peer-urls":["https://199.204.45.116:2380"],"advertise-client-urls":["https://199.204.45.116:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.116:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-01T10:35:36.090121Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-01T10:35:36.090234Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-07-01T10:35:36.090247Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.116:2380"} {"level":"info","ts":"2026-07-01T10:35:36.475942Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 is starting a new election at term 1"} {"level":"info","ts":"2026-07-01T10:35:36.476028Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-01T10:35:36.476051Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgPreVoteResp from 5caa70ef1dd6dc04 at term 1"} {"level":"info","ts":"2026-07-01T10:35:36.476072Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became candidate at term 2"} {"level":"info","ts":"2026-07-01T10:35:36.476083Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 received MsgVoteResp from 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-07-01T10:35:36.476106Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"5caa70ef1dd6dc04 became leader at term 2"} {"level":"info","ts":"2026-07-01T10:35:36.476118Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 5caa70ef1dd6dc04 elected leader 5caa70ef1dd6dc04 at term 2"} {"level":"info","ts":"2026-07-01T10:35:36.484759Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"5caa70ef1dd6dc04","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.116:2379]}","request-path":"/0/members/5caa70ef1dd6dc04/attributes","cluster-id":"45afccab143d2c82","publish-timeout":"7s"} {"level":"info","ts":"2026-07-01T10:35:36.484916Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T10:35:36.484977Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:35:36.485017Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-01T10:35:36.485228Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-01T10:35:36.485272Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-01T10:35:36.486557Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"45afccab143d2c82","local-member-id":"5caa70ef1dd6dc04","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:35:36.486688Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:35:36.48672Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-01T10:35:36.486966Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-01T10:35:36.488274Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.116:2379"} {"level":"info","ts":"2026-07-01T10:35:39.767942Z","caller":"traceutil/trace.go:171","msg":"trace[1269480641] transaction","detail":"{read_only:false; response_revision:169; number_of_response:1; }","duration":"169.104465ms","start":"2026-07-01T10:35:39.598799Z","end":"2026-07-01T10:35:39.767903Z","steps":["trace[1269480641] 'process raft request' (duration: 159.350049ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:35:54.789013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.520022ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:35:54.789227Z","caller":"traceutil/trace.go:171","msg":"trace[101483273] transaction","detail":"{read_only:false; response_revision:380; number_of_response:1; }","duration":"163.908906ms","start":"2026-07-01T10:35:54.625272Z","end":"2026-07-01T10:35:54.78918Z","steps":["trace[101483273] 'process raft request' (duration: 50.679973ms)","trace[101483273] 'compare' (duration: 109.38903ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:36:19.687307Z","caller":"traceutil/trace.go:171","msg":"trace[36890276] transaction","detail":"{read_only:false; response_revision:537; number_of_response:1; }","duration":"104.411867ms","start":"2026-07-01T10:36:19.582865Z","end":"2026-07-01T10:36:19.687276Z","steps":["trace[36890276] 'process raft request' (duration: 35.22084ms)","trace[36890276] 'compare' (duration: 68.925161ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:36:26.193404Z","caller":"traceutil/trace.go:171","msg":"trace[987477387] linearizableReadLoop","detail":"{readStateIndex:637; appliedIndex:636; }","duration":"242.669237ms","start":"2026-07-01T10:36:25.950703Z","end":"2026-07-01T10:36:26.193372Z","steps":["trace[987477387] 'read index received' (duration: 241.74659ms)","trace[987477387] 'applied index is now lower than readState.Index' (duration: 921.506µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:36:26.193541Z","caller":"traceutil/trace.go:171","msg":"trace[832061006] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"292.844852ms","start":"2026-07-01T10:36:25.900643Z","end":"2026-07-01T10:36:26.193488Z","steps":["trace[832061006] 'process raft request' (duration: 292.063007ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:36:26.193621Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"242.90139ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-btgp5\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-01T10:36:26.193669Z","caller":"traceutil/trace.go:171","msg":"trace[96117878] range","detail":"{range_begin:/registry/pods/kube-system/cilium-btgp5; range_end:; response_count:1; response_revision:609; }","duration":"243.027514ms","start":"2026-07-01T10:36:25.950628Z","end":"2026-07-01T10:36:26.193656Z","steps":["trace[96117878] 'agreement among raft nodes before linearized reading' (duration: 242.857951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:36:26.744556Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.596031ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:36:26.744705Z","caller":"traceutil/trace.go:171","msg":"trace[1304470674] linearizableReadLoop","detail":"{readStateIndex:639; appliedIndex:638; }","duration":"359.090782ms","start":"2026-07-01T10:36:26.385595Z","end":"2026-07-01T10:36:26.744686Z","steps":["trace[1304470674] 'read index received' (duration: 214.311088ms)","trace[1304470674] 'applied index is now lower than readState.Index' (duration: 144.778524ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:36:26.744803Z","caller":"traceutil/trace.go:171","msg":"trace[630639989] transaction","detail":"{read_only:false; response_revision:611; number_of_response:1; }","duration":"481.201206ms","start":"2026-07-01T10:36:26.263591Z","end":"2026-07-01T10:36:26.744792Z","steps":["trace[630639989] 'process raft request' (duration: 336.282829ms)","trace[630639989] 'compare' (duration: 144.353296ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:36:26.744873Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:36:26.263568Z","time spent":"481.271438ms","remote":"127.0.0.1:47132","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-07-01T10:36:26.745025Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"359.426189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:36:26.745086Z","caller":"traceutil/trace.go:171","msg":"trace[768489468] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:611; }","duration":"359.544061ms","start":"2026-07-01T10:36:26.385522Z","end":"2026-07-01T10:36:26.745067Z","steps":["trace[768489468] 'agreement among raft nodes before linearized reading' (duration: 359.401688ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:36:26.745131Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:36:26.385479Z","time spent":"359.643793ms","remote":"127.0.0.1:46892","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-07-01T10:36:26.745124Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"277.589421ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"warn","ts":"2026-07-01T10:36:26.745128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.488537ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:431"} {"level":"info","ts":"2026-07-01T10:36:26.745254Z","caller":"traceutil/trace.go:171","msg":"trace[1696025201] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:611; }","duration":"277.723334ms","start":"2026-07-01T10:36:26.467494Z","end":"2026-07-01T10:36:26.745218Z","steps":["trace[1696025201] 'agreement among raft nodes before linearized reading' (duration: 277.51824ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:36:26.745269Z","caller":"traceutil/trace.go:171","msg":"trace[761689348] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:611; }","duration":"290.68161ms","start":"2026-07-01T10:36:26.45456Z","end":"2026-07-01T10:36:26.745241Z","steps":["trace[761689348] 'agreement among raft nodes before linearized reading' (duration: 290.334604ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:36:41.618439Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.952072ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:36:41.618607Z","caller":"traceutil/trace.go:171","msg":"trace[375445768] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:768; }","duration":"233.189646ms","start":"2026-07-01T10:36:41.385396Z","end":"2026-07-01T10:36:41.618585Z","steps":["trace[375445768] 'range keys from in-memory index tree' (duration: 232.735858ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:37:09.17989Z","caller":"traceutil/trace.go:171","msg":"trace[2057922902] linearizableReadLoop","detail":"{readStateIndex:1202; appliedIndex:1201; }","duration":"170.694729ms","start":"2026-07-01T10:37:09.009166Z","end":"2026-07-01T10:37:09.17986Z","steps":["trace[2057922902] 'read index received' (duration: 170.663498ms)","trace[2057922902] 'applied index is now lower than readState.Index' (duration: 29.651µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:37:09.179928Z","caller":"traceutil/trace.go:171","msg":"trace[1121433973] transaction","detail":"{read_only:false; response_revision:1164; number_of_response:1; }","duration":"172.602994ms","start":"2026-07-01T10:37:09.007299Z","end":"2026-07-01T10:37:09.179902Z","steps":["trace[1121433973] 'process raft request' (duration: 172.413591ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:37:09.180147Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.943853ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-01T10:37:09.180197Z","caller":"traceutil/trace.go:171","msg":"trace[1630986149] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1164; }","duration":"171.043554ms","start":"2026-07-01T10:37:09.009137Z","end":"2026-07-01T10:37:09.180181Z","steps":["trace[1630986149] 'agreement among raft nodes before linearized reading' (duration: 170.865681ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:37:09.231704Z","caller":"traceutil/trace.go:171","msg":"trace[2085934525] transaction","detail":"{read_only:false; response_revision:1165; number_of_response:1; }","duration":"221.258059ms","start":"2026-07-01T10:37:09.010424Z","end":"2026-07-01T10:37:09.231682Z","steps":["trace[2085934525] 'process raft request' (duration: 208.306553ms)","trace[2085934525] 'compare' (duration: 12.802493ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:37:31.534167Z","caller":"traceutil/trace.go:171","msg":"trace[61070796] linearizableReadLoop","detail":"{readStateIndex:1473; appliedIndex:1472; }","duration":"171.563234ms","start":"2026-07-01T10:37:31.362572Z","end":"2026-07-01T10:37:31.534135Z","steps":["trace[61070796] 'read index received' (duration: 114.465928ms)","trace[61070796] 'applied index is now lower than readState.Index' (duration: 57.096096ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:37:31.534316Z","caller":"traceutil/trace.go:171","msg":"trace[1005953837] transaction","detail":"{read_only:false; response_revision:1426; number_of_response:1; }","duration":"175.668313ms","start":"2026-07-01T10:37:31.358579Z","end":"2026-07-01T10:37:31.534247Z","steps":["trace[1005953837] 'process raft request' (duration: 118.417313ms)","trace[1005953837] 'compare' (duration: 56.997485ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:37:31.534435Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.843509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:479"} {"level":"info","ts":"2026-07-01T10:37:31.534472Z","caller":"traceutil/trace.go:171","msg":"trace[858471905] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:1426; }","duration":"171.92571ms","start":"2026-07-01T10:37:31.362535Z","end":"2026-07-01T10:37:31.534461Z","steps":["trace[858471905] 'agreement among raft nodes before linearized reading' (duration: 171.769648ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:37:31.534457Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"150.012434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-01T10:37:31.534533Z","caller":"traceutil/trace.go:171","msg":"trace[485284986] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1426; }","duration":"150.118515ms","start":"2026-07-01T10:37:31.384393Z","end":"2026-07-01T10:37:31.534512Z","steps":["trace[485284986] 'agreement among raft nodes before linearized reading' (duration: 149.998843ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:37:54.587093Z","caller":"traceutil/trace.go:171","msg":"trace[852850253] linearizableReadLoop","detail":"{readStateIndex:1896; appliedIndex:1894; }","duration":"137.455586ms","start":"2026-07-01T10:37:54.449603Z","end":"2026-07-01T10:37:54.587059Z","steps":["trace[852850253] 'read index received' (duration: 21.354358ms)","trace[852850253] 'applied index is now lower than readState.Index' (duration: 116.093568ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:37:54.587353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.736761ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-282312e1-ef9d-4969-9ca9-6fb3ca2e2da0\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-01T10:37:54.587401Z","caller":"traceutil/trace.go:171","msg":"trace[450299118] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-282312e1-ef9d-4969-9ca9-6fb3ca2e2da0; range_end:; response_count:1; response_revision:1823; }","duration":"137.876803ms","start":"2026-07-01T10:37:54.44951Z","end":"2026-07-01T10:37:54.587387Z","steps":["trace[450299118] 'agreement among raft nodes before linearized reading' (duration: 137.67946ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:37:54.587412Z","caller":"traceutil/trace.go:171","msg":"trace[563479257] transaction","detail":"{read_only:false; response_revision:1823; number_of_response:1; }","duration":"165.727713ms","start":"2026-07-01T10:37:54.421639Z","end":"2026-07-01T10:37:54.587366Z","steps":["trace[563479257] 'process raft request' (duration: 143.656283ms)","trace[563479257] 'compare' (duration: 21.627122ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:37:54.747766Z","caller":"traceutil/trace.go:171","msg":"trace[2050820619] transaction","detail":"{read_only:false; response_revision:1824; number_of_response:1; }","duration":"154.223364ms","start":"2026-07-01T10:37:54.593515Z","end":"2026-07-01T10:37:54.747739Z","steps":["trace[2050820619] 'process raft request' (duration: 131.552843ms)","trace[2050820619] 'compare' (duration: 22.444077ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:38:44.988324Z","caller":"traceutil/trace.go:171","msg":"trace[1946058579] transaction","detail":"{read_only:false; response_revision:2151; number_of_response:1; }","duration":"137.007112ms","start":"2026-07-01T10:38:44.851274Z","end":"2026-07-01T10:38:44.988281Z","steps":["trace[1946058579] 'process raft request' (duration: 108.06313ms)","trace[1946058579] 'compare' (duration: 28.786229ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:40:08.663965Z","caller":"traceutil/trace.go:171","msg":"trace[872557860] transaction","detail":"{read_only:false; response_revision:2798; number_of_response:1; }","duration":"201.235213ms","start":"2026-07-01T10:40:08.462655Z","end":"2026-07-01T10:40:08.663891Z","steps":["trace[872557860] 'process raft request' (duration: 159.109198ms)","trace[872557860] 'compare' (duration: 41.876999ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:40:08.664035Z","caller":"traceutil/trace.go:171","msg":"trace[1342986365] transaction","detail":"{read_only:false; response_revision:2800; number_of_response:1; }","duration":"146.265484ms","start":"2026-07-01T10:40:08.51775Z","end":"2026-07-01T10:40:08.664016Z","steps":["trace[1342986365] 'process raft request' (duration: 146.125071ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:40:08.664135Z","caller":"traceutil/trace.go:171","msg":"trace[927510203] transaction","detail":"{read_only:false; response_revision:2799; number_of_response:1; }","duration":"181.948064ms","start":"2026-07-01T10:40:08.482149Z","end":"2026-07-01T10:40:08.664098Z","steps":["trace[927510203] 'process raft request' (duration: 181.644289ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:40:09.155498Z","caller":"traceutil/trace.go:171","msg":"trace[1680751541] transaction","detail":"{read_only:false; response_revision:2801; number_of_response:1; }","duration":"177.267035ms","start":"2026-07-01T10:40:08.978196Z","end":"2026-07-01T10:40:09.155463Z","steps":["trace[1680751541] 'process raft request' (duration: 176.99668ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:42:49.428615Z","caller":"traceutil/trace.go:171","msg":"trace[300631808] transaction","detail":"{read_only:false; response_revision:3846; number_of_response:1; }","duration":"122.865962ms","start":"2026-07-01T10:42:49.305695Z","end":"2026-07-01T10:42:49.428561Z","steps":["trace[300631808] 'process raft request' (duration: 118.462108ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:15.406438Z","caller":"traceutil/trace.go:171","msg":"trace[972470678] linearizableReadLoop","detail":"{readStateIndex:5241; appliedIndex:5240; }","duration":"104.350942ms","start":"2026-07-01T10:44:15.302046Z","end":"2026-07-01T10:44:15.406397Z","steps":["trace[972470678] 'read index received' (duration: 39.443343ms)","trace[972470678] 'applied index is now lower than readState.Index' (duration: 64.905739ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:44:15.407273Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.201127ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/\" range_end:\"/registry/secrets/monitoring0\" ","response":"range_response_count:24 size:728655"} {"level":"info","ts":"2026-07-01T10:44:15.407397Z","caller":"traceutil/trace.go:171","msg":"trace[842191477] range","detail":"{range_begin:/registry/secrets/monitoring/; range_end:/registry/secrets/monitoring0; response_count:24; response_revision:5048; }","duration":"105.408771ms","start":"2026-07-01T10:44:15.301962Z","end":"2026-07-01T10:44:15.407371Z","steps":["trace[842191477] 'agreement among raft nodes before linearized reading' (duration: 104.558755ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:16.864936Z","caller":"traceutil/trace.go:171","msg":"trace[167985972] transaction","detail":"{read_only:false; response_revision:5079; number_of_response:1; }","duration":"110.448438ms","start":"2026-07-01T10:44:16.754446Z","end":"2026-07-01T10:44:16.864894Z","steps":["trace[167985972] 'process raft request' (duration: 101.60003ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:19.036012Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.528329ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:44:19.036277Z","caller":"traceutil/trace.go:171","msg":"trace[1670104676] linearizableReadLoop","detail":"{readStateIndex:5332; appliedIndex:5330; }","duration":"111.731612ms","start":"2026-07-01T10:44:18.924525Z","end":"2026-07-01T10:44:19.036257Z","steps":["trace[1670104676] 'read index received' (duration: 832.626µs)","trace[1670104676] 'applied index is now lower than readState.Index' (duration: 110.898086ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:19.036286Z","caller":"traceutil/trace.go:171","msg":"trace[1659436338] transaction","detail":"{read_only:false; response_revision:5135; number_of_response:1; }","duration":"161.101904ms","start":"2026-07-01T10:44:18.875158Z","end":"2026-07-01T10:44:19.03626Z","steps":["trace[1659436338] 'process raft request' (duration: 50.209388ms)","trace[1659436338] 'compare' (duration: 110.335716ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:19.036438Z","caller":"traceutil/trace.go:171","msg":"trace[1055779127] transaction","detail":"{read_only:false; response_revision:5136; number_of_response:1; }","duration":"139.212216ms","start":"2026-07-01T10:44:18.897219Z","end":"2026-07-01T10:44:19.036431Z","steps":["trace[1055779127] 'process raft request' (duration: 138.957762ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:19.036582Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.059879ms","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-07-01T10:44:19.036628Z","caller":"traceutil/trace.go:171","msg":"trace[447982971] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5136; }","duration":"112.170881ms","start":"2026-07-01T10:44:18.924449Z","end":"2026-07-01T10:44:19.03662Z","steps":["trace[447982971] 'agreement among raft nodes before linearized reading' (duration: 112.056569ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.133605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"264.63201ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:44:38.133842Z","caller":"traceutil/trace.go:171","msg":"trace[447113628] linearizableReadLoop","detail":"{readStateIndex:5709; appliedIndex:5707; }","duration":"328.836265ms","start":"2026-07-01T10:44:37.804982Z","end":"2026-07-01T10:44:38.133819Z","steps":["trace[447113628] 'read index received' (duration: 63.890119ms)","trace[447113628] 'applied index is now lower than readState.Index' (duration: 264.944796ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:38.134146Z","caller":"traceutil/trace.go:171","msg":"trace[703236688] transaction","detail":"{read_only:false; response_revision:5503; number_of_response:1; }","duration":"356.201757ms","start":"2026-07-01T10:44:37.777902Z","end":"2026-07-01T10:44:38.134104Z","steps":["trace[703236688] 'process raft request' (duration: 355.85094ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:38.134192Z","caller":"traceutil/trace.go:171","msg":"trace[872316967] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"391.633484ms","start":"2026-07-01T10:44:37.742506Z","end":"2026-07-01T10:44:38.13414Z","steps":["trace[872316967] 'process raft request' (duration: 126.348042ms)","trace[872316967] 'compare' (duration: 264.457745ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:44:38.13438Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:37.77788Z","time spent":"356.37177ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T10:44:38.13446Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:37.742492Z","time spent":"391.807447ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-01T10:44:38.13453Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.478257ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-chunks-cache-0\" ","response":"range_response_count:1 size:4464"} {"level":"info","ts":"2026-07-01T10:44:38.134682Z","caller":"traceutil/trace.go:171","msg":"trace[540649459] range","detail":"{range_begin:/registry/pods/monitoring/loki-chunks-cache-0; range_end:; response_count:1; response_revision:5503; }","duration":"329.716741ms","start":"2026-07-01T10:44:37.804931Z","end":"2026-07-01T10:44:38.134648Z","steps":["trace[540649459] 'agreement among raft nodes before linearized reading' (duration: 329.160231ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.134742Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:37.804911Z","time spent":"329.818813ms","remote":"127.0.0.1:47074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":4486,"request content":"key:\"/registry/pods/monitoring/loki-chunks-cache-0\" "} {"level":"warn","ts":"2026-07-01T10:44:38.401873Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.622656ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-01T10:44:38.402453Z","caller":"traceutil/trace.go:171","msg":"trace[1808427154] linearizableReadLoop","detail":"{readStateIndex:5710; appliedIndex:5709; }","duration":"268.367652ms","start":"2026-07-01T10:44:38.133881Z","end":"2026-07-01T10:44:38.402249Z","steps":["trace[1808427154] 'read index received' (duration: 130.282156ms)","trace[1808427154] 'applied index is now lower than readState.Index' (duration: 138.082756ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:38.402624Z","caller":"traceutil/trace.go:171","msg":"trace[2073844995] transaction","detail":"{read_only:false; response_revision:5504; number_of_response:1; }","duration":"548.755182ms","start":"2026-07-01T10:44:37.853816Z","end":"2026-07-01T10:44:38.402571Z","steps":["trace[2073844995] 'process raft request' (duration: 410.294939ms)","trace[2073844995] 'compare' (duration: 137.403402ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:44:38.402717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"393.043961ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-07-01T10:44:38.402769Z","caller":"traceutil/trace.go:171","msg":"trace[1332128829] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5504; }","duration":"393.162173ms","start":"2026-07-01T10:44:38.009591Z","end":"2026-07-01T10:44:38.402753Z","steps":["trace[1332128829] 'agreement among raft nodes before linearized reading' (duration: 392.947189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.402811Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.009563Z","time spent":"393.237805ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":502,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-07-01T10:44:38.402837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"574.857591ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"warn","ts":"2026-07-01T10:44:38.402813Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"345.814909ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/serviceips\" ","response":"range_response_count:1 size:129592"} {"level":"warn","ts":"2026-07-01T10:44:38.402862Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:37.853769Z","time spent":"548.965056ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:44:38.402889Z","caller":"traceutil/trace.go:171","msg":"trace[487430482] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5504; }","duration":"574.921792ms","start":"2026-07-01T10:44:37.827956Z","end":"2026-07-01T10:44:38.402877Z","steps":["trace[487430482] 'agreement among raft nodes before linearized reading' (duration: 574.732799ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.402925Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:37.827857Z","time spent":"575.060265ms","remote":"127.0.0.1:47058","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":1803,"request content":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" "} {"level":"info","ts":"2026-07-01T10:44:38.402916Z","caller":"traceutil/trace.go:171","msg":"trace[521694704] range","detail":"{range_begin:/registry/ranges/serviceips; range_end:; response_count:1; response_revision:5504; }","duration":"345.995023ms","start":"2026-07-01T10:44:38.056892Z","end":"2026-07-01T10:44:38.402887Z","steps":["trace[521694704] 'agreement among raft nodes before linearized reading' (duration: 345.602616ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.402978Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.056868Z","time spent":"346.101285ms","remote":"127.0.0.1:46950","response type":"/etcdserverpb.KV/Range","request count":0,"request size":29,"response count":1,"response size":129614,"request content":"key:\"/registry/ranges/serviceips\" "} {"level":"warn","ts":"2026-07-01T10:44:38.402944Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.688675ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ranges/servicenodeports\" ","response":"range_response_count:1 size:118"} {"level":"info","ts":"2026-07-01T10:44:38.403074Z","caller":"traceutil/trace.go:171","msg":"trace[1088522375] range","detail":"{range_begin:/registry/ranges/servicenodeports; range_end:; response_count:1; response_revision:5504; }","duration":"348.900618ms","start":"2026-07-01T10:44:38.054141Z","end":"2026-07-01T10:44:38.403042Z","steps":["trace[1088522375] 'agreement among raft nodes before linearized reading' (duration: 348.579112ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.403129Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.054109Z","time spent":"349.010351ms","remote":"127.0.0.1:46966","response type":"/etcdserverpb.KV/Range","request count":0,"request size":35,"response count":1,"response size":140,"request content":"key:\"/registry/ranges/servicenodeports\" "} {"level":"info","ts":"2026-07-01T10:44:38.694794Z","caller":"traceutil/trace.go:171","msg":"trace[446316789] transaction","detail":"{read_only:false; response_revision:5505; number_of_response:1; }","duration":"550.915873ms","start":"2026-07-01T10:44:38.143848Z","end":"2026-07-01T10:44:38.694764Z","steps":["trace[446316789] 'process raft request' (duration: 464.995753ms)","trace[446316789] 'compare' (duration: 85.41421ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:44:38.695135Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.14382Z","time spent":"551.058836ms","remote":"127.0.0.1:47074","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4753,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:44:38.695183Z","caller":"traceutil/trace.go:171","msg":"trace[2082773831] transaction","detail":"{read_only:false; response_revision:5506; number_of_response:1; }","duration":"327.616882ms","start":"2026-07-01T10:44:38.367526Z","end":"2026-07-01T10:44:38.695143Z","steps":["trace[2082773831] 'process raft request' (duration: 327.170412ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.695381Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"402.403639ms","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-07-01T10:44:38.695339Z","caller":"traceutil/trace.go:171","msg":"trace[480884977] transaction","detail":"{read_only:false; response_revision:5507; number_of_response:1; }","duration":"286.850743ms","start":"2026-07-01T10:44:38.408451Z","end":"2026-07-01T10:44:38.695302Z","steps":["trace[480884977] 'process raft request' (duration: 286.554588ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:38.695443Z","caller":"traceutil/trace.go:171","msg":"trace[1176758712] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5507; }","duration":"402.526452ms","start":"2026-07-01T10:44:38.292897Z","end":"2026-07-01T10:44:38.695424Z","steps":["trace[1176758712] 'agreement among raft nodes before linearized reading' (duration: 402.42964ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.695384Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.367486Z","time spent":"327.786545ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-01T10:44:38.69543Z","caller":"traceutil/trace.go:171","msg":"trace[1569251876] linearizableReadLoop","detail":"{readStateIndex:5712; appliedIndex:5710; }","duration":"292.805297ms","start":"2026-07-01T10:44:38.402491Z","end":"2026-07-01T10:44:38.695296Z","steps":["trace[1569251876] 'read index received' (duration: 206.450539ms)","trace[1569251876] 'applied index is now lower than readState.Index' (duration: 86.350688ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:44:38.695483Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"309.928534ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-07-01T10:44:38.695482Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.292872Z","time spent":"402.601134ms","remote":"127.0.0.1:45248","response type":"/etcdserverpb.KV/Range","request count":0,"request size":100,"response count":0,"response size":27,"request content":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true "} {"level":"warn","ts":"2026-07-01T10:44:38.695538Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"449.363885ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-rzmth\" ","response":"range_response_count:1 size:6522"} {"level":"info","ts":"2026-07-01T10:44:38.6956Z","caller":"traceutil/trace.go:171","msg":"trace[789669031] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5507; }","duration":"310.092567ms","start":"2026-07-01T10:44:38.385481Z","end":"2026-07-01T10:44:38.695574Z","steps":["trace[789669031] 'agreement among raft nodes before linearized reading' (duration: 309.916144ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:38.695603Z","caller":"traceutil/trace.go:171","msg":"trace[522124142] range","detail":"{range_begin:/registry/pods/openstack/keepalived-rzmth; range_end:; response_count:1; response_revision:5507; }","duration":"449.498148ms","start":"2026-07-01T10:44:38.246091Z","end":"2026-07-01T10:44:38.695589Z","steps":["trace[522124142] 'agreement among raft nodes before linearized reading' (duration: 449.258283ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.695654Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.385468Z","time spent":"310.177469ms","remote":"127.0.0.1:46892","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-07-01T10:44:38.695661Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.246058Z","time spent":"449.594689ms","remote":"127.0.0.1:47074","response type":"/etcdserverpb.KV/Range","request count":0,"request size":43,"response count":1,"response size":6544,"request content":"key:\"/registry/pods/openstack/keepalived-rzmth\" "} {"level":"warn","ts":"2026-07-01T10:44:38.695664Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"550.465684ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-07-01T10:44:38.695707Z","caller":"traceutil/trace.go:171","msg":"trace[1618303345] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5507; }","duration":"550.542776ms","start":"2026-07-01T10:44:38.145153Z","end":"2026-07-01T10:44:38.695695Z","steps":["trace[1618303345] 'agreement among raft nodes before linearized reading' (duration: 550.367802ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.695748Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:44:38.145136Z","time spent":"550.604597ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":528,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-07-01T10:44:38.69606Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"289.129346ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumes/pvc-48e2ea29-76f7-471a-b83f-bfef2995354a\" ","response":"range_response_count:1 size:1275"} {"level":"info","ts":"2026-07-01T10:44:38.696193Z","caller":"traceutil/trace.go:171","msg":"trace[483440327] range","detail":"{range_begin:/registry/persistentvolumes/pvc-48e2ea29-76f7-471a-b83f-bfef2995354a; range_end:; response_count:1; response_revision:5507; }","duration":"289.3249ms","start":"2026-07-01T10:44:38.406833Z","end":"2026-07-01T10:44:38.696158Z","steps":["trace[483440327] 'agreement among raft nodes before linearized reading' (duration: 288.859852ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.696299Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"290.034706ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:50 size:73305"} {"level":"info","ts":"2026-07-01T10:44:38.696355Z","caller":"traceutil/trace.go:171","msg":"trace[480895952] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:50; response_revision:5507; }","duration":"290.148858ms","start":"2026-07-01T10:44:38.406196Z","end":"2026-07-01T10:44:38.696344Z","steps":["trace[480895952] 'agreement among raft nodes before linearized reading' (duration: 289.683558ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:44:38.698215Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.629594ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/specs/\" range_end:\"/registry/services/specs0\" ","response":"range_response_count:50 size:73305"} {"level":"info","ts":"2026-07-01T10:44:38.698314Z","caller":"traceutil/trace.go:171","msg":"trace[224091304] range","detail":"{range_begin:/registry/services/specs/; range_end:/registry/services/specs0; response_count:50; response_revision:5507; }","duration":"292.798608ms","start":"2026-07-01T10:44:38.405498Z","end":"2026-07-01T10:44:38.698297Z","steps":["trace[224091304] 'agreement among raft nodes before linearized reading' (duration: 290.140217ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:50.127949Z","caller":"traceutil/trace.go:171","msg":"trace[643502154] transaction","detail":"{read_only:false; response_revision:5651; number_of_response:1; }","duration":"108.97271ms","start":"2026-07-01T10:44:50.018942Z","end":"2026-07-01T10:44:50.127915Z","steps":["trace[643502154] 'process raft request' (duration: 69.548758ms)","trace[643502154] 'compare' (duration: 39.128617ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:44:50.128242Z","caller":"traceutil/trace.go:171","msg":"trace[1827250751] transaction","detail":"{read_only:false; response_revision:5652; number_of_response:1; }","duration":"109.219145ms","start":"2026-07-01T10:44:50.019005Z","end":"2026-07-01T10:44:50.128224Z","steps":["trace[1827250751] 'process raft request' (duration: 108.830247ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:44:50.128499Z","caller":"traceutil/trace.go:171","msg":"trace[1518819375] transaction","detail":"{read_only:false; response_revision:5653; number_of_response:1; }","duration":"109.085272ms","start":"2026-07-01T10:44:50.019358Z","end":"2026-07-01T10:44:50.128444Z","steps":["trace[1518819375] 'process raft request' (duration: 108.743884ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:45:31.606404Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.101677ms","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-07-01T10:45:31.606518Z","caller":"traceutil/trace.go:171","msg":"trace[1139392982] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6009; }","duration":"135.332212ms","start":"2026-07-01T10:45:31.471162Z","end":"2026-07-01T10:45:31.606495Z","steps":["trace[1139392982] 'range keys from in-memory index tree' (duration: 134.679508ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:45:36.670767Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2952} {"level":"info","ts":"2026-07-01T10:45:36.746037Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2952,"took":"72.979122ms","hash":2910399521,"current-db-size-bytes":57479168,"current-db-size":"58 MB","current-db-size-in-use-bytes":33980416,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-07-01T10:45:36.746181Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2910399521,"revision":2952,"compact-revision":-1} {"level":"info","ts":"2026-07-01T10:50:36.677216Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6058} {"level":"info","ts":"2026-07-01T10:50:36.776855Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6058,"took":"97.419768ms","hash":1869362727,"current-db-size-bytes":57479168,"current-db-size":"58 MB","current-db-size-in-use-bytes":21909504,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-01T10:50:36.776948Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1869362727,"revision":6058,"compact-revision":2952} {"level":"info","ts":"2026-07-01T10:50:43.793727Z","caller":"traceutil/trace.go:171","msg":"trace[70672471] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"265.701108ms","start":"2026-07-01T10:50:43.527998Z","end":"2026-07-01T10:50:43.7937Z","steps":["trace[70672471] 'process raft request' (duration: 265.516704ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:50:43.952997Z","caller":"traceutil/trace.go:171","msg":"trace[1098591265] transaction","detail":"{read_only:false; response_revision:8318; number_of_response:1; }","duration":"139.096923ms","start":"2026-07-01T10:50:43.813875Z","end":"2026-07-01T10:50:43.952972Z","steps":["trace[1098591265] 'process raft request' (duration: 137.838689ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:50:55.436807Z","caller":"traceutil/trace.go:171","msg":"trace[520354949] linearizableReadLoop","detail":"{readStateIndex:8684; appliedIndex:8683; }","duration":"166.945834ms","start":"2026-07-01T10:50:55.269831Z","end":"2026-07-01T10:50:55.436777Z","steps":["trace[520354949] 'read index received' (duration: 116.671765ms)","trace[520354949] 'applied index is now lower than readState.Index' (duration: 50.271959ms)"],"step_count":2} {"level":"warn","ts":"2026-07-01T10:50:55.437135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"167.270521ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-01T10:50:55.437251Z","caller":"traceutil/trace.go:171","msg":"trace[1126546598] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8384; }","duration":"167.451605ms","start":"2026-07-01T10:50:55.269776Z","end":"2026-07-01T10:50:55.437227Z","steps":["trace[1126546598] 'agreement among raft nodes before linearized reading' (duration: 167.146798ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:50:56.199989Z","caller":"traceutil/trace.go:171","msg":"trace[2084199629] linearizableReadLoop","detail":"{readStateIndex:8687; appliedIndex:8686; }","duration":"180.696506ms","start":"2026-07-01T10:50:56.019265Z","end":"2026-07-01T10:50:56.199961Z","steps":["trace[2084199629] 'read index received' (duration: 180.659526ms)","trace[2084199629] 'applied index is now lower than readState.Index' (duration: 35.83µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:50:56.200084Z","caller":"traceutil/trace.go:171","msg":"trace[1279228260] transaction","detail":"{read_only:false; response_revision:8387; number_of_response:1; }","duration":"187.019287ms","start":"2026-07-01T10:50:56.013025Z","end":"2026-07-01T10:50:56.200044Z","steps":["trace[1279228260] 'process raft request' (duration: 186.750072ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:50:56.20064Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.311378ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:432"} {"level":"info","ts":"2026-07-01T10:50:56.200748Z","caller":"traceutil/trace.go:171","msg":"trace[550455968] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8387; }","duration":"181.506312ms","start":"2026-07-01T10:50:56.01922Z","end":"2026-07-01T10:50:56.200726Z","steps":["trace[550455968] 'agreement among raft nodes before linearized reading' (duration: 180.88663ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:50:56.396102Z","caller":"traceutil/trace.go:171","msg":"trace[343921467] transaction","detail":"{read_only:false; response_revision:8390; number_of_response:1; }","duration":"190.863891ms","start":"2026-07-01T10:50:56.205191Z","end":"2026-07-01T10:50:56.396055Z","steps":["trace[343921467] 'process raft request' (duration: 190.81583ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:50:56.396159Z","caller":"traceutil/trace.go:171","msg":"trace[1677610203] linearizableReadLoop","detail":"{readStateIndex:8689; appliedIndex:8687; }","duration":"196.06776ms","start":"2026-07-01T10:50:56.200065Z","end":"2026-07-01T10:50:56.396133Z","steps":["trace[1677610203] 'read index received' (duration: 104.86053ms)","trace[1677610203] 'applied index is now lower than readState.Index' (duration: 91.205ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:50:56.39618Z","caller":"traceutil/trace.go:171","msg":"trace[205660810] transaction","detail":"{read_only:false; response_revision:8389; number_of_response:1; }","duration":"237.864906ms","start":"2026-07-01T10:50:56.158265Z","end":"2026-07-01T10:50:56.39613Z","steps":["trace[205660810] 'process raft request' (duration: 237.665802ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:50:56.396416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"325.823795ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-01T10:50:56.396502Z","caller":"traceutil/trace.go:171","msg":"trace[1826398785] transaction","detail":"{read_only:false; response_revision:8388; number_of_response:1; }","duration":"242.70612ms","start":"2026-07-01T10:50:56.1534Z","end":"2026-07-01T10:50:56.396106Z","steps":["trace[1826398785] 'process raft request' (duration: 151.440639ms)","trace[1826398785] 'compare' (duration: 90.909704ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:50:56.396517Z","caller":"traceutil/trace.go:171","msg":"trace[159880065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:8390; }","duration":"325.945047ms","start":"2026-07-01T10:50:56.070509Z","end":"2026-07-01T10:50:56.396454Z","steps":["trace[159880065] 'agreement among raft nodes before linearized reading' (duration: 325.748703ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:50:56.396558Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-01T10:50:56.070492Z","time spent":"326.05582ms","remote":"127.0.0.1:47156","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-07-01T10:50:57.666759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"136.742129ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rolebindings/\" range_end:\"/registry/rolebindings0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-01T10:50:57.666879Z","caller":"traceutil/trace.go:171","msg":"trace[1163853584] range","detail":"{range_begin:/registry/rolebindings/; range_end:/registry/rolebindings0; response_count:0; response_revision:8395; }","duration":"136.961493ms","start":"2026-07-01T10:50:57.529893Z","end":"2026-07-01T10:50:57.666855Z","steps":["trace[1163853584] 'count revisions from in-memory index tree' (duration: 136.597096ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:51:24.124629Z","caller":"traceutil/trace.go:171","msg":"trace[930006094] linearizableReadLoop","detail":"{readStateIndex:8897; appliedIndex:8896; }","duration":"115.269411ms","start":"2026-07-01T10:51:24.009314Z","end":"2026-07-01T10:51:24.124584Z","steps":["trace[930006094] 'read index received' (duration: 115.053176ms)","trace[930006094] 'applied index is now lower than readState.Index' (duration: 215.035µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:51:24.124661Z","caller":"traceutil/trace.go:171","msg":"trace[1417659352] transaction","detail":"{read_only:false; response_revision:8590; number_of_response:1; }","duration":"172.452262ms","start":"2026-07-01T10:51:23.95217Z","end":"2026-07-01T10:51:24.124622Z","steps":["trace[1417659352] 'process raft request' (duration: 172.233177ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:51:24.124968Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.638188ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/openstack/barbican-api-87849c875-7s5cn.18be24df4ee971e4\" ","response":"range_response_count:1 size:1132"} {"level":"info","ts":"2026-07-01T10:51:24.125054Z","caller":"traceutil/trace.go:171","msg":"trace[958730917] range","detail":"{range_begin:/registry/events/openstack/barbican-api-87849c875-7s5cn.18be24df4ee971e4; range_end:; response_count:1; response_revision:8590; }","duration":"115.797401ms","start":"2026-07-01T10:51:24.009236Z","end":"2026-07-01T10:51:24.125034Z","steps":["trace[958730917] 'agreement among raft nodes before linearized reading' (duration: 115.462995ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:51:24.247182Z","caller":"traceutil/trace.go:171","msg":"trace[403195436] transaction","detail":"{read_only:false; response_revision:8591; number_of_response:1; }","duration":"118.506401ms","start":"2026-07-01T10:51:24.128628Z","end":"2026-07-01T10:51:24.247134Z","steps":["trace[403195436] 'process raft request' (duration: 105.510853ms)","trace[403195436] 'compare' (duration: 12.807274ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:51:37.376767Z","caller":"traceutil/trace.go:171","msg":"trace[42716023] linearizableReadLoop","detail":"{readStateIndex:9017; appliedIndex:9016; }","duration":"121.58057ms","start":"2026-07-01T10:51:37.255159Z","end":"2026-07-01T10:51:37.37674Z","steps":["trace[42716023] 'read index received' (duration: 121.233143ms)","trace[42716023] 'applied index is now lower than readState.Index' (duration: 345.987µs)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:51:37.37682Z","caller":"traceutil/trace.go:171","msg":"trace[1357216388] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"122.407457ms","start":"2026-07-01T10:51:37.254379Z","end":"2026-07-01T10:51:37.376786Z","steps":["trace[1357216388] 'process raft request' (duration: 122.138001ms)"],"step_count":1} {"level":"warn","ts":"2026-07-01T10:51:37.377136Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"121.943087ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-w75dc\" ","response":"range_response_count:1 size:2803"} {"level":"info","ts":"2026-07-01T10:51:37.37723Z","caller":"traceutil/trace.go:171","msg":"trace[1392854841] range","detail":"{range_begin:/registry/cilium.io/ciliumendpoints/openstack/rook-ceph-detect-version-w75dc; range_end:; response_count:1; response_revision:8704; }","duration":"122.08444ms","start":"2026-07-01T10:51:37.255123Z","end":"2026-07-01T10:51:37.377207Z","steps":["trace[1392854841] 'agreement among raft nodes before linearized reading' (duration: 121.764684ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T10:51:39.146965Z","caller":"traceutil/trace.go:171","msg":"trace[1298818279] transaction","detail":"{read_only:false; response_revision:8719; number_of_response:1; }","duration":"104.436154ms","start":"2026-07-01T10:51:39.042489Z","end":"2026-07-01T10:51:39.146925Z","steps":["trace[1298818279] 'process raft request' (duration: 51.575394ms)","trace[1298818279] 'compare' (duration: 52.686507ms)"],"step_count":2} {"level":"info","ts":"2026-07-01T10:51:53.054015Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000023c7.wal"} {"level":"info","ts":"2026-07-01T10:53:20.750201Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"5caa70ef1dd6dc04","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-07-01T10:53:20.757801Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-07-01T10:53:20.7579Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-07-01T10:55:36.684078Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8154} {"level":"info","ts":"2026-07-01T10:55:36.744364Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8154,"took":"57.772244ms","hash":2897892994,"current-db-size-bytes":57479168,"current-db-size":"58 MB","current-db-size-in-use-bytes":29827072,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-07-01T10:55:36.744428Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2897892994,"revision":8154,"compact-revision":6058} {"level":"warn","ts":"2026-07-01T10:56:37.559176Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.298679ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12216"} {"level":"info","ts":"2026-07-01T10:56:37.559297Z","caller":"traceutil/trace.go:171","msg":"trace[1595154567] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:11308; }","duration":"120.454342ms","start":"2026-07-01T10:56:37.438812Z","end":"2026-07-01T10:56:37.559266Z","steps":["trace[1595154567] 'range keys from in-memory index tree' (duration: 120.106885ms)"],"step_count":1} {"level":"info","ts":"2026-07-01T11:00:36.691502Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10769} {"level":"info","ts":"2026-07-01T11:00:36.778831Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10769,"took":"83.620128ms","hash":3427107586,"current-db-size-bytes":57479168,"current-db-size":"58 MB","current-db-size-in-use-bytes":27803648,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-07-01T11:00:36.778892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3427107586,"revision":10769,"compact-revision":8154} {"level":"info","ts":"2026-07-01T11:05:36.698716Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12823} {"level":"info","ts":"2026-07-01T11:05:36.769643Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12823,"took":"68.62325ms","hash":3534459880,"current-db-size-bytes":57479168,"current-db-size":"58 MB","current-db-size-in-use-bytes":22528000,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-07-01T11:05:36.769696Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3534459880,"revision":12823,"compact-revision":10769}