{"level":"warn","ts":"2026-08-06T19:08:26.34223Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-06T19:08:26.342318Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.129: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.129:2380","--initial-cluster=instance=https://199.204.45.129:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.129:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.129: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-08-06T19:08:26.342403Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-06T19:08:26.342415Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-08-06T19:08:26.342449Z","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-08-06T19:08:26.343159Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"]} {"level":"info","ts":"2026-08-06T19:08:26.343257Z","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.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.129: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-08-06T19:08:26.346869Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"3.361463ms"} {"level":"info","ts":"2026-08-06T19:08:26.364688Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"3cec112083e8d3ff","cluster-id":"3f68255a3b440659"} {"level":"info","ts":"2026-08-06T19:08:26.364757Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=()"} {"level":"info","ts":"2026-08-06T19:08:26.364791Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 0"} {"level":"info","ts":"2026-08-06T19:08:26.364884Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 3cec112083e8d3ff [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-06T19:08:26.364903Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became follower at term 1"} {"level":"info","ts":"2026-08-06T19:08:26.364952Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"warn","ts":"2026-08-06T19:08:26.368303Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-06T19:08:26.369409Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-06T19:08:26.370364Z","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-08-06T19:08:26.373185Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"3cec112083e8d3ff","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-06T19:08:26.3755Z","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-08-06T19:08:26.375866Z","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-08-06T19:08:26.375886Z","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-08-06T19:08:26.375588Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"3cec112083e8d3ff","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-06T19:08:26.377771Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff switched to configuration voters=(4389902568129090559)"} {"level":"info","ts":"2026-08-06T19:08:26.37948Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","added-peer-id":"3cec112083e8d3ff","added-peer-peer-urls":["https://199.204.45.129:2380"]} {"level":"info","ts":"2026-08-06T19:08:26.381503Z","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-08-06T19:08:26.381671Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-08-06T19:08:26.382486Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.129:2380"} {"level":"info","ts":"2026-08-06T19:08:26.382085Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"3cec112083e8d3ff","initial-advertise-peer-urls":["https://199.204.45.129:2380"],"listen-peer-urls":["https://199.204.45.129:2380"],"advertise-client-urls":["https://199.204.45.129:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.129:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-06T19:08:26.382124Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-06T19:08:27.36583Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff is starting a new election at term 1"} {"level":"info","ts":"2026-08-06T19:08:27.365907Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became pre-candidate at term 1"} {"level":"info","ts":"2026-08-06T19:08:27.365943Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgPreVoteResp from 3cec112083e8d3ff at term 1"} {"level":"info","ts":"2026-08-06T19:08:27.365963Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became candidate at term 2"} {"level":"info","ts":"2026-08-06T19:08:27.365974Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff received MsgVoteResp from 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-08-06T19:08:27.365989Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"3cec112083e8d3ff became leader at term 2"} {"level":"info","ts":"2026-08-06T19:08:27.366005Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 3cec112083e8d3ff elected leader 3cec112083e8d3ff at term 2"} {"level":"info","ts":"2026-08-06T19:08:27.367142Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"3cec112083e8d3ff","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.129:2379]}","request-path":"/0/members/3cec112083e8d3ff/attributes","cluster-id":"3f68255a3b440659","publish-timeout":"7s"} {"level":"info","ts":"2026-08-06T19:08:27.367195Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T19:08:27.367297Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-06T19:08:27.367305Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T19:08:27.367746Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-06T19:08:27.367893Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-06T19:08:27.368417Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"3f68255a3b440659","local-member-id":"3cec112083e8d3ff","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T19:08:27.368562Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T19:08:27.368602Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-06T19:08:27.369301Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.129:2379"} {"level":"info","ts":"2026-08-06T19:08:27.371497Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-06T19:08:39.451048Z","caller":"traceutil/trace.go:171","msg":"trace[459883469] transaction","detail":"{read_only:false; response_revision:398; number_of_response:1; }","duration":"172.364773ms","start":"2026-08-06T19:08:39.278645Z","end":"2026-08-06T19:08:39.45101Z","steps":["trace[459883469] 'process raft request' (duration: 172.121306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:08:39.671418Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"147.085034ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T19:08:39.671574Z","caller":"traceutil/trace.go:171","msg":"trace[614603302] transaction","detail":"{read_only:false; response_revision:399; number_of_response:1; }","duration":"216.235395ms","start":"2026-08-06T19:08:39.455319Z","end":"2026-08-06T19:08:39.671555Z","steps":["trace[614603302] 'process raft request' (duration: 68.424041ms)","trace[614603302] 'compare' (duration: 146.951821ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:09:09.197608Z","caller":"traceutil/trace.go:171","msg":"trace[407843103] transaction","detail":"{read_only:false; response_revision:630; number_of_response:1; }","duration":"209.470439ms","start":"2026-08-06T19:09:08.988112Z","end":"2026-08-06T19:09:09.197582Z","steps":["trace[407843103] 'process raft request' (duration: 208.926084ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:09:09.468896Z","caller":"traceutil/trace.go:171","msg":"trace[626528376] transaction","detail":"{read_only:false; response_revision:631; number_of_response:1; }","duration":"213.033857ms","start":"2026-08-06T19:09:09.255839Z","end":"2026-08-06T19:09:09.468873Z","steps":["trace[626528376] 'process raft request' (duration: 197.727724ms)","trace[626528376] 'compare' (duration: 15.035556ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:09:09.46895Z","caller":"traceutil/trace.go:171","msg":"trace[1925299256] transaction","detail":"{read_only:false; response_revision:632; number_of_response:1; }","duration":"211.00883ms","start":"2026-08-06T19:09:09.257907Z","end":"2026-08-06T19:09:09.468916Z","steps":["trace[1925299256] 'process raft request' (duration: 210.903188ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:09:24.769108Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"151.213158ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-06T19:09:24.769226Z","caller":"traceutil/trace.go:171","msg":"trace[1629386316] linearizableReadLoop","detail":"{readStateIndex:818; appliedIndex:817; }","duration":"165.861683ms","start":"2026-08-06T19:09:24.603347Z","end":"2026-08-06T19:09:24.769209Z","steps":["trace[1629386316] 'read index received' (duration: 14.406238ms)","trace[1629386316] 'applied index is now lower than readState.Index' (duration: 151.453935ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:09:24.769275Z","caller":"traceutil/trace.go:171","msg":"trace[1164106880] transaction","detail":"{read_only:false; response_revision:794; number_of_response:1; }","duration":"254.472012ms","start":"2026-08-06T19:09:24.514768Z","end":"2026-08-06T19:09:24.76924Z","steps":["trace[1164106880] 'process raft request' (duration: 103.031167ms)","trace[1164106880] 'compare' (duration: 151.104485ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:09:24.76936Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.014228ms","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-08-06T19:09:24.769389Z","caller":"traceutil/trace.go:171","msg":"trace[329470151] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:794; }","duration":"166.09494ms","start":"2026-08-06T19:09:24.603285Z","end":"2026-08-06T19:09:24.76938Z","steps":["trace[329470151] 'agreement among raft nodes before linearized reading' (duration: 165.969276ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:10:42.534508Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.079841ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T19:10:42.534665Z","caller":"traceutil/trace.go:171","msg":"trace[868259754] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1869; }","duration":"149.300417ms","start":"2026-08-06T19:10:42.385332Z","end":"2026-08-06T19:10:42.534633Z","steps":["trace[868259754] 'range keys from in-memory index tree' (duration: 148.792504ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:10:42.826761Z","caller":"traceutil/trace.go:171","msg":"trace[1773867231] transaction","detail":"{read_only:false; response_revision:1876; number_of_response:1; }","duration":"125.103707ms","start":"2026-08-06T19:10:42.701623Z","end":"2026-08-06T19:10:42.826726Z","steps":["trace[1773867231] 'process raft request' (duration: 124.920102ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:10:55.179137Z","caller":"traceutil/trace.go:171","msg":"trace[1180235492] linearizableReadLoop","detail":"{readStateIndex:2049; appliedIndex:2048; }","duration":"100.080673ms","start":"2026-08-06T19:10:55.078943Z","end":"2026-08-06T19:10:55.179024Z","steps":["trace[1180235492] 'read index received' (duration: 45.089119ms)","trace[1180235492] 'applied index is now lower than readState.Index' (duration: 54.989934ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:10:55.179187Z","caller":"traceutil/trace.go:171","msg":"trace[908782572] transaction","detail":"{read_only:false; response_revision:1979; number_of_response:1; }","duration":"127.605806ms","start":"2026-08-06T19:10:55.051518Z","end":"2026-08-06T19:10:55.179124Z","steps":["trace[908782572] 'process raft request' (duration: 72.482168ms)","trace[908782572] 'compare' (duration: 54.84368ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:10:55.179353Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.402763ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-06T19:10:55.179428Z","caller":"traceutil/trace.go:171","msg":"trace[624599034] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1979; }","duration":"100.523116ms","start":"2026-08-06T19:10:55.078885Z","end":"2026-08-06T19:10:55.179408Z","steps":["trace[624599034] 'agreement among raft nodes before linearized reading' (duration: 100.30688ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:10:58.121924Z","caller":"traceutil/trace.go:171","msg":"trace[671183386] transaction","detail":"{read_only:false; response_revision:1998; number_of_response:1; }","duration":"126.63217ms","start":"2026-08-06T19:10:57.995231Z","end":"2026-08-06T19:10:58.121863Z","steps":["trace[671183386] 'process raft request' (duration: 126.27201ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:11:31.601012Z","caller":"traceutil/trace.go:171","msg":"trace[1434402222] transaction","detail":"{read_only:false; response_revision:2191; number_of_response:1; }","duration":"114.865833ms","start":"2026-08-06T19:11:31.486108Z","end":"2026-08-06T19:11:31.600974Z","steps":["trace[1434402222] 'process raft request' (duration: 51.273511ms)","trace[1434402222] 'compare' (duration: 63.451548ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:11:37.712417Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"231.375722ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"warn","ts":"2026-08-06T19:11:37.712485Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"189.545863ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-06T19:11:37.712509Z","caller":"traceutil/trace.go:171","msg":"trace[259015990] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2221; }","duration":"231.523716ms","start":"2026-08-06T19:11:37.480961Z","end":"2026-08-06T19:11:37.712484Z","steps":["trace[259015990] 'range keys from in-memory index tree' (duration: 231.165116ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:11:37.712557Z","caller":"traceutil/trace.go:171","msg":"trace[1095687498] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:2221; }","duration":"189.645405ms","start":"2026-08-06T19:11:37.522887Z","end":"2026-08-06T19:11:37.712532Z","steps":["trace[1095687498] 'range keys from in-memory index tree' (duration: 189.410469ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:11:37.855492Z","caller":"traceutil/trace.go:171","msg":"trace[1159370408] transaction","detail":"{read_only:false; response_revision:2222; number_of_response:1; }","duration":"138.006633ms","start":"2026-08-06T19:11:37.717468Z","end":"2026-08-06T19:11:37.855474Z","steps":["trace[1159370408] 'process raft request' (duration: 137.864789ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:11:37.986258Z","caller":"traceutil/trace.go:171","msg":"trace[1008759096] transaction","detail":"{read_only:false; response_revision:2223; number_of_response:1; }","duration":"268.602642ms","start":"2026-08-06T19:11:37.717631Z","end":"2026-08-06T19:11:37.986233Z","steps":["trace[1008759096] 'process raft request' (duration: 268.231382ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:11:37.987366Z","caller":"traceutil/trace.go:171","msg":"trace[280413262] transaction","detail":"{read_only:false; response_revision:2224; number_of_response:1; }","duration":"177.160059ms","start":"2026-08-06T19:11:37.810194Z","end":"2026-08-06T19:11:37.987354Z","steps":["trace[280413262] 'process raft request' (duration: 176.006917ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:11:37.987318Z","caller":"traceutil/trace.go:171","msg":"trace[318381703] linearizableReadLoop","detail":"{readStateIndex:2303; appliedIndex:2301; }","duration":"207.457878ms","start":"2026-08-06T19:11:37.779807Z","end":"2026-08-06T19:11:37.987265Z","steps":["trace[318381703] 'read index received' (duration: 75.571644ms)","trace[318381703] 'applied index is now lower than readState.Index' (duration: 131.882504ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:11:37.987605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"207.690634ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/superstreams/\" range_end:\"/registry/rabbitmq.com/superstreams0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T19:11:37.987651Z","caller":"traceutil/trace.go:171","msg":"trace[1529717858] range","detail":"{range_begin:/registry/rabbitmq.com/superstreams/; range_end:/registry/rabbitmq.com/superstreams0; response_count:0; response_revision:2224; }","duration":"207.90416ms","start":"2026-08-06T19:11:37.779733Z","end":"2026-08-06T19:11:37.987637Z","steps":["trace[1529717858] 'agreement among raft nodes before linearized reading' (duration: 207.692605ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:15:11.036435Z","caller":"traceutil/trace.go:171","msg":"trace[1136476158] transaction","detail":"{read_only:false; response_revision:3755; number_of_response:1; }","duration":"124.401081ms","start":"2026-08-06T19:15:10.912016Z","end":"2026-08-06T19:15:11.036417Z","steps":["trace[1136476158] 'process raft request' (duration: 124.269617ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:15:16.444547Z","caller":"traceutil/trace.go:171","msg":"trace[2139237325] transaction","detail":"{read_only:false; response_revision:3783; number_of_response:1; }","duration":"146.531208ms","start":"2026-08-06T19:15:16.297998Z","end":"2026-08-06T19:15:16.444529Z","steps":["trace[2139237325] 'process raft request' (duration: 146.004743ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:16:38.062001Z","caller":"traceutil/trace.go:171","msg":"trace[1457685671] transaction","detail":"{read_only:false; response_revision:4939; number_of_response:1; }","duration":"117.225867ms","start":"2026-08-06T19:16:37.944732Z","end":"2026-08-06T19:16:38.061958Z","steps":["trace[1457685671] 'process raft request' (duration: 69.009029ms)","trace[1457685671] 'compare' (duration: 48.011342ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:16:52.028039Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"369.017013ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-qgrlz\" ","response":"range_response_count:1 size:7818"} {"level":"info","ts":"2026-08-06T19:16:52.028144Z","caller":"traceutil/trace.go:171","msg":"trace[1037440961] range","detail":"{range_begin:/registry/pods/openstack/memcached-memcached-6479589586-qgrlz; range_end:; response_count:1; response_revision:5204; }","duration":"369.182527ms","start":"2026-08-06T19:16:51.658941Z","end":"2026-08-06T19:16:52.028123Z","steps":["trace[1037440961] 'range keys from in-memory index tree' (duration: 368.827728ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:16:52.028195Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T19:16:51.658917Z","time spent":"369.26327ms","remote":"127.0.0.1:34342","response type":"/etcdserverpb.KV/Range","request count":0,"request size":63,"response count":1,"response size":7840,"request content":"key:\"/registry/pods/openstack/memcached-memcached-6479589586-qgrlz\" "} {"level":"warn","ts":"2026-08-06T19:16:52.028459Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"114.409038ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-08-06T19:16:52.02872Z","caller":"traceutil/trace.go:171","msg":"trace[1456424876] linearizableReadLoop","detail":"{readStateIndex:5395; appliedIndex:5394; }","duration":"168.761397ms","start":"2026-08-06T19:16:51.859945Z","end":"2026-08-06T19:16:52.028707Z","steps":["trace[1456424876] 'read index received' (duration: 54.03142ms)","trace[1456424876] 'applied index is now lower than readState.Index' (duration: 114.728387ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:16:52.028833Z","caller":"traceutil/trace.go:171","msg":"trace[1081062687] transaction","detail":"{read_only:false; response_revision:5205; number_of_response:1; }","duration":"315.849208ms","start":"2026-08-06T19:16:51.712972Z","end":"2026-08-06T19:16:52.028821Z","steps":["trace[1081062687] 'process raft request' (duration: 201.003878ms)","trace[1081062687] 'compare' (duration: 114.250013ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:16:52.028905Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T19:16:51.712939Z","time spent":"315.91585ms","remote":"127.0.0.1:34220","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":805,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-08-06T19:16:52.029004Z","caller":"traceutil/trace.go:171","msg":"trace[422064505] transaction","detail":"{read_only:false; response_revision:5206; number_of_response:1; }","duration":"134.021105ms","start":"2026-08-06T19:16:51.894963Z","end":"2026-08-06T19:16:52.028984Z","steps":["trace[422064505] 'process raft request' (duration: 133.602724ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:16:52.029092Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"169.142607ms","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-08-06T19:16:52.029133Z","caller":"traceutil/trace.go:171","msg":"trace[882021553] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tlsroutes/; range_end:/registry/gateway.networking.k8s.io/tlsroutes0; response_count:0; response_revision:5207; }","duration":"169.217979ms","start":"2026-08-06T19:16:51.859902Z","end":"2026-08-06T19:16:52.02912Z","steps":["trace[882021553] 'agreement among raft nodes before linearized reading' (duration: 169.152407ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:16:52.030421Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.105927ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/\" range_end:\"/registry/events0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-06T19:16:52.030466Z","caller":"traceutil/trace.go:171","msg":"trace[520169220] range","detail":"{range_begin:/registry/events/; range_end:/registry/events0; response_count:0; response_revision:5207; }","duration":"110.183229ms","start":"2026-08-06T19:16:51.920274Z","end":"2026-08-06T19:16:52.030457Z","steps":["trace[520169220] 'agreement among raft nodes before linearized reading' (duration: 108.999946ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:16:59.861466Z","caller":"traceutil/trace.go:171","msg":"trace[255081101] linearizableReadLoop","detail":"{readStateIndex:5573; appliedIndex:5572; }","duration":"109.689786ms","start":"2026-08-06T19:16:59.751746Z","end":"2026-08-06T19:16:59.861436Z","steps":["trace[255081101] 'read index received' (duration: 109.46324ms)","trace[255081101] 'applied index is now lower than readState.Index' (duration: 225.756µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:16:59.861537Z","caller":"traceutil/trace.go:171","msg":"trace[395987051] transaction","detail":"{read_only:false; response_revision:5379; number_of_response:1; }","duration":"114.960602ms","start":"2026-08-06T19:16:59.746529Z","end":"2026-08-06T19:16:59.861489Z","steps":["trace[395987051] 'process raft request' (duration: 114.699255ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:16:59.86183Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.047416ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:7614"} {"level":"info","ts":"2026-08-06T19:16:59.862015Z","caller":"traceutil/trace.go:171","msg":"trace[614315154] range","detail":"{range_begin:/registry/monitoring.coreos.com/prometheuses/monitoring/kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:5379; }","duration":"110.269451ms","start":"2026-08-06T19:16:59.751717Z","end":"2026-08-06T19:16:59.861986Z","steps":["trace[614315154] 'agreement among raft nodes before linearized reading' (duration: 109.86559ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:17:00.044861Z","caller":"traceutil/trace.go:171","msg":"trace[351716641] linearizableReadLoop","detail":"{readStateIndex:5574; appliedIndex:5573; }","duration":"179.031652ms","start":"2026-08-06T19:16:59.865799Z","end":"2026-08-06T19:17:00.044831Z","steps":["trace[351716641] 'read index received' (duration: 131.690389ms)","trace[351716641] 'applied index is now lower than readState.Index' (duration: 47.339963ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:17:00.045045Z","caller":"traceutil/trace.go:171","msg":"trace[727956130] transaction","detail":"{read_only:false; response_revision:5380; number_of_response:1; }","duration":"257.759203ms","start":"2026-08-06T19:16:59.787241Z","end":"2026-08-06T19:17:00.045Z","steps":["trace[727956130] 'process raft request' (duration: 210.315877ms)","trace[727956130] 'compare' (duration: 47.135457ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:17:00.045283Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.394672ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/loki-results-cache-0\" ","response":"range_response_count:1 size:4474"} {"level":"info","ts":"2026-08-06T19:17:00.04537Z","caller":"traceutil/trace.go:171","msg":"trace[1287552913] range","detail":"{range_begin:/registry/pods/monitoring/loki-results-cache-0; range_end:; response_count:1; response_revision:5380; }","duration":"179.616879ms","start":"2026-08-06T19:16:59.865728Z","end":"2026-08-06T19:17:00.045345Z","steps":["trace[1287552913] 'agreement among raft nodes before linearized reading' (duration: 179.251258ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:18:27.398058Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":3018} {"level":"info","ts":"2026-08-06T19:18:27.485923Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":3018,"took":"85.914701ms","hash":1239616601,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":32346112,"current-db-size-in-use":"32 MB"} {"level":"info","ts":"2026-08-06T19:18:27.486005Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1239616601,"revision":3018,"compact-revision":-1} {"level":"warn","ts":"2026-08-06T19:23:15.728964Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"168.809586ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-08-06T19:23:15.729345Z","caller":"traceutil/trace.go:171","msg":"trace[1415282091] linearizableReadLoop","detail":"{readStateIndex:8532; appliedIndex:8530; }","duration":"211.70288ms","start":"2026-08-06T19:23:15.517617Z","end":"2026-08-06T19:23:15.72932Z","steps":["trace[1415282091] 'read index received' (duration: 42.554894ms)","trace[1415282091] 'applied index is now lower than readState.Index' (duration: 169.146486ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:23:15.729459Z","caller":"traceutil/trace.go:171","msg":"trace[131158849] transaction","detail":"{read_only:false; response_revision:8248; number_of_response:1; }","duration":"297.745753ms","start":"2026-08-06T19:23:15.431705Z","end":"2026-08-06T19:23:15.729451Z","steps":["trace[131158849] 'process raft request' (duration: 297.349942ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:23:15.729674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"212.029139ms","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-08-06T19:23:15.729716Z","caller":"traceutil/trace.go:171","msg":"trace[878356255] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8248; }","duration":"212.131722ms","start":"2026-08-06T19:23:15.517574Z","end":"2026-08-06T19:23:15.729706Z","steps":["trace[878356255] 'agreement among raft nodes before linearized reading' (duration: 211.967977ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:23:15.72992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"195.981509ms","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-08-06T19:23:15.73003Z","caller":"traceutil/trace.go:171","msg":"trace[1879248254] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8248; }","duration":"196.111622ms","start":"2026-08-06T19:23:15.533868Z","end":"2026-08-06T19:23:15.72998Z","steps":["trace[1879248254] 'agreement among raft nodes before linearized reading' (duration: 195.67974ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:23:27.667369Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6145} {"level":"warn","ts":"2026-08-06T19:23:27.668625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"192.552352ms","expected-duration":"100ms","prefix":"","request":"header: compaction: ","response":"size:5"} {"level":"info","ts":"2026-08-06T19:23:27.668778Z","caller":"traceutil/trace.go:171","msg":"trace[2105580517] linearizableReadLoop","detail":"{readStateIndex:8597; appliedIndex:8596; }","duration":"236.034652ms","start":"2026-08-06T19:23:27.432719Z","end":"2026-08-06T19:23:27.668753Z","steps":["trace[2105580517] 'read index received' (duration: 41.957647ms)","trace[2105580517] 'applied index is now lower than readState.Index' (duration: 194.075155ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:23:27.668926Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"236.190056ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/deployments/openstack/percona-xtradb-pitr\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-06T19:23:27.668985Z","caller":"traceutil/trace.go:171","msg":"trace[326757636] range","detail":"{range_begin:/registry/deployments/openstack/percona-xtradb-pitr; range_end:; response_count:0; response_revision:8310; }","duration":"236.299239ms","start":"2026-08-06T19:23:27.432667Z","end":"2026-08-06T19:23:27.668966Z","steps":["trace[326757636] 'agreement among raft nodes before linearized reading' (duration: 236.155305ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:23:27.668989Z","caller":"traceutil/trace.go:171","msg":"trace[1408842746] compact","detail":"{revision:6145; response_revision:8310; }","duration":"264.375797ms","start":"2026-08-06T19:23:27.404545Z","end":"2026-08-06T19:23:27.668921Z","steps":["trace[1408842746] 'process raft request' (duration: 70.163698ms)","trace[1408842746] 'check and update compact revision' (duration: 192.386488ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:23:27.8408Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.507467ms","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-08-06T19:23:27.841215Z","caller":"traceutil/trace.go:171","msg":"trace[2088981114] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8310; }","duration":"163.98348ms","start":"2026-08-06T19:23:27.677206Z","end":"2026-08-06T19:23:27.841189Z","steps":["trace[2088981114] 'range keys from in-memory index tree' (duration: 162.714655ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:23:27.99252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.539855ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-08-06T19:23:27.992623Z","caller":"traceutil/trace.go:171","msg":"trace[820645535] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8313; }","duration":"108.676399ms","start":"2026-08-06T19:23:27.88392Z","end":"2026-08-06T19:23:27.992596Z","steps":["trace[820645535] 'agreement among raft nodes before linearized reading' (duration: 89.311336ms)","trace[820645535] 'range keys from in-memory index tree' (duration: 19.062695ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:23:27.992807Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.600541ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:25 size:224147"} {"level":"info","ts":"2026-08-06T19:23:27.99291Z","caller":"traceutil/trace.go:171","msg":"trace[875898339] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:25; response_revision:8313; }","duration":"111.791286ms","start":"2026-08-06T19:23:27.881096Z","end":"2026-08-06T19:23:27.992887Z","steps":["trace[875898339] 'agreement among raft nodes before linearized reading' (duration: 92.153205ms)","trace[875898339] 'range keys from in-memory index tree' (duration: 18.963483ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:23:28.184712Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6145,"took":"514.541425ms","hash":2423511617,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":23277568,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-08-06T19:23:28.184805Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2423511617,"revision":6145,"compact-revision":3018} {"level":"info","ts":"2026-08-06T19:23:28.588194Z","caller":"traceutil/trace.go:171","msg":"trace[1706633090] transaction","detail":"{read_only:false; response_revision:8317; number_of_response:1; }","duration":"246.783503ms","start":"2026-08-06T19:23:28.341379Z","end":"2026-08-06T19:23:28.588162Z","steps":["trace[1706633090] 'process raft request' (duration: 246.534336ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:23:56.880039Z","caller":"traceutil/trace.go:171","msg":"trace[571765690] transaction","detail":"{read_only:false; response_revision:8522; number_of_response:1; }","duration":"191.122012ms","start":"2026-08-06T19:23:56.68889Z","end":"2026-08-06T19:23:56.880012Z","steps":["trace[571765690] 'process raft request' (duration: 190.965938ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:00.220871Z","caller":"traceutil/trace.go:171","msg":"trace[697514804] linearizableReadLoop","detail":"{readStateIndex:8834; appliedIndex:8833; }","duration":"101.21569ms","start":"2026-08-06T19:24:00.119619Z","end":"2026-08-06T19:24:00.220835Z","steps":["trace[697514804] 'read index received' (duration: 53.375418ms)","trace[697514804] 'applied index is now lower than readState.Index' (duration: 47.839322ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:24:00.220896Z","caller":"traceutil/trace.go:171","msg":"trace[1288378869] transaction","detail":"{read_only:false; response_revision:8538; number_of_response:1; }","duration":"167.796878ms","start":"2026-08-06T19:24:00.053069Z","end":"2026-08-06T19:24:00.220866Z","steps":["trace[1288378869] 'process raft request' (duration: 120.012157ms)","trace[1288378869] 'compare' (duration: 47.452501ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:24:00.221083Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.460206ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-08-06T19:24:00.221111Z","caller":"traceutil/trace.go:171","msg":"trace[999491386] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8538; }","duration":"101.501888ms","start":"2026-08-06T19:24:00.119601Z","end":"2026-08-06T19:24:00.221103Z","steps":["trace[999491386] 'agreement among raft nodes before linearized reading' (duration: 101.365404ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:24:00.221105Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.040047ms","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-08-06T19:24:00.221155Z","caller":"traceutil/trace.go:171","msg":"trace[66500579] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8538; }","duration":"100.13406ms","start":"2026-08-06T19:24:00.121007Z","end":"2026-08-06T19:24:00.221141Z","steps":["trace[66500579] 'agreement among raft nodes before linearized reading' (duration: 100.003816ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:00.428746Z","caller":"traceutil/trace.go:171","msg":"trace[1731040107] transaction","detail":"{read_only:false; response_revision:8539; number_of_response:1; }","duration":"204.211849ms","start":"2026-08-06T19:24:00.224497Z","end":"2026-08-06T19:24:00.428709Z","steps":["trace[1731040107] 'process raft request' (duration: 139.464263ms)","trace[1731040107] 'compare' (duration: 64.556531ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:24:00.428821Z","caller":"traceutil/trace.go:171","msg":"trace[863413027] transaction","detail":"{read_only:false; response_revision:8540; number_of_response:1; }","duration":"203.806047ms","start":"2026-08-06T19:24:00.224983Z","end":"2026-08-06T19:24:00.428789Z","steps":["trace[863413027] 'process raft request' (duration: 203.707045ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:00.428882Z","caller":"traceutil/trace.go:171","msg":"trace[1185034044] transaction","detail":"{read_only:false; response_revision:8541; number_of_response:1; }","duration":"177.253754ms","start":"2026-08-06T19:24:00.251575Z","end":"2026-08-06T19:24:00.428829Z","steps":["trace[1185034044] 'process raft request' (duration: 177.168791ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:00.428911Z","caller":"traceutil/trace.go:171","msg":"trace[1338880254] linearizableReadLoop","detail":"{readStateIndex:8835; appliedIndex:8834; }","duration":"203.970803ms","start":"2026-08-06T19:24:00.224904Z","end":"2026-08-06T19:24:00.428874Z","steps":["trace[1338880254] 'read index received' (duration: 139.073442ms)","trace[1338880254] 'applied index is now lower than readState.Index' (duration: 64.893831ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:24:00.429337Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.123107ms","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-08-06T19:24:00.429426Z","caller":"traceutil/trace.go:171","msg":"trace[63081714] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8541; }","duration":"137.283102ms","start":"2026-08-06T19:24:00.292121Z","end":"2026-08-06T19:24:00.429404Z","steps":["trace[63081714] 'agreement among raft nodes before linearized reading' (duration: 137.006784ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:24:00.42967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"204.738774ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/\" range_end:\"/registry/pods/openstack0\" ","response":"range_response_count:26 size:228878"} {"level":"info","ts":"2026-08-06T19:24:00.429729Z","caller":"traceutil/trace.go:171","msg":"trace[64676446] range","detail":"{range_begin:/registry/pods/openstack/; range_end:/registry/pods/openstack0; response_count:26; response_revision:8541; }","duration":"204.867187ms","start":"2026-08-06T19:24:00.224849Z","end":"2026-08-06T19:24:00.429716Z","steps":["trace[64676446] 'agreement among raft nodes before linearized reading' (duration: 204.215769ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:09.321295Z","caller":"traceutil/trace.go:171","msg":"trace[1118116926] transaction","detail":"{read_only:false; response_revision:8629; number_of_response:1; }","duration":"119.40221ms","start":"2026-08-06T19:24:09.201866Z","end":"2026-08-06T19:24:09.321269Z","steps":["trace[1118116926] 'process raft request' (duration: 119.222325ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:09.472686Z","caller":"traceutil/trace.go:171","msg":"trace[85622265] transaction","detail":"{read_only:false; response_revision:8630; number_of_response:1; }","duration":"118.902926ms","start":"2026-08-06T19:24:09.353754Z","end":"2026-08-06T19:24:09.472657Z","steps":["trace[85622265] 'process raft request' (duration: 87.717381ms)","trace[85622265] 'compare' (duration: 31.04173ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:24:09.503998Z","caller":"traceutil/trace.go:171","msg":"trace[394976160] linearizableReadLoop","detail":"{readStateIndex:8932; appliedIndex:8930; }","duration":"118.75728ms","start":"2026-08-06T19:24:09.385218Z","end":"2026-08-06T19:24:09.503975Z","steps":["trace[394976160] 'read index received' (duration: 56.266268ms)","trace[394976160] 'applied index is now lower than readState.Index' (duration: 62.489952ms)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:24:09.504142Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"118.915435ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"warn","ts":"2026-08-06T19:24:09.504387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.669ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.carvel.dev/secrettemplates/\" range_end:\"/registry/secretgen.carvel.dev/secrettemplates0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T19:24:09.504518Z","caller":"traceutil/trace.go:171","msg":"trace[1604041350] range","detail":"{range_begin:/registry/secretgen.carvel.dev/secrettemplates/; range_end:/registry/secretgen.carvel.dev/secrettemplates0; response_count:0; response_revision:8631; }","duration":"102.814444ms","start":"2026-08-06T19:24:09.401685Z","end":"2026-08-06T19:24:09.504499Z","steps":["trace[1604041350] 'agreement among raft nodes before linearized reading' (duration: 102.602258ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:09.504529Z","caller":"traceutil/trace.go:171","msg":"trace[118861546] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8631; }","duration":"119.148851ms","start":"2026-08-06T19:24:09.385152Z","end":"2026-08-06T19:24:09.504301Z","steps":["trace[118861546] 'agreement among raft nodes before linearized reading' (duration: 118.929385ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:09.504797Z","caller":"traceutil/trace.go:171","msg":"trace[788984236] transaction","detail":"{read_only:false; response_revision:8631; number_of_response:1; }","duration":"144.849163ms","start":"2026-08-06T19:24:09.359908Z","end":"2026-08-06T19:24:09.504758Z","steps":["trace[788984236] 'process raft request' (duration: 143.949788ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:09.986517Z","caller":"traceutil/trace.go:171","msg":"trace[2100423019] transaction","detail":"{read_only:false; response_revision:8632; number_of_response:1; }","duration":"131.660244ms","start":"2026-08-06T19:24:09.854831Z","end":"2026-08-06T19:24:09.986492Z","steps":["trace[2100423019] 'process raft request' (duration: 131.439977ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:24:10.422156Z","caller":"traceutil/trace.go:171","msg":"trace[1151045718] transaction","detail":"{read_only:false; response_revision:8634; number_of_response:1; }","duration":"114.832652ms","start":"2026-08-06T19:24:10.307298Z","end":"2026-08-06T19:24:10.42213Z","steps":["trace[1151045718] 'process raft request' (duration: 98.200785ms)","trace[1151045718] 'compare' (duration: 16.520944ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:24:25.147373Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-000000000000237a.wal"} {"level":"info","ts":"2026-08-06T19:25:25.437449Z","caller":"traceutil/trace.go:171","msg":"trace[1326524325] transaction","detail":"{read_only:false; response_revision:9380; number_of_response:1; }","duration":"234.778821ms","start":"2026-08-06T19:25:25.202605Z","end":"2026-08-06T19:25:25.437383Z","steps":["trace[1326524325] 'process raft request' (duration: 234.527063ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:26:03.714684Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-06T19:26:03.722312Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-06T19:26:03.722456Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-06T19:28:27.676087Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8310} {"level":"info","ts":"2026-08-06T19:28:27.753623Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8310,"took":"75.280739ms","hash":2679829948,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":24072192,"current-db-size-in-use":"24 MB"} {"level":"info","ts":"2026-08-06T19:28:27.753681Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2679829948,"revision":8310,"compact-revision":6145} {"level":"info","ts":"2026-08-06T19:31:00.786004Z","caller":"traceutil/trace.go:171","msg":"trace[1992889773] linearizableReadLoop","detail":"{readStateIndex:12191; appliedIndex:12190; }","duration":"108.495619ms","start":"2026-08-06T19:31:00.677482Z","end":"2026-08-06T19:31:00.785978Z","steps":["trace[1992889773] 'read index received' (duration: 99.042305ms)","trace[1992889773] 'applied index is now lower than readState.Index' (duration: 9.451984ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:31:00.78603Z","caller":"traceutil/trace.go:171","msg":"trace[982974138] transaction","detail":"{read_only:false; response_revision:11793; number_of_response:1; }","duration":"126.840603ms","start":"2026-08-06T19:31:00.659158Z","end":"2026-08-06T19:31:00.785999Z","steps":["trace[982974138] 'process raft request' (duration: 117.360817ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:31:00.786333Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.784953ms","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-08-06T19:31:00.786391Z","caller":"traceutil/trace.go:171","msg":"trace[1616370535] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:11793; }","duration":"120.874307ms","start":"2026-08-06T19:31:00.6655Z","end":"2026-08-06T19:31:00.786374Z","steps":["trace[1616370535] 'agreement among raft nodes before linearized reading' (duration: 120.63542ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:31:00.786366Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.860756ms","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-08-06T19:31:00.786462Z","caller":"traceutil/trace.go:171","msg":"trace[1516945101] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:11793; }","duration":"131.00266ms","start":"2026-08-06T19:31:00.655435Z","end":"2026-08-06T19:31:00.786438Z","steps":["trace[1516945101] 'agreement among raft nodes before linearized reading' (duration: 130.713192ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:31:00.808811Z","caller":"traceutil/trace.go:171","msg":"trace[2102973195] transaction","detail":"{read_only:false; response_revision:11794; number_of_response:1; }","duration":"127.542143ms","start":"2026-08-06T19:31:00.681255Z","end":"2026-08-06T19:31:00.808797Z","steps":["trace[2102973195] 'process raft request' (duration: 127.46518ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:31:00.861752Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.598854ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/clusterroles/\" range_end:\"/registry/clusterroles0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-06T19:31:00.861826Z","caller":"traceutil/trace.go:171","msg":"trace[1607282627] range","detail":"{range_begin:/registry/clusterroles/; range_end:/registry/clusterroles0; response_count:0; response_revision:11797; }","duration":"173.710406ms","start":"2026-08-06T19:31:00.6881Z","end":"2026-08-06T19:31:00.861811Z","steps":["trace[1607282627] 'agreement among raft nodes before linearized reading' (duration: 173.47689ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:33:27.681161Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10531} {"level":"info","ts":"2026-08-06T19:33:27.756841Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10531,"took":"73.228222ms","hash":3687752686,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":26177536,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-06T19:33:27.757025Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3687752686,"revision":10531,"compact-revision":8310} {"level":"info","ts":"2026-08-06T19:37:45.94671Z","caller":"traceutil/trace.go:171","msg":"trace[22795894] transaction","detail":"{read_only:false; response_revision:14489; number_of_response:1; }","duration":"164.114847ms","start":"2026-08-06T19:37:45.782564Z","end":"2026-08-06T19:37:45.946678Z","steps":["trace[22795894] 'process raft request' (duration: 163.923032ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:37:46.130254Z","caller":"traceutil/trace.go:171","msg":"trace[1944741107] transaction","detail":"{read_only:false; response_revision:14490; number_of_response:1; }","duration":"214.108307ms","start":"2026-08-06T19:37:45.916085Z","end":"2026-08-06T19:37:46.130193Z","steps":["trace[1944741107] 'process raft request' (duration: 178.921652ms)","trace[1944741107] 'compare' (duration: 34.901347ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:37:46.133635Z","caller":"traceutil/trace.go:171","msg":"trace[1647640028] transaction","detail":"{read_only:false; response_revision:14491; number_of_response:1; }","duration":"145.774723ms","start":"2026-08-06T19:37:45.987811Z","end":"2026-08-06T19:37:46.133585Z","steps":["trace[1647640028] 'process raft request' (duration: 145.180536ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:38:08.165883Z","caller":"traceutil/trace.go:171","msg":"trace[2100363255] transaction","detail":"{read_only:false; response_revision:14795; number_of_response:1; }","duration":"346.32968ms","start":"2026-08-06T19:38:07.819509Z","end":"2026-08-06T19:38:08.165839Z","steps":["trace[2100363255] 'process raft request' (duration: 345.988631ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:38:08.165722Z","caller":"traceutil/trace.go:171","msg":"trace[1978168375] linearizableReadLoop","detail":"{readStateIndex:15301; appliedIndex:15300; }","duration":"224.894239ms","start":"2026-08-06T19:38:07.940793Z","end":"2026-08-06T19:38:08.165687Z","steps":["trace[1978168375] 'read index received' (duration: 224.672553ms)","trace[1978168375] 'applied index is now lower than readState.Index' (duration: 220.266µs)"],"step_count":2} {"level":"warn","ts":"2026-08-06T19:38:08.166108Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-06T19:38:07.819491Z","time spent":"346.505076ms","remote":"127.0.0.1:34342","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3742,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-06T19:38:08.166296Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.426874ms","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-08-06T19:38:08.166442Z","caller":"traceutil/trace.go:171","msg":"trace[1584461294] range","detail":"{range_begin:/registry/roles/; range_end:/registry/roles0; response_count:0; response_revision:14795; }","duration":"225.659441ms","start":"2026-08-06T19:38:07.940733Z","end":"2026-08-06T19:38:08.166392Z","steps":["trace[1584461294] 'agreement among raft nodes before linearized reading' (duration: 225.201258ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:38:27.694658Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12791} {"level":"info","ts":"2026-08-06T19:38:27.770616Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12791,"took":"73.145329ms","hash":3972210813,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":28758016,"current-db-size-in-use":"29 MB"} {"level":"info","ts":"2026-08-06T19:38:27.770682Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3972210813,"revision":12791,"compact-revision":10531} {"level":"info","ts":"2026-08-06T19:43:27.701043Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14928} {"level":"info","ts":"2026-08-06T19:43:27.788294Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14928,"took":"84.971689ms","hash":3194290205,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":30765056,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-06T19:43:27.788404Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3194290205,"revision":14928,"compact-revision":12791} {"level":"info","ts":"2026-08-06T19:45:33.552047Z","caller":"traceutil/trace.go:171","msg":"trace[1792931353] transaction","detail":"{read_only:false; response_revision:18250; number_of_response:1; }","duration":"224.035885ms","start":"2026-08-06T19:45:33.327989Z","end":"2026-08-06T19:45:33.552025Z","steps":["trace[1792931353] 'process raft request' (duration: 223.729137ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:45:33.562191Z","caller":"traceutil/trace.go:171","msg":"trace[544089372] linearizableReadLoop","detail":"{readStateIndex:18869; appliedIndex:18866; }","duration":"178.670885ms","start":"2026-08-06T19:45:33.383508Z","end":"2026-08-06T19:45:33.562179Z","steps":["trace[544089372] 'read index received' (duration: 168.14569ms)","trace[544089372] 'applied index is now lower than readState.Index' (duration: 10.524535ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:45:33.562355Z","caller":"traceutil/trace.go:171","msg":"trace[314570276] transaction","detail":"{read_only:false; response_revision:18251; number_of_response:1; }","duration":"234.20729ms","start":"2026-08-06T19:45:33.328139Z","end":"2026-08-06T19:45:33.562346Z","steps":["trace[314570276] 'process raft request' (duration: 233.965313ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:45:33.562455Z","caller":"traceutil/trace.go:171","msg":"trace[441505282] transaction","detail":"{read_only:false; response_revision:18252; number_of_response:1; }","duration":"234.22831ms","start":"2026-08-06T19:45:33.328219Z","end":"2026-08-06T19:45:33.562448Z","steps":["trace[441505282] 'process raft request' (duration: 233.939482ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:45:33.562548Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"179.026155ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T19:45:33.56257Z","caller":"traceutil/trace.go:171","msg":"trace[1603444072] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:18252; }","duration":"179.112997ms","start":"2026-08-06T19:45:33.383452Z","end":"2026-08-06T19:45:33.562565Z","steps":["trace[1603444072] 'agreement among raft nodes before linearized reading' (duration: 179.060695ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:47:29.533996Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"3cec112083e8d3ff","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-06T19:47:29.53948Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-06T19:47:29.539621Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-06T19:48:27.709253Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17402} {"level":"info","ts":"2026-08-06T19:48:27.809006Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17402,"took":"96.371721ms","hash":2534974408,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":34312192,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-06T19:48:27.809104Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2534974408,"revision":17402,"compact-revision":14928} {"level":"info","ts":"2026-08-06T19:51:54.613284Z","caller":"traceutil/trace.go:171","msg":"trace[1765256464] transaction","detail":"{read_only:false; response_revision:21121; number_of_response:1; }","duration":"120.562978ms","start":"2026-08-06T19:51:54.492694Z","end":"2026-08-06T19:51:54.613257Z","steps":["trace[1765256464] 'process raft request' (duration: 120.382253ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:51:54.936154Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.18735ms","expected-duration":"100ms","prefix":"read-only range ","request":"limit:1 serializable:true keys_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-06T19:51:54.936305Z","caller":"traceutil/trace.go:171","msg":"trace[1341154777] range","detail":"{range_begin:; range_end:; response_count:0; response_revision:21121; }","duration":"205.362234ms","start":"2026-08-06T19:51:54.730922Z","end":"2026-08-06T19:51:54.936284Z","steps":["trace[1341154777] 'range keys from in-memory index tree' (duration: 205.165889ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:51:55.159907Z","caller":"traceutil/trace.go:171","msg":"trace[56108195] transaction","detail":"{read_only:false; response_revision:21122; number_of_response:1; }","duration":"139.156789ms","start":"2026-08-06T19:51:55.020717Z","end":"2026-08-06T19:51:55.159874Z","steps":["trace[56108195] 'process raft request' (duration: 138.933833ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:51:55.463133Z","caller":"traceutil/trace.go:171","msg":"trace[686747212] transaction","detail":"{read_only:false; response_revision:21123; number_of_response:1; }","duration":"299.489192ms","start":"2026-08-06T19:51:55.163607Z","end":"2026-08-06T19:51:55.463096Z","steps":["trace[686747212] 'process raft request' (duration: 299.227955ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:53:27.71597Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19716} {"level":"info","ts":"2026-08-06T19:53:27.825281Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19716,"took":"105.225609ms","hash":3598696810,"current-db-size-bytes":59326464,"current-db-size":"59 MB","current-db-size-in-use-bytes":29962240,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-06T19:53:27.825352Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3598696810,"revision":19716,"compact-revision":17402} {"level":"info","ts":"2026-08-06T19:55:08.523624Z","caller":"traceutil/trace.go:171","msg":"trace[1246782107] linearizableReadLoop","detail":"{readStateIndex:23501; appliedIndex:23500; }","duration":"166.006412ms","start":"2026-08-06T19:55:08.357593Z","end":"2026-08-06T19:55:08.5236Z","steps":["trace[1246782107] 'read index received' (duration: 165.772176ms)","trace[1246782107] 'applied index is now lower than readState.Index' (duration: 233.666µs)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:55:08.523742Z","caller":"traceutil/trace.go:171","msg":"trace[1760690637] transaction","detail":"{read_only:false; response_revision:22731; number_of_response:1; }","duration":"173.827061ms","start":"2026-08-06T19:55:08.349906Z","end":"2026-08-06T19:55:08.523733Z","steps":["trace[1760690637] 'process raft request' (duration: 173.520562ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:55:08.523983Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"166.377572ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rabbitmq-magnum-server-0\" ","response":"range_response_count:1 size:10359"} {"level":"info","ts":"2026-08-06T19:55:08.524016Z","caller":"traceutil/trace.go:171","msg":"trace[2139902979] range","detail":"{range_begin:/registry/pods/openstack/rabbitmq-magnum-server-0; range_end:; response_count:1; response_revision:22731; }","duration":"166.465984ms","start":"2026-08-06T19:55:08.357541Z","end":"2026-08-06T19:55:08.524007Z","steps":["trace[2139902979] 'agreement among raft nodes before linearized reading' (duration: 166.32259ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:55:08.524416Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.345689ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:508"} {"level":"info","ts":"2026-08-06T19:55:08.524502Z","caller":"traceutil/trace.go:171","msg":"trace[248883742] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22731; }","duration":"132.438462ms","start":"2026-08-06T19:55:08.392042Z","end":"2026-08-06T19:55:08.52448Z","steps":["trace[248883742] 'agreement among raft nodes before linearized reading' (duration: 132.190075ms)"],"step_count":1} {"level":"warn","ts":"2026-08-06T19:55:08.524727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"102.909903ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:495"} {"level":"info","ts":"2026-08-06T19:55:08.524774Z","caller":"traceutil/trace.go:171","msg":"trace[1435199176] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22731; }","duration":"102.955045ms","start":"2026-08-06T19:55:08.421806Z","end":"2026-08-06T19:55:08.524761Z","steps":["trace[1435199176] 'agreement among raft nodes before linearized reading' (duration: 102.860112ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:55:56.758065Z","caller":"traceutil/trace.go:171","msg":"trace[2142395577] transaction","detail":"{read_only:false; response_revision:23639; number_of_response:1; }","duration":"259.124932ms","start":"2026-08-06T19:55:56.498915Z","end":"2026-08-06T19:55:56.758039Z","steps":["trace[2142395577] 'process raft request' (duration: 223.692089ms)","trace[2142395577] 'compare' (duration: 35.294419ms)"],"step_count":2} {"level":"info","ts":"2026-08-06T19:55:56.75868Z","caller":"traceutil/trace.go:171","msg":"trace[1958607082] transaction","detail":"{read_only:false; response_revision:23640; number_of_response:1; }","duration":"243.536744ms","start":"2026-08-06T19:55:56.515096Z","end":"2026-08-06T19:55:56.758632Z","steps":["trace[1958607082] 'process raft request' (duration: 243.240936ms)"],"step_count":1} {"level":"info","ts":"2026-08-06T19:58:27.725599Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21924} {"level":"info","ts":"2026-08-06T19:58:27.829718Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21924,"took":"100.298261ms","hash":2782936988,"current-db-size-bytes":60186624,"current-db-size":"60 MB","current-db-size-in-use-bytes":43995136,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-08-06T19:58:27.829795Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2782936988,"revision":21924,"compact-revision":19716} {"level":"info","ts":"2026-08-06T20:02:16.665332Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006c3e.wal"} {"level":"info","ts":"2026-08-06T20:03:27.733643Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25054} {"level":"info","ts":"2026-08-06T20:03:27.879393Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25054,"took":"140.722814ms","hash":3435487231,"current-db-size-bytes":60186624,"current-db-size":"60 MB","current-db-size-in-use-bytes":30609408,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-06T20:03:27.879462Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3435487231,"revision":25054,"compact-revision":21924}