{"level":"warn","ts":"2026-07-29T15:36:16.050541Z","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-29T15:36:16.050641Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.125:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.125:2380","--initial-cluster=instance=https://199.19.213.125:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.125:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.125: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-29T15:36:16.050753Z","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-29T15:36:16.050772Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-07-29T15:36:16.050794Z","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-29T15:36:16.051848Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"]} {"level":"info","ts":"2026-07-29T15:36:16.051947Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.125: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-29T15:36:16.05637Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.182712ms"} {"level":"info","ts":"2026-07-29T15:36:16.065581Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"b448fdce642f2755","cluster-id":"66f7e5dc9a72c5e3"} {"level":"info","ts":"2026-07-29T15:36:16.065681Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=()"} {"level":"info","ts":"2026-07-29T15:36:16.065718Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 0"} {"level":"info","ts":"2026-07-29T15:36:16.065738Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft b448fdce642f2755 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-07-29T15:36:16.065753Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became follower at term 1"} {"level":"info","ts":"2026-07-29T15:36:16.065809Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"warn","ts":"2026-07-29T15:36:16.079481Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-07-29T15:36:16.087447Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-07-29T15:36:16.089171Z","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-29T15:36:16.091213Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"b448fdce642f2755","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-07-29T15:36:16.091346Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"b448fdce642f2755","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-07-29T15:36:16.09162Z","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-29T15:36:16.09169Z","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-29T15:36:16.091709Z","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-29T15:36:16.092475Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 switched to configuration voters=(12990912188036097877)"} {"level":"info","ts":"2026-07-29T15:36:16.092575Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","added-peer-id":"b448fdce642f2755","added-peer-peer-urls":["https://199.19.213.125:2380"]} {"level":"info","ts":"2026-07-29T15:36:16.093382Z","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-29T15:36:16.09354Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"b448fdce642f2755","initial-advertise-peer-urls":["https://199.19.213.125:2380"],"listen-peer-urls":["https://199.19.213.125:2380"],"advertise-client-urls":["https://199.19.213.125:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.125:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-07-29T15:36:16.093578Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-07-29T15:36:16.093614Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-07-29T15:36:16.093621Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.125:2380"} {"level":"info","ts":"2026-07-29T15:36:16.666643Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 is starting a new election at term 1"} {"level":"info","ts":"2026-07-29T15:36:16.666759Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became pre-candidate at term 1"} {"level":"info","ts":"2026-07-29T15:36:16.666783Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgPreVoteResp from b448fdce642f2755 at term 1"} {"level":"info","ts":"2026-07-29T15:36:16.666802Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became candidate at term 2"} {"level":"info","ts":"2026-07-29T15:36:16.666817Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 received MsgVoteResp from b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-07-29T15:36:16.666831Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"b448fdce642f2755 became leader at term 2"} {"level":"info","ts":"2026-07-29T15:36:16.666847Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: b448fdce642f2755 elected leader b448fdce642f2755 at term 2"} {"level":"info","ts":"2026-07-29T15:36:16.66783Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"b448fdce642f2755","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.125:2379]}","request-path":"/0/members/b448fdce642f2755/attributes","cluster-id":"66f7e5dc9a72c5e3","publish-timeout":"7s"} {"level":"info","ts":"2026-07-29T15:36:16.66788Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:36:16.667978Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T15:36:16.668123Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-07-29T15:36:16.668741Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"66f7e5dc9a72c5e3","local-member-id":"b448fdce642f2755","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:36:16.668891Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:36:16.668929Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-07-29T15:36:16.670089Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.125:2379"} {"level":"info","ts":"2026-07-29T15:36:16.670511Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-07-29T15:36:16.670535Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-07-29T15:36:16.67187Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-07-29T15:36:26.491127Z","caller":"traceutil/trace.go:171","msg":"trace[1937805819] linearizableReadLoop","detail":"{readStateIndex:380; appliedIndex:379; }","duration":"175.394269ms","start":"2026-07-29T15:36:26.315703Z","end":"2026-07-29T15:36:26.491097Z","steps":["trace[1937805819] 'read index received' (duration: 174.705997ms)","trace[1937805819] 'applied index is now lower than readState.Index' (duration: 686.592µs)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:36:26.491205Z","caller":"traceutil/trace.go:171","msg":"trace[1611020278] transaction","detail":"{read_only:false; response_revision:366; number_of_response:1; }","duration":"215.373893ms","start":"2026-07-29T15:36:26.275785Z","end":"2026-07-29T15:36:26.491159Z","steps":["trace[1611020278] 'process raft request' (duration: 214.547466ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:36:26.491461Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"175.691559ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/endpointslice-controller\" ","response":"range_response_count:1 size:214"} {"level":"info","ts":"2026-07-29T15:36:26.491536Z","caller":"traceutil/trace.go:171","msg":"trace[752656536] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/endpointslice-controller; range_end:; response_count:1; response_revision:366; }","duration":"175.870175ms","start":"2026-07-29T15:36:26.315647Z","end":"2026-07-29T15:36:26.491518Z","steps":["trace[752656536] 'agreement among raft nodes before linearized reading' (duration: 175.579165ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:36:26.492076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.225656ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/serviceaccounts/kube-system/ttl-controller\" ","response":"range_response_count:1 size:193"} {"level":"info","ts":"2026-07-29T15:36:26.492718Z","caller":"traceutil/trace.go:171","msg":"trace[631282656] range","detail":"{range_begin:/registry/serviceaccounts/kube-system/ttl-controller; range_end:; response_count:1; response_revision:366; }","duration":"126.901588ms","start":"2026-07-29T15:36:26.365801Z","end":"2026-07-29T15:36:26.492702Z","steps":["trace[631282656] 'agreement among raft nodes before linearized reading' (duration: 125.491712ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:37:03.885151Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.554984ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-962b6\" ","response":"range_response_count:1 size:16965"} {"level":"info","ts":"2026-07-29T15:37:03.885243Z","caller":"traceutil/trace.go:171","msg":"trace[2093358332] range","detail":"{range_begin:/registry/pods/kube-system/cilium-962b6; range_end:; response_count:1; response_revision:691; }","duration":"212.700747ms","start":"2026-07-29T15:37:03.672523Z","end":"2026-07-29T15:37:03.885224Z","steps":["trace[2093358332] 'range keys from in-memory index tree' (duration: 212.370189ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:37:03.885462Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"358.286326ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T15:37:03.885853Z","caller":"traceutil/trace.go:171","msg":"trace[1218007422] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:691; }","duration":"358.634563ms","start":"2026-07-29T15:37:03.527061Z","end":"2026-07-29T15:37:03.885696Z","steps":["trace[1218007422] 'range keys from in-memory index tree' (duration: 358.206734ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:37:03.885911Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:37:03.52704Z","time spent":"358.857549ms","remote":"127.0.0.1:46050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-07-29T15:37:03.922359Z","caller":"traceutil/trace.go:171","msg":"trace[1388299827] transaction","detail":"{read_only:false; response_revision:692; number_of_response:1; }","duration":"136.67458ms","start":"2026-07-29T15:37:03.785658Z","end":"2026-07-29T15:37:03.922332Z","steps":["trace[1388299827] 'process raft request' (duration: 135.852581ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:37:04.155677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.316093ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T15:37:04.155869Z","caller":"traceutil/trace.go:171","msg":"trace[1334141640] transaction","detail":"{read_only:false; response_revision:695; number_of_response:1; }","duration":"148.209487ms","start":"2026-07-29T15:37:04.007643Z","end":"2026-07-29T15:37:04.155852Z","steps":["trace[1334141640] 'process raft request' (duration: 148.138146ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:37:04.156007Z","caller":"traceutil/trace.go:171","msg":"trace[91458648] transaction","detail":"{read_only:false; response_revision:694; number_of_response:1; }","duration":"229.829298ms","start":"2026-07-29T15:37:03.926127Z","end":"2026-07-29T15:37:04.155956Z","steps":["trace[91458648] 'process raft request' (duration: 93.665656ms)","trace[91458648] 'compare' (duration: 135.1725ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:37:04.639824Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"378.691714ms","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-07-29T15:37:04.639932Z","caller":"traceutil/trace.go:171","msg":"trace[1512454222] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:695; }","duration":"378.849568ms","start":"2026-07-29T15:37:04.261054Z","end":"2026-07-29T15:37:04.639904Z","steps":["trace[1512454222] 'range keys from in-memory index tree' (duration: 378.47663ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:37:04.639987Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:37:04.261034Z","time spent":"378.94036ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":500,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-07-29T15:37:04.681026Z","caller":"traceutil/trace.go:171","msg":"trace[1133531065] transaction","detail":"{read_only:false; response_revision:696; number_of_response:1; }","duration":"109.604063ms","start":"2026-07-29T15:37:04.571394Z","end":"2026-07-29T15:37:04.680998Z","steps":["trace[1133531065] 'process raft request' (duration: 108.926218ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:37:21.820052Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"176.731696ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T15:37:21.820169Z","caller":"traceutil/trace.go:171","msg":"trace[1700725625] linearizableReadLoop","detail":"{readStateIndex:855; appliedIndex:854; }","duration":"292.433846ms","start":"2026-07-29T15:37:21.527719Z","end":"2026-07-29T15:37:21.820153Z","steps":["trace[1700725625] 'read index received' (duration: 115.466065ms)","trace[1700725625] 'applied index is now lower than readState.Index' (duration: 176.966561ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:37:21.820274Z","caller":"traceutil/trace.go:171","msg":"trace[818066461] transaction","detail":"{read_only:false; response_revision:824; number_of_response:1; }","duration":"306.72551ms","start":"2026-07-29T15:37:21.513538Z","end":"2026-07-29T15:37:21.820263Z","steps":["trace[818066461] 'process raft request' (duration: 129.707688ms)","trace[818066461] 'compare' (duration: 176.594693ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:37:21.820364Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:37:21.51352Z","time spent":"306.793832ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:37:21.820613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"292.872736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T15:37:21.820756Z","caller":"traceutil/trace.go:171","msg":"trace[815705074] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:824; }","duration":"293.053188ms","start":"2026-07-29T15:37:21.527673Z","end":"2026-07-29T15:37:21.820727Z","steps":["trace[815705074] 'agreement among raft nodes before linearized reading' (duration: 292.817034ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:37:52.183166Z","caller":"traceutil/trace.go:171","msg":"trace[721285681] transaction","detail":"{read_only:false; response_revision:1223; number_of_response:1; }","duration":"193.478485ms","start":"2026-07-29T15:37:51.989653Z","end":"2026-07-29T15:37:52.183131Z","steps":["trace[721285681] 'process raft request' (duration: 193.265182ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:38:17.263629Z","caller":"traceutil/trace.go:171","msg":"trace[833172449] transaction","detail":"{read_only:false; response_revision:1491; number_of_response:1; }","duration":"119.927053ms","start":"2026-07-29T15:38:17.143672Z","end":"2026-07-29T15:38:17.263599Z","steps":["trace[833172449] 'process raft request' (duration: 97.723556ms)","trace[833172449] 'compare' (duration: 22.057395ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:38:41.663684Z","caller":"traceutil/trace.go:171","msg":"trace[1364872093] linearizableReadLoop","detail":"{readStateIndex:1976; appliedIndex:1975; }","duration":"320.395531ms","start":"2026-07-29T15:38:41.343253Z","end":"2026-07-29T15:38:41.663648Z","steps":["trace[1364872093] 'read index received' (duration: 312.946082ms)","trace[1364872093] 'applied index is now lower than readState.Index' (duration: 7.448059ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:38:41.663843Z","caller":"traceutil/trace.go:171","msg":"trace[1295906925] transaction","detail":"{read_only:false; response_revision:1902; number_of_response:1; }","duration":"321.401963ms","start":"2026-07-29T15:38:41.342408Z","end":"2026-07-29T15:38:41.663809Z","steps":["trace[1295906925] 'process raft request' (duration: 313.67033ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:38:41.664011Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:38:41.342383Z","time spent":"321.546054ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":463,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:38:41.66406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"320.773995ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b0dd70f1-ff42-40fb-bf7c-096d89f6e743\" ","response":"range_response_count:1 size:3627"} {"level":"info","ts":"2026-07-29T15:38:41.664153Z","caller":"traceutil/trace.go:171","msg":"trace[894283772] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-b0dd70f1-ff42-40fb-bf7c-096d89f6e743; range_end:; response_count:1; response_revision:1902; }","duration":"320.915046ms","start":"2026-07-29T15:38:41.343216Z","end":"2026-07-29T15:38:41.664131Z","steps":["trace[894283772] 'agreement among raft nodes before linearized reading' (duration: 320.637253ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:38:41.664208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:38:41.343207Z","time spent":"320.991787ms","remote":"127.0.0.1:46246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3650,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-b0dd70f1-ff42-40fb-bf7c-096d89f6e743\" "} {"level":"info","ts":"2026-07-29T15:38:41.737327Z","caller":"traceutil/trace.go:171","msg":"trace[1476775951] transaction","detail":"{read_only:false; response_revision:1903; number_of_response:1; }","duration":"392.126617ms","start":"2026-07-29T15:38:41.345156Z","end":"2026-07-29T15:38:41.737283Z","steps":["trace[1476775951] 'process raft request' (duration: 391.795652ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:38:41.737575Z","caller":"traceutil/trace.go:171","msg":"trace[756573250] transaction","detail":"{read_only:false; response_revision:1904; number_of_response:1; }","duration":"391.419129ms","start":"2026-07-29T15:38:41.346141Z","end":"2026-07-29T15:38:41.73756Z","steps":["trace[756573250] 'process raft request' (duration: 391.008065ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:38:41.737723Z","caller":"traceutil/trace.go:171","msg":"trace[1856704999] transaction","detail":"{read_only:false; response_revision:1906; number_of_response:1; }","duration":"390.832723ms","start":"2026-07-29T15:38:41.346862Z","end":"2026-07-29T15:38:41.737695Z","steps":["trace[1856704999] 'process raft request' (duration: 390.393038ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:38:41.73758Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:38:41.345132Z","time spent":"392.33662ms","remote":"127.0.0.1:46238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":894,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:38:41.737933Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:38:41.346823Z","time spent":"391.004985ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1530,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:38:41.738039Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:38:41.346118Z","time spent":"391.596071ms","remote":"127.0.0.1:46238","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":978,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:38:41.73735Z","caller":"traceutil/trace.go:171","msg":"trace[1578605450] transaction","detail":"{read_only:false; response_revision:1905; number_of_response:1; }","duration":"390.501679ms","start":"2026-07-29T15:38:41.346807Z","end":"2026-07-29T15:38:41.737309Z","steps":["trace[1578605450] 'process raft request' (duration: 390.393757ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:38:41.738177Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"145.509789ms","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-07-29T15:38:41.738231Z","caller":"traceutil/trace.go:171","msg":"trace[1666803078] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1907; }","duration":"145.589669ms","start":"2026-07-29T15:38:41.592623Z","end":"2026-07-29T15:38:41.738212Z","steps":["trace[1666803078] 'agreement among raft nodes before linearized reading' (duration: 145.424577ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:38:41.738322Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:38:41.346769Z","time spent":"391.43348ms","remote":"127.0.0.1:46316","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:38:41.738608Z","caller":"traceutil/trace.go:171","msg":"trace[1231187328] transaction","detail":"{read_only:false; response_revision:1907; number_of_response:1; }","duration":"376.381587ms","start":"2026-07-29T15:38:41.362211Z","end":"2026-07-29T15:38:41.738592Z","steps":["trace[1231187328] 'process raft request' (duration: 375.366615ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:38:41.738644Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.943101ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-29T15:38:41.73873Z","caller":"traceutil/trace.go:171","msg":"trace[1484953619] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1907; }","duration":"145.042282ms","start":"2026-07-29T15:38:41.593632Z","end":"2026-07-29T15:38:41.738674Z","steps":["trace[1484953619] 'agreement among raft nodes before linearized reading' (duration: 144.879081ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:38:41.738756Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:38:41.362194Z","time spent":"376.469938ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":535,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:38:41.789859Z","caller":"traceutil/trace.go:171","msg":"trace[1845916224] transaction","detail":"{read_only:false; response_revision:1908; number_of_response:1; }","duration":"117.063273ms","start":"2026-07-29T15:38:41.672767Z","end":"2026-07-29T15:38:41.78983Z","steps":["trace[1845916224] 'process raft request' (duration: 107.121314ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:39:16.02707Z","caller":"traceutil/trace.go:171","msg":"trace[1483945232] transaction","detail":"{read_only:false; response_revision:2145; number_of_response:1; }","duration":"101.612931ms","start":"2026-07-29T15:39:15.925225Z","end":"2026-07-29T15:39:16.026838Z","steps":["trace[1483945232] 'process raft request' (duration: 101.398688ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:39:16.241185Z","caller":"traceutil/trace.go:171","msg":"trace[184482853] transaction","detail":"{read_only:false; response_revision:2148; number_of_response:1; }","duration":"120.059539ms","start":"2026-07-29T15:39:16.121079Z","end":"2026-07-29T15:39:16.241139Z","steps":["trace[184482853] 'process raft request' (duration: 86.27765ms)","trace[184482853] 'compare' (duration: 33.527166ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:39:16.573014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"135.081392ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T15:39:16.573133Z","caller":"traceutil/trace.go:171","msg":"trace[946987041] transaction","detail":"{read_only:false; response_revision:2149; number_of_response:1; }","duration":"193.384089ms","start":"2026-07-29T15:39:16.379732Z","end":"2026-07-29T15:39:16.573117Z","steps":["trace[946987041] 'process raft request' (duration: 58.085214ms)","trace[946987041] 'compare' (duration: 134.994682ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:39:17.167282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"287.771684ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T15:39:17.167899Z","caller":"traceutil/trace.go:171","msg":"trace[2049695841] linearizableReadLoop","detail":"{readStateIndex:2233; appliedIndex:2232; }","duration":"291.05151ms","start":"2026-07-29T15:39:16.876824Z","end":"2026-07-29T15:39:17.167875Z","steps":["trace[2049695841] 'read index received' (duration: 2.553058ms)","trace[2049695841] 'applied index is now lower than readState.Index' (duration: 288.496952ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:39:17.167914Z","caller":"traceutil/trace.go:171","msg":"trace[633840450] transaction","detail":"{read_only:false; response_revision:2152; number_of_response:1; }","duration":"448.530317ms","start":"2026-07-29T15:39:16.71935Z","end":"2026-07-29T15:39:17.16788Z","steps":["trace[633840450] 'process raft request' (duration: 160.047665ms)","trace[633840450] 'compare' (duration: 287.630373ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:39:17.168111Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"291.274732ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/roles/\" range_end:\"/registry/roles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T15:39:17.168185Z","caller":"traceutil/trace.go:171","msg":"trace[1799088081] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:2152; }","duration":"291.406953ms","start":"2026-07-29T15:39:16.876743Z","end":"2026-07-29T15:39:17.16815Z","steps":["trace[1799088081] 'agreement among raft nodes before linearized reading' (duration: 291.243162ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:39:17.168277Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:39:16.719329Z","time spent":"448.811869ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":490,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:39:17.168532Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"248.196972ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-07-29T15:39:17.168573Z","caller":"traceutil/trace.go:171","msg":"trace[1985435994] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:2152; }","duration":"248.278764ms","start":"2026-07-29T15:39:16.920285Z","end":"2026-07-29T15:39:17.168564Z","steps":["trace[1985435994] 'agreement among raft nodes before linearized reading' (duration: 248.146951ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:39:17.168553Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"219.827203ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T15:39:17.168664Z","caller":"traceutil/trace.go:171","msg":"trace[1243081832] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:2152; }","duration":"219.983814ms","start":"2026-07-29T15:39:16.94865Z","end":"2026-07-29T15:39:17.168633Z","steps":["trace[1243081832] 'agreement among raft nodes before linearized reading' (duration: 219.787351ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:39:17.413264Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"109.115917ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T15:39:17.413512Z","caller":"traceutil/trace.go:171","msg":"trace[1020965672] linearizableReadLoop","detail":"{readStateIndex:2234; appliedIndex:2233; }","duration":"161.931912ms","start":"2026-07-29T15:39:17.251561Z","end":"2026-07-29T15:39:17.413493Z","steps":["trace[1020965672] 'read index received' (duration: 52.38701ms)","trace[1020965672] 'applied index is now lower than readState.Index' (duration: 109.543102ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:39:17.413557Z","caller":"traceutil/trace.go:171","msg":"trace[214415302] transaction","detail":"{read_only:false; response_revision:2153; number_of_response:1; }","duration":"240.155093ms","start":"2026-07-29T15:39:17.173348Z","end":"2026-07-29T15:39:17.413503Z","steps":["trace[214415302] 'process raft request' (duration: 130.695392ms)","trace[214415302] 'compare' (duration: 108.884655ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:39:17.413661Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.089433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/endpointslices/\" range_end:\"/registry/endpointslices0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T15:39:17.413763Z","caller":"traceutil/trace.go:171","msg":"trace[781620674] range","detail":"{range_begin:/registry/endpointslices/; range_end:/registry/endpointslices0; response_count:0; response_revision:2153; }","duration":"162.274106ms","start":"2026-07-29T15:39:17.251468Z","end":"2026-07-29T15:39:17.413742Z","steps":["trace[781620674] 'agreement among raft nodes before linearized reading' (duration: 162.083084ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:39:17.413937Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.099906ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/limitranges/\" range_end:\"/registry/limitranges0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T15:39:17.41421Z","caller":"traceutil/trace.go:171","msg":"trace[1913237685] range","detail":"{range_begin:/registry/limitranges/; range_end:/registry/limitranges0; response_count:0; response_revision:2153; }","duration":"108.396529ms","start":"2026-07-29T15:39:17.305794Z","end":"2026-07-29T15:39:17.41419Z","steps":["trace[1913237685] 'agreement among raft nodes before linearized reading' (duration: 107.919293ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:21.096504Z","caller":"traceutil/trace.go:171","msg":"trace[888799525] transaction","detail":"{read_only:false; response_revision:2600; number_of_response:1; }","duration":"147.407197ms","start":"2026-07-29T15:40:20.949074Z","end":"2026-07-29T15:40:21.096481Z","steps":["trace[888799525] 'process raft request' (duration: 140.58608ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:21.101652Z","caller":"traceutil/trace.go:171","msg":"trace[1827243548] linearizableReadLoop","detail":"{readStateIndex:2697; appliedIndex:2695; }","duration":"112.777924ms","start":"2026-07-29T15:40:20.988849Z","end":"2026-07-29T15:40:21.101627Z","steps":["trace[1827243548] 'read index received' (duration: 100.824826ms)","trace[1827243548] 'applied index is now lower than readState.Index' (duration: 11.952138ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:40:21.101895Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.024986ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/daemonsets/\" range_end:\"/registry/daemonsets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-07-29T15:40:21.101939Z","caller":"traceutil/trace.go:171","msg":"trace[409564765] range","detail":"{range_begin:/registry/daemonsets/; range_end:/registry/daemonsets0; response_count:0; response_revision:2601; }","duration":"113.130348ms","start":"2026-07-29T15:40:20.988797Z","end":"2026-07-29T15:40:21.101928Z","steps":["trace[409564765] 'agreement among raft nodes before linearized reading' (duration: 112.958066ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:40:21.102195Z","caller":"traceutil/trace.go:171","msg":"trace[797818570] transaction","detail":"{read_only:false; response_revision:2601; number_of_response:1; }","duration":"145.832131ms","start":"2026-07-29T15:40:20.955932Z","end":"2026-07-29T15:40:21.101764Z","steps":["trace[797818570] 'process raft request' (duration: 145.549769ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:40:52.778216Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.59936ms","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-07-29T15:40:52.778345Z","caller":"traceutil/trace.go:171","msg":"trace[1270283827] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/envoyproxies/; range_end:/registry/gateway.envoyproxy.io/envoyproxies0; response_count:0; response_revision:2774; }","duration":"115.813736ms","start":"2026-07-29T15:40:52.662506Z","end":"2026-07-29T15:40:52.77832Z","steps":["trace[1270283827] 'count revisions from in-memory index tree' (duration: 115.495877ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.452923Z","caller":"traceutil/trace.go:171","msg":"trace[1705557110] transaction","detail":"{read_only:false; response_revision:4868; number_of_response:1; }","duration":"289.663695ms","start":"2026-07-29T15:45:02.163239Z","end":"2026-07-29T15:45:02.452903Z","steps":["trace[1705557110] 'process raft request' (duration: 289.426352ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.453733Z","caller":"traceutil/trace.go:171","msg":"trace[484168856] transaction","detail":"{read_only:false; response_revision:4870; number_of_response:1; }","duration":"289.537665ms","start":"2026-07-29T15:45:02.16417Z","end":"2026-07-29T15:45:02.453708Z","steps":["trace[484168856] 'process raft request' (duration: 289.483924ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.453757Z","caller":"traceutil/trace.go:171","msg":"trace[732453411] transaction","detail":"{read_only:false; response_revision:4869; number_of_response:1; }","duration":"289.781788ms","start":"2026-07-29T15:45:02.163937Z","end":"2026-07-29T15:45:02.453719Z","steps":["trace[732453411] 'process raft request' (duration: 289.612395ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.481366Z","caller":"traceutil/trace.go:171","msg":"trace[1402707398] linearizableReadLoop","detail":"{readStateIndex:5053; appliedIndex:5049; }","duration":"253.968707ms","start":"2026-07-29T15:45:02.227369Z","end":"2026-07-29T15:45:02.481338Z","steps":["trace[1402707398] 'read index received' (duration: 225.23116ms)","trace[1402707398] 'applied index is now lower than readState.Index' (duration: 28.736476ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:45:02.481417Z","caller":"traceutil/trace.go:171","msg":"trace[1062341181] transaction","detail":"{read_only:false; response_revision:4871; number_of_response:1; }","duration":"261.168604ms","start":"2026-07-29T15:45:02.220216Z","end":"2026-07-29T15:45:02.481384Z","steps":["trace[1062341181] 'process raft request' (duration: 260.995801ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:02.481607Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"254.22719ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0\" ","response":"range_response_count:1 size:1935"} {"level":"info","ts":"2026-07-29T15:45:02.481651Z","caller":"traceutil/trace.go:171","msg":"trace[205333928] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/alertmanager-kube-prometheus-stack-alertmanager-db-alertmanager-kube-prometheus-stack-alertmanager-0; range_end:; response_count:1; response_revision:4871; }","duration":"254.290701ms","start":"2026-07-29T15:45:02.227347Z","end":"2026-07-29T15:45:02.481637Z","steps":["trace[205333928] 'agreement among raft nodes before linearized reading' (duration: 254.113758ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.57253Z","caller":"traceutil/trace.go:171","msg":"trace[2104890969] transaction","detail":"{read_only:false; response_revision:4872; number_of_response:1; }","duration":"113.668356ms","start":"2026-07-29T15:45:02.458836Z","end":"2026-07-29T15:45:02.572505Z","steps":["trace[2104890969] 'process raft request' (duration: 110.667932ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.573203Z","caller":"traceutil/trace.go:171","msg":"trace[1640326704] transaction","detail":"{read_only:false; response_revision:4873; number_of_response:1; }","duration":"114.345345ms","start":"2026-07-29T15:45:02.458831Z","end":"2026-07-29T15:45:02.573176Z","steps":["trace[1640326704] 'process raft request' (duration: 113.623265ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.573881Z","caller":"traceutil/trace.go:171","msg":"trace[1722027612] transaction","detail":"{read_only:false; response_revision:4874; number_of_response:1; }","duration":"114.444847ms","start":"2026-07-29T15:45:02.459418Z","end":"2026-07-29T15:45:02.573863Z","steps":["trace[1722027612] 'process raft request' (duration: 113.27646ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:02.573993Z","caller":"traceutil/trace.go:171","msg":"trace[2090035703] transaction","detail":"{read_only:false; response_revision:4875; number_of_response:1; }","duration":"114.412556ms","start":"2026-07-29T15:45:02.459575Z","end":"2026-07-29T15:45:02.573988Z","steps":["trace[2090035703] 'process raft request' (duration: 114.221423ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:02.574013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"297.064035ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-07-29T15:45:02.57407Z","caller":"traceutil/trace.go:171","msg":"trace[3499770] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4875; }","duration":"297.147786ms","start":"2026-07-29T15:45:02.276893Z","end":"2026-07-29T15:45:02.574041Z","steps":["trace[3499770] 'agreement among raft nodes before linearized reading' (duration: 297.009334ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:02.576183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.74156ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c295c805-8928-4b94-a6dd-a3bfcab204a0\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-07-29T15:45:02.576275Z","caller":"traceutil/trace.go:171","msg":"trace[512597261] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c295c805-8928-4b94-a6dd-a3bfcab204a0; range_end:; response_count:1; response_revision:4875; }","duration":"118.876772ms","start":"2026-07-29T15:45:02.457374Z","end":"2026-07-29T15:45:02.576251Z","steps":["trace[512597261] 'agreement among raft nodes before linearized reading' (duration: 116.534218ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:16.157766Z","caller":"traceutil/trace.go:171","msg":"trace[1525069946] transaction","detail":"{read_only:false; response_revision:5053; number_of_response:1; }","duration":"144.776577ms","start":"2026-07-29T15:45:16.012962Z","end":"2026-07-29T15:45:16.157738Z","steps":["trace[1525069946] 'process raft request' (duration: 144.599415ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:16.217735Z","caller":"traceutil/trace.go:171","msg":"trace[350496262] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5241; }","duration":"143.172583ms","start":"2026-07-29T15:45:16.074523Z","end":"2026-07-29T15:45:16.217696Z","steps":["trace[350496262] 'read index received' (duration: 83.13825ms)","trace[350496262] 'applied index is now lower than readState.Index' (duration: 60.032833ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:45:16.217863Z","caller":"traceutil/trace.go:171","msg":"trace[2104257602] transaction","detail":"{read_only:false; response_revision:5054; number_of_response:1; }","duration":"157.315989ms","start":"2026-07-29T15:45:16.060504Z","end":"2026-07-29T15:45:16.21782Z","steps":["trace[2104257602] 'process raft request' (duration: 156.986004ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:16.218068Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"139.622542ms","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-07-29T15:45:16.218121Z","caller":"traceutil/trace.go:171","msg":"trace[1042287704] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5054; }","duration":"139.731343ms","start":"2026-07-29T15:45:16.078376Z","end":"2026-07-29T15:45:16.218108Z","steps":["trace[1042287704] 'agreement among raft nodes before linearized reading' (duration: 139.50524ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:16.218248Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"143.529848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-07-29T15:45:16.218389Z","caller":"traceutil/trace.go:171","msg":"trace[2022109065] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5054; }","duration":"143.843002ms","start":"2026-07-29T15:45:16.074515Z","end":"2026-07-29T15:45:16.218358Z","steps":["trace[2022109065] 'agreement among raft nodes before linearized reading' (duration: 143.319415ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:16.396078Z","caller":"traceutil/trace.go:171","msg":"trace[1310070923] transaction","detail":"{read_only:false; response_revision:5055; number_of_response:1; }","duration":"171.338882ms","start":"2026-07-29T15:45:16.224709Z","end":"2026-07-29T15:45:16.396048Z","steps":["trace[1310070923] 'process raft request' (duration: 162.190898ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:16.416064Z","caller":"traceutil/trace.go:171","msg":"trace[996859195] linearizableReadLoop","detail":"{readStateIndex:5245; appliedIndex:5243; }","duration":"108.283015ms","start":"2026-07-29T15:45:16.307733Z","end":"2026-07-29T15:45:16.416016Z","steps":["trace[996859195] 'read index received' (duration: 79.217202ms)","trace[996859195] 'applied index is now lower than readState.Index' (duration: 29.064033ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:45:16.416169Z","caller":"traceutil/trace.go:171","msg":"trace[147025310] transaction","detail":"{read_only:false; response_revision:5056; number_of_response:1; }","duration":"191.07587ms","start":"2026-07-29T15:45:16.225047Z","end":"2026-07-29T15:45:16.416123Z","steps":["trace[147025310] 'process raft request' (duration: 190.789716ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:16.416437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.675651ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16548"} {"level":"info","ts":"2026-07-29T15:45:16.416526Z","caller":"traceutil/trace.go:171","msg":"trace[1598813441] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5056; }","duration":"108.844183ms","start":"2026-07-29T15:45:16.30766Z","end":"2026-07-29T15:45:16.416505Z","steps":["trace[1598813441] 'agreement among raft nodes before linearized reading' (duration: 108.550409ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:16.416505Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"105.218991ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:2082"} {"level":"info","ts":"2026-07-29T15:45:16.416597Z","caller":"traceutil/trace.go:171","msg":"trace[1165676261] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/prometheus-kube-prometheus-stack-prometheus-db-prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:5056; }","duration":"105.375263ms","start":"2026-07-29T15:45:16.311203Z","end":"2026-07-29T15:45:16.416578Z","steps":["trace[1165676261] 'agreement among raft nodes before linearized reading' (duration: 105.069159ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:45:16.718014Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.991964ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-07-29T15:45:16.718252Z","caller":"traceutil/trace.go:171","msg":"trace[794924570] transaction","detail":"{read_only:false; response_revision:5059; number_of_response:1; }","duration":"218.327816ms","start":"2026-07-29T15:45:16.499905Z","end":"2026-07-29T15:45:16.718232Z","steps":["trace[794924570] 'process raft request' (duration: 218.230165ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:16.718276Z","caller":"traceutil/trace.go:171","msg":"trace[1484734559] transaction","detail":"{read_only:false; response_revision:5058; number_of_response:1; }","duration":"257.495406ms","start":"2026-07-29T15:45:16.460731Z","end":"2026-07-29T15:45:16.718226Z","steps":["trace[1484734559] 'process raft request' (duration: 41.192179ms)","trace[1484734559] 'compare' (duration: 215.828211ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:45:16.718383Z","caller":"traceutil/trace.go:171","msg":"trace[1268327768] transaction","detail":"{read_only:false; response_revision:5060; number_of_response:1; }","duration":"217.283872ms","start":"2026-07-29T15:45:16.501061Z","end":"2026-07-29T15:45:16.718344Z","steps":["trace[1268327768] 'process raft request' (duration: 217.13071ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:45:56.482821Z","caller":"traceutil/trace.go:171","msg":"trace[666782559] transaction","detail":"{read_only:false; response_revision:5394; number_of_response:1; }","duration":"118.376225ms","start":"2026-07-29T15:45:56.364415Z","end":"2026-07-29T15:45:56.482791Z","steps":["trace[666782559] 'process raft request' (duration: 96.876787ms)","trace[666782559] 'compare' (duration: 21.372917ms)"],"step_count":2} {"level":"info","ts":"2026-07-29T15:46:16.715333Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2903} {"level":"info","ts":"2026-07-29T15:46:16.828872Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2903,"took":"111.024964ms","hash":2789715427,"current-db-size-bytes":54394880,"current-db-size":"54 MB","current-db-size-in-use-bytes":29073408,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-07-29T15:46:16.82892Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2789715427,"revision":2903,"compact-revision":-1} {"level":"info","ts":"2026-07-29T15:49:06.581224Z","caller":"traceutil/trace.go:171","msg":"trace[307362794] transaction","detail":"{read_only:false; response_revision:6699; number_of_response:1; }","duration":"156.597242ms","start":"2026-07-29T15:49:06.424479Z","end":"2026-07-29T15:49:06.581076Z","steps":["trace[307362794] 'process raft request' (duration: 108.64703ms)","trace[307362794] 'compare' (duration: 46.500571ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:49:12.722017Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2834347112403172811,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T15:49:13.222193Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2834347112403172811,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T15:49:13.723125Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":2834347112403172811,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-07-29T15:49:13.919781Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.833820217s","expected-duration":"1s"} {"level":"info","ts":"2026-07-29T15:49:13.920546Z","caller":"traceutil/trace.go:171","msg":"trace[492318311] transaction","detail":"{read_only:false; response_revision:6731; number_of_response:1; }","duration":"1.834791635s","start":"2026-07-29T15:49:12.085725Z","end":"2026-07-29T15:49:13.920516Z","steps":["trace[492318311] 'process raft request' (duration: 1.834584399s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.920738Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.085674Z","time spent":"1.8349702s","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":4945,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:49:13.927991Z","caller":"traceutil/trace.go:171","msg":"trace[559173306] transaction","detail":"{read_only:false; response_revision:6732; number_of_response:1; }","duration":"1.738667887s","start":"2026-07-29T15:49:12.189311Z","end":"2026-07-29T15:49:13.927979Z","steps":["trace[559173306] 'process raft request' (duration: 1.738554594s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.928072Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.189282Z","time spent":"1.7387478s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:49:13.928379Z","caller":"traceutil/trace.go:171","msg":"trace[223305245] transaction","detail":"{read_only:false; response_revision:6733; number_of_response:1; }","duration":"1.089024472s","start":"2026-07-29T15:49:12.839343Z","end":"2026-07-29T15:49:13.928368Z","steps":["trace[223305245] 'process raft request' (duration: 1.08860081s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.928426Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.839316Z","time spent":"1.089088164s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":673,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:49:13.928509Z","caller":"traceutil/trace.go:171","msg":"trace[629161372] transaction","detail":"{read_only:false; response_revision:6734; number_of_response:1; }","duration":"695.203863ms","start":"2026-07-29T15:49:13.23329Z","end":"2026-07-29T15:49:13.928494Z","steps":["trace[629161372] 'process raft request' (duration: 694.912835ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:49:13.928548Z","caller":"traceutil/trace.go:171","msg":"trace[2012163330] transaction","detail":"{read_only:false; response_revision:6736; number_of_response:1; }","duration":"313.24685ms","start":"2026-07-29T15:49:13.615293Z","end":"2026-07-29T15:49:13.92854Z","steps":["trace[2012163330] 'process raft request' (duration: 313.099846ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:49:13.928626Z","caller":"traceutil/trace.go:171","msg":"trace[1345096420] linearizableReadLoop","detail":"{readStateIndex:6982; appliedIndex:6975; }","duration":"1.707352306s","start":"2026-07-29T15:49:12.221261Z","end":"2026-07-29T15:49:13.928613Z","steps":["trace[1345096420] 'read index received' (duration: 1.6990345s)","trace[1345096420] 'applied index is now lower than readState.Index' (duration: 8.316586ms)"],"step_count":2} {"level":"warn","ts":"2026-07-29T15:49:13.928629Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:13.615284Z","time spent":"313.291392ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:49:13.928673Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:13.233263Z","time spent":"695.304566ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":554,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-07-29T15:49:13.928718Z","caller":"traceutil/trace.go:171","msg":"trace[175102292] transaction","detail":"{read_only:false; response_revision:6737; number_of_response:1; }","duration":"273.951674ms","start":"2026-07-29T15:49:13.654756Z","end":"2026-07-29T15:49:13.928707Z","steps":["trace[175102292] 'process raft request' (duration: 273.744218ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:49:13.928481Z","caller":"traceutil/trace.go:171","msg":"trace[1271276594] transaction","detail":"{read_only:false; response_revision:6735; number_of_response:1; }","duration":"320.021742ms","start":"2026-07-29T15:49:13.608422Z","end":"2026-07-29T15:49:13.928444Z","steps":["trace[1271276594] 'process raft request' (duration: 319.92194ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.928861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:13.608392Z","time spent":"320.437464ms","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":510,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-07-29T15:49:13.928893Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.707641234s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"warn","ts":"2026-07-29T15:49:13.928795Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.536199153s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T15:49:13.928942Z","caller":"traceutil/trace.go:171","msg":"trace[1957283074] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:6737; }","duration":"1.707699796s","start":"2026-07-29T15:49:12.221219Z","end":"2026-07-29T15:49:13.928919Z","steps":["trace[1957283074] 'agreement among raft nodes before linearized reading' (duration: 1.707598863s)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:49:13.928953Z","caller":"traceutil/trace.go:171","msg":"trace[718507662] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:6737; }","duration":"1.536398338s","start":"2026-07-29T15:49:12.392541Z","end":"2026-07-29T15:49:13.928939Z","steps":["trace[718507662] 'agreement among raft nodes before linearized reading' (duration: 1.536191903s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.928972Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.221205Z","time spent":"1.707761008s","remote":"127.0.0.1:46304","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-29T15:49:13.92899Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.392514Z","time spent":"1.53646484s","remote":"127.0.0.1:39610","response type":"/etcdserverpb.KV/Range","request count":0,"request size":98,"response count":0,"response size":28,"request content":"key:\"/registry/gateway.networking.k8s.io/tlsroutes/\" range_end:\"/registry/gateway.networking.k8s.io/tlsroutes0\" count_only:true "} {"level":"warn","ts":"2026-07-29T15:49:13.929061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"520.267763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4960"} {"level":"info","ts":"2026-07-29T15:49:13.929086Z","caller":"traceutil/trace.go:171","msg":"trace[397855954] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6737; }","duration":"520.325394ms","start":"2026-07-29T15:49:13.408754Z","end":"2026-07-29T15:49:13.929079Z","steps":["trace[397855954] 'agreement among raft nodes before linearized reading' (duration: 520.278043ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.929104Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:13.408743Z","time spent":"520.356956ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4983,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"warn","ts":"2026-07-29T15:49:13.92886Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"399.562863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-07-29T15:49:13.929181Z","caller":"traceutil/trace.go:171","msg":"trace[969288787] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:6737; }","duration":"399.933344ms","start":"2026-07-29T15:49:13.529237Z","end":"2026-07-29T15:49:13.929171Z","steps":["trace[969288787] 'agreement among raft nodes before linearized reading' (duration: 399.590314ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.929218Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:13.529212Z","time spent":"399.998326ms","remote":"127.0.0.1:46050","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-07-29T15:49:13.929291Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"525.200422ms","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-29T15:49:13.929322Z","caller":"traceutil/trace.go:171","msg":"trace[124354611] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:6737; }","duration":"525.296475ms","start":"2026-07-29T15:49:13.404019Z","end":"2026-07-29T15:49:13.929316Z","steps":["trace[124354611] 'agreement among raft nodes before linearized reading' (duration: 525.223123ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.929347Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:13.403989Z","time spent":"525.354307ms","remote":"127.0.0.1:46304","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-29T15:49:13.929437Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.268661206s","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-29T15:49:13.929459Z","caller":"traceutil/trace.go:171","msg":"trace[1368597547] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:6737; }","duration":"1.268740779s","start":"2026-07-29T15:49:12.660713Z","end":"2026-07-29T15:49:13.929454Z","steps":["trace[1368597547] 'agreement among raft nodes before linearized reading' (duration: 1.268682977s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.929476Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.660684Z","time spent":"1.26878785s","remote":"127.0.0.1:46304","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":516,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-07-29T15:49:13.929613Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.350725423s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-07-29T15:49:13.929633Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.429567618s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12215"} {"level":"info","ts":"2026-07-29T15:49:13.929651Z","caller":"traceutil/trace.go:171","msg":"trace[1185389721] range","detail":"{range_begin:/registry/secrets/; range_end:/registry/secrets0; response_count:0; response_revision:6737; }","duration":"1.350799314s","start":"2026-07-29T15:49:12.578845Z","end":"2026-07-29T15:49:13.929645Z","steps":["trace[1185389721] 'agreement among raft nodes before linearized reading' (duration: 1.350676411s)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:49:13.929666Z","caller":"traceutil/trace.go:171","msg":"trace[1930916036] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:6737; }","duration":"1.429629968s","start":"2026-07-29T15:49:12.500027Z","end":"2026-07-29T15:49:13.929657Z","steps":["trace[1930916036] 'agreement among raft nodes before linearized reading' (duration: 1.429506885s)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.929704Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.500007Z","time spent":"1.429690891s","remote":"127.0.0.1:46246","response type":"/etcdserverpb.KV/Range","request count":0,"request size":47,"response count":1,"response size":12238,"request content":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" "} {"level":"warn","ts":"2026-07-29T15:49:13.929675Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:12.578826Z","time spent":"1.350841856s","remote":"127.0.0.1:46154","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":67,"response size":30,"request content":"key:\"/registry/secrets/\" range_end:\"/registry/secrets0\" count_only:true "} {"level":"warn","ts":"2026-07-29T15:49:13.930066Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"218.197959ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4960"} {"level":"warn","ts":"2026-07-29T15:49:13.93008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.424575ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-07-29T15:49:13.930112Z","caller":"traceutil/trace.go:171","msg":"trace[478116557] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:6737; }","duration":"162.482417ms","start":"2026-07-29T15:49:13.767622Z","end":"2026-07-29T15:49:13.930105Z","steps":["trace[478116557] 'agreement among raft nodes before linearized reading' (duration: 162.389164ms)"],"step_count":1} {"level":"info","ts":"2026-07-29T15:49:13.930116Z","caller":"traceutil/trace.go:171","msg":"trace[1659884411] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6737; }","duration":"218.300962ms","start":"2026-07-29T15:49:13.7118Z","end":"2026-07-29T15:49:13.930101Z","steps":["trace[1659884411] 'agreement among raft nodes before linearized reading' (duration: 218.199939ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.930041Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"162.317912ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-07-29T15:49:13.930188Z","caller":"traceutil/trace.go:171","msg":"trace[869563690] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:6737; }","duration":"162.513127ms","start":"2026-07-29T15:49:13.76767Z","end":"2026-07-29T15:49:13.930184Z","steps":["trace[869563690] 'agreement among raft nodes before linearized reading' (duration: 161.212641ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.930371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"317.934404ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/horizon-db-sync\" ","response":"range_response_count:1 size:4960"} {"level":"info","ts":"2026-07-29T15:49:13.930568Z","caller":"traceutil/trace.go:171","msg":"trace[635298242] range","detail":"{range_begin:/registry/jobs/openstack/horizon-db-sync; range_end:; response_count:1; response_revision:6737; }","duration":"318.020847ms","start":"2026-07-29T15:49:13.612396Z","end":"2026-07-29T15:49:13.930417Z","steps":["trace[635298242] 'agreement among raft nodes before linearized reading' (duration: 317.702347ms)"],"step_count":1} {"level":"warn","ts":"2026-07-29T15:49:13.930744Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-07-29T15:49:13.612386Z","time spent":"318.232282ms","remote":"127.0.0.1:46288","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":4983,"request content":"key:\"/registry/jobs/openstack/horizon-db-sync\" "} {"level":"info","ts":"2026-07-29T15:51:16.723801Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5551} {"level":"info","ts":"2026-07-29T15:51:16.821739Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5551,"took":"95.772954ms","hash":2070857922,"current-db-size-bytes":54394880,"current-db-size":"54 MB","current-db-size-in-use-bytes":18583552,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-07-29T15:51:16.821959Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2070857922,"revision":5551,"compact-revision":2903}