{"level":"warn","ts":"2026-04-03T01:37:26.193375Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-03T01:37:26.193456Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.204.45.3: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.3:2380","--initial-cluster=instance=https://199.204.45.3:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.204.45.3:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.204.45.3:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-04-03T01:37:26.193521Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-04-03T01:37:26.19353Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-04-03T01:37:26.193547Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-03T01:37:26.19414Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"]} {"level":"info","ts":"2026-04-03T01:37:26.19421Z","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.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.204.45.3:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-04-03T01:37:26.197375Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.948009ms"} {"level":"info","ts":"2026-04-03T01:37:26.203156Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"597401b06ce1cf3d","cluster-id":"dfc54657ad8a2432"} {"level":"info","ts":"2026-04-03T01:37:26.203253Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=()"} {"level":"info","ts":"2026-04-03T01:37:26.203285Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 0"} {"level":"info","ts":"2026-04-03T01:37:26.203304Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 597401b06ce1cf3d [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-04-03T01:37:26.203324Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became follower at term 1"} {"level":"info","ts":"2026-04-03T01:37:26.203378Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"warn","ts":"2026-04-03T01:37:26.208961Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-04-03T01:37:26.210943Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-04-03T01:37:26.212382Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-04-03T01:37:26.217979Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"597401b06ce1cf3d","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-04-03T01:37:26.218295Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"597401b06ce1cf3d","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-04-03T01:37:26.218535Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T01:37:26.218648Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T01:37:26.21866Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-04-03T01:37:26.219832Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d switched to configuration voters=(6445778823926632253)"} {"level":"info","ts":"2026-04-03T01:37:26.219984Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","added-peer-id":"597401b06ce1cf3d","added-peer-peer-urls":["https://199.204.45.3:2380"]} {"level":"info","ts":"2026-04-03T01:37:26.221889Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-04-03T01:37:26.222118Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"597401b06ce1cf3d","initial-advertise-peer-urls":["https://199.204.45.3:2380"],"listen-peer-urls":["https://199.204.45.3:2380"],"advertise-client-urls":["https://199.204.45.3:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.204.45.3:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-04-03T01:37:26.222163Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-04-03T01:37:26.222118Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-04-03T01:37:26.22233Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.204.45.3:2380"} {"level":"info","ts":"2026-04-03T01:37:26.704125Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d is starting a new election at term 1"} {"level":"info","ts":"2026-04-03T01:37:26.704198Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became pre-candidate at term 1"} {"level":"info","ts":"2026-04-03T01:37:26.704245Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgPreVoteResp from 597401b06ce1cf3d at term 1"} {"level":"info","ts":"2026-04-03T01:37:26.704266Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became candidate at term 2"} {"level":"info","ts":"2026-04-03T01:37:26.704278Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d received MsgVoteResp from 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-04-03T01:37:26.704295Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"597401b06ce1cf3d became leader at term 2"} {"level":"info","ts":"2026-04-03T01:37:26.704309Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 597401b06ce1cf3d elected leader 597401b06ce1cf3d at term 2"} {"level":"info","ts":"2026-04-03T01:37:26.773144Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"597401b06ce1cf3d","local-member-attributes":"{Name:instance ClientURLs:[https://199.204.45.3:2379]}","request-path":"/0/members/597401b06ce1cf3d/attributes","cluster-id":"dfc54657ad8a2432","publish-timeout":"7s"} {"level":"info","ts":"2026-04-03T01:37:26.773348Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T01:37:26.773536Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-04-03T01:37:26.773845Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:37:26.774161Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-04-03T01:37:26.774219Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-04-03T01:37:26.776303Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-04-03T01:37:26.777105Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.204.45.3:2379"} {"level":"info","ts":"2026-04-03T01:37:26.786638Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"dfc54657ad8a2432","local-member-id":"597401b06ce1cf3d","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:37:26.786767Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:37:26.786846Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-04-03T01:37:38.337496Z","caller":"traceutil/trace.go:171","msg":"trace[257685825] transaction","detail":"{read_only:false; response_revision:353; number_of_response:1; }","duration":"122.573895ms","start":"2026-04-03T01:37:38.2149Z","end":"2026-04-03T01:37:38.337474Z","steps":["trace[257685825] 'process raft request' (duration: 122.465873ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:37:57.02241Z","caller":"traceutil/trace.go:171","msg":"trace[815986293] transaction","detail":"{read_only:false; response_revision:509; number_of_response:1; }","duration":"120.017254ms","start":"2026-04-03T01:37:56.90235Z","end":"2026-04-03T01:37:57.022368Z","steps":["trace[815986293] 'process raft request' (duration: 114.869661ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:37:57.024097Z","caller":"traceutil/trace.go:171","msg":"trace[1889922134] transaction","detail":"{read_only:false; response_revision:510; number_of_response:1; }","duration":"107.425982ms","start":"2026-04-03T01:37:56.916636Z","end":"2026-04-03T01:37:57.024062Z","steps":["trace[1889922134] 'process raft request' (duration: 107.064805ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:38:02.94029Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.960373ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T01:38:02.940569Z","caller":"traceutil/trace.go:171","msg":"trace[165689080] transaction","detail":"{read_only:false; response_revision:571; number_of_response:1; }","duration":"224.398455ms","start":"2026-04-03T01:38:02.716124Z","end":"2026-04-03T01:38:02.940522Z","steps":["trace[165689080] 'process raft request' (duration: 121.527274ms)","trace[165689080] 'compare' (duration: 101.648296ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:38:03.505369Z","caller":"traceutil/trace.go:171","msg":"trace[957075836] transaction","detail":"{read_only:false; response_revision:578; number_of_response:1; }","duration":"111.256999ms","start":"2026-04-03T01:38:03.394082Z","end":"2026-04-03T01:38:03.505339Z","steps":["trace[957075836] 'process raft request' (duration: 110.633535ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:38:03.977238Z","caller":"traceutil/trace.go:171","msg":"trace[1724597515] transaction","detail":"{read_only:false; response_revision:579; number_of_response:1; }","duration":"413.893312ms","start":"2026-04-03T01:38:03.563314Z","end":"2026-04-03T01:38:03.977207Z","steps":["trace[1724597515] 'process raft request' (duration: 413.767709ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:38:03.977381Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:38:03.563283Z","time spent":"414.034044ms","remote":"127.0.0.1:36384","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":2603,"response count":0,"response size":39,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-04-03T01:38:49.866677Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"275.437198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T01:38:49.86682Z","caller":"traceutil/trace.go:171","msg":"trace[1080873455] linearizableReadLoop","detail":"{readStateIndex:1177; appliedIndex:1176; }","duration":"181.008409ms","start":"2026-04-03T01:38:49.685789Z","end":"2026-04-03T01:38:49.866798Z","steps":["trace[1080873455] 'read index received' (duration: 63.881µs)","trace[1080873455] 'applied index is now lower than readState.Index' (duration: 180.943048ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:38:49.866921Z","caller":"traceutil/trace.go:171","msg":"trace[951657540] transaction","detail":"{read_only:false; response_revision:1143; number_of_response:1; }","duration":"304.080485ms","start":"2026-04-03T01:38:49.562759Z","end":"2026-04-03T01:38:49.866839Z","steps":["trace[951657540] 'process raft request' (duration: 28.377361ms)","trace[951657540] 'compare' (duration: 275.299776ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:38:49.866977Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"181.172433ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:38:49.867204Z","caller":"traceutil/trace.go:171","msg":"trace[38263912] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1143; }","duration":"181.458019ms","start":"2026-04-03T01:38:49.685713Z","end":"2026-04-03T01:38:49.867171Z","steps":["trace[38263912] 'agreement among raft nodes before linearized reading' (duration: 181.154003ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:38:49.867259Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:38:49.562732Z","time spent":"304.35755ms","remote":"127.0.0.1:36396","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-04-03T01:39:09.535678Z","caller":"traceutil/trace.go:171","msg":"trace[1541206342] transaction","detail":"{read_only:false; response_revision:1393; number_of_response:1; }","duration":"101.876348ms","start":"2026-04-03T01:39:09.433786Z","end":"2026-04-03T01:39:09.535662Z","steps":["trace[1541206342] 'process raft request' (duration: 101.786536ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:39:33.91036Z","caller":"traceutil/trace.go:171","msg":"trace[1872080599] transaction","detail":"{read_only:false; response_revision:1795; number_of_response:1; }","duration":"368.691439ms","start":"2026-04-03T01:39:33.541619Z","end":"2026-04-03T01:39:33.910311Z","steps":["trace[1872080599] 'process raft request' (duration: 368.460675ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:39:33.91043Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"296.162177ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/tcproutes/\" range_end:\"/registry/gateway.networking.k8s.io/tcproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:39:33.91051Z","caller":"traceutil/trace.go:171","msg":"trace[1973735018] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/tcproutes/; range_end:/registry/gateway.networking.k8s.io/tcproutes0; response_count:0; response_revision:1799; }","duration":"296.28388ms","start":"2026-04-03T01:39:33.614213Z","end":"2026-04-03T01:39:33.910497Z","steps":["trace[1973735018] 'agreement among raft nodes before linearized reading' (duration: 296.152637ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:39:33.910575Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:39:33.541598Z","time spent":"368.867752ms","remote":"127.0.0.1:36300","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-04-03T01:39:33.910573Z","caller":"traceutil/trace.go:171","msg":"trace[1935912823] transaction","detail":"{read_only:false; response_revision:1798; number_of_response:1; }","duration":"367.910293ms","start":"2026-04-03T01:39:33.542512Z","end":"2026-04-03T01:39:33.910422Z","steps":["trace[1935912823] 'process raft request' (duration: 367.76024ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:39:33.910701Z","caller":"traceutil/trace.go:171","msg":"trace[1572147612] transaction","detail":"{read_only:false; response_revision:1799; number_of_response:1; }","duration":"364.22465ms","start":"2026-04-03T01:39:33.546466Z","end":"2026-04-03T01:39:33.910691Z","steps":["trace[1572147612] 'process raft request' (duration: 363.837222ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:39:33.91036Z","caller":"traceutil/trace.go:171","msg":"trace[1434689646] linearizableReadLoop","detail":"{readStateIndex:1870; appliedIndex:1865; }","duration":"296.093936ms","start":"2026-04-03T01:39:33.614253Z","end":"2026-04-03T01:39:33.910347Z","steps":["trace[1434689646] 'read index received' (duration: 295.891652ms)","trace[1434689646] 'applied index is now lower than readState.Index' (duration: 201.274µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:39:33.910365Z","caller":"traceutil/trace.go:171","msg":"trace[1169947284] transaction","detail":"{read_only:false; response_revision:1796; number_of_response:1; }","duration":"368.313182ms","start":"2026-04-03T01:39:33.542018Z","end":"2026-04-03T01:39:33.910331Z","steps":["trace[1169947284] 'process raft request' (duration: 368.192069ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:39:33.910804Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:39:33.546451Z","time spent":"364.289792ms","remote":"127.0.0.1:36318","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3730,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:39:33.910702Z","caller":"traceutil/trace.go:171","msg":"trace[915112713] transaction","detail":"{read_only:false; response_revision:1797; number_of_response:1; }","duration":"368.457305ms","start":"2026-04-03T01:39:33.542233Z","end":"2026-04-03T01:39:33.91069Z","steps":["trace[915112713] 'process raft request' (duration: 368.012446ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:39:33.910845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:39:33.542002Z","time spent":"368.807661ms","remote":"127.0.0.1:36412","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1472,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:39:33.91091Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:39:33.542502Z","time spent":"368.210309ms","remote":"127.0.0.1:36412","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-04-03T01:39:33.911843Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:39:33.542205Z","time spent":"368.677339ms","remote":"127.0.0.1:36300","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-04-03T01:39:33.971252Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"191.091065ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-c0629b5f-3208-462d-9d92-f73263df5dc3\" ","response":"range_response_count:1 size:3745"} {"level":"info","ts":"2026-04-03T01:39:33.971319Z","caller":"traceutil/trace.go:171","msg":"trace[1422309920] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-c0629b5f-3208-462d-9d92-f73263df5dc3; range_end:; response_count:1; response_revision:1800; }","duration":"191.193506ms","start":"2026-04-03T01:39:33.780108Z","end":"2026-04-03T01:39:33.971301Z","steps":["trace[1422309920] 'agreement among raft nodes before linearized reading' (duration: 191.069934ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:39:33.971356Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"286.126407ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:39:33.971425Z","caller":"traceutil/trace.go:171","msg":"trace[949643228] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:1800; }","duration":"286.236339ms","start":"2026-04-03T01:39:33.68517Z","end":"2026-04-03T01:39:33.971407Z","steps":["trace[949643228] 'agreement among raft nodes before linearized reading' (duration: 286.133947ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:39:33.97135Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"268.535725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:491"} {"level":"warn","ts":"2026-04-03T01:39:33.971475Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"127.724736ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-03T01:39:33.971483Z","caller":"traceutil/trace.go:171","msg":"trace[61095642] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1800; }","duration":"268.716009ms","start":"2026-04-03T01:39:33.70275Z","end":"2026-04-03T01:39:33.971466Z","steps":["trace[61095642] 'agreement among raft nodes before linearized reading' (duration: 268.424173ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:39:33.971544Z","caller":"traceutil/trace.go:171","msg":"trace[1990797553] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1800; }","duration":"127.795068ms","start":"2026-04-03T01:39:33.843723Z","end":"2026-04-03T01:39:33.971518Z","steps":["trace[1990797553] 'agreement among raft nodes before linearized reading' (duration: 127.689696ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:39:34.366992Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"153.378659ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:555"} {"level":"info","ts":"2026-04-03T01:39:34.367083Z","caller":"traceutil/trace.go:171","msg":"trace[625359850] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:1803; }","duration":"153.528701ms","start":"2026-04-03T01:39:34.213535Z","end":"2026-04-03T01:39:34.367064Z","steps":["trace[625359850] 'range keys from in-memory index tree' (duration: 153.096694ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:40:18.638038Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"177.365346ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T01:40:18.63828Z","caller":"traceutil/trace.go:171","msg":"trace[678823004] transaction","detail":"{read_only:false; response_revision:2092; number_of_response:1; }","duration":"283.670636ms","start":"2026-04-03T01:40:18.35459Z","end":"2026-04-03T01:40:18.63826Z","steps":["trace[678823004] 'process raft request' (duration: 283.584714ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:40:18.638304Z","caller":"traceutil/trace.go:171","msg":"trace[375609611] transaction","detail":"{read_only:false; response_revision:2091; number_of_response:1; }","duration":"358.033006ms","start":"2026-04-03T01:40:18.28025Z","end":"2026-04-03T01:40:18.638283Z","steps":["trace[375609611] 'process raft request' (duration: 180.337054ms)","trace[375609611] 'compare' (duration: 177.095481ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:40:18.638389Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:40:18.280237Z","time spent":"358.108918ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:45:39.081513Z","caller":"traceutil/trace.go:171","msg":"trace[400996930] transaction","detail":"{read_only:false; response_revision:4730; number_of_response:1; }","duration":"135.953126ms","start":"2026-04-03T01:45:38.945523Z","end":"2026-04-03T01:45:39.081476Z","steps":["trace[400996930] 'process raft request' (duration: 135.772942ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:44.349118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.508166ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-04-03T01:45:44.349211Z","caller":"traceutil/trace.go:171","msg":"trace[1940962737] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:4932; }","duration":"131.671419ms","start":"2026-04-03T01:45:44.217517Z","end":"2026-04-03T01:45:44.349188Z","steps":["trace[1940962737] 'range keys from in-memory index tree' (duration: 131.300163ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:44.349238Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"131.793642ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumidentities/\" range_end:\"/registry/cilium.io/ciliumidentities0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"warn","ts":"2026-04-03T01:45:44.349346Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"101.083849ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-03T01:45:44.349393Z","caller":"traceutil/trace.go:171","msg":"trace[576922060] range","detail":"{range_begin:/registry/cilium.io/ciliumidentities/; range_end:/registry/cilium.io/ciliumidentities0; response_count:0; response_revision:4932; }","duration":"132.032417ms","start":"2026-04-03T01:45:44.217306Z","end":"2026-04-03T01:45:44.349339Z","steps":["trace[576922060] 'count revisions from in-memory index tree' (duration: 131.6786ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:45:44.349451Z","caller":"traceutil/trace.go:171","msg":"trace[90969552] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4932; }","duration":"101.224533ms","start":"2026-04-03T01:45:44.248205Z","end":"2026-04-03T01:45:44.349429Z","steps":["trace[90969552] 'range keys from in-memory index tree' (duration: 100.764842ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:45:44.472512Z","caller":"traceutil/trace.go:171","msg":"trace[1528576508] linearizableReadLoop","detail":"{readStateIndex:5121; appliedIndex:5120; }","duration":"119.830132ms","start":"2026-04-03T01:45:44.352658Z","end":"2026-04-03T01:45:44.472488Z","steps":["trace[1528576508] 'read index received' (duration: 119.72382ms)","trace[1528576508] 'applied index is now lower than readState.Index' (duration: 105.072µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:45:44.472562Z","caller":"traceutil/trace.go:171","msg":"trace[1335457882] transaction","detail":"{read_only:false; response_revision:4933; number_of_response:1; }","duration":"119.933445ms","start":"2026-04-03T01:45:44.352601Z","end":"2026-04-03T01:45:44.472535Z","steps":["trace[1335457882] 'process raft request' (duration: 119.709571ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:44.472799Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.088398ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/minions/instance\" ","response":"range_response_count:1 size:16450"} {"level":"info","ts":"2026-04-03T01:45:44.472872Z","caller":"traceutil/trace.go:171","msg":"trace[166348065] range","detail":"{range_begin:/registry/minions/instance; range_end:; response_count:1; response_revision:4933; }","duration":"120.190501ms","start":"2026-04-03T01:45:44.352642Z","end":"2026-04-03T01:45:44.472832Z","steps":["trace[166348065] 'agreement among raft nodes before linearized reading' (duration: 119.976396ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:45:44.50902Z","caller":"traceutil/trace.go:171","msg":"trace[1003008351] transaction","detail":"{read_only:false; response_revision:4935; number_of_response:1; }","duration":"131.978796ms","start":"2026-04-03T01:45:44.377007Z","end":"2026-04-03T01:45:44.508985Z","steps":["trace[1003008351] 'process raft request' (duration: 131.806613ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:44.509071Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.912553ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-69be0945-95e4-4ec3-818e-4f1ce8025a21\" ","response":"range_response_count:1 size:3599"} {"level":"info","ts":"2026-04-03T01:45:44.509171Z","caller":"traceutil/trace.go:171","msg":"trace[2031878621] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-69be0945-95e4-4ec3-818e-4f1ce8025a21; range_end:; response_count:1; response_revision:4935; }","duration":"153.043527ms","start":"2026-04-03T01:45:44.3561Z","end":"2026-04-03T01:45:44.509143Z","steps":["trace[2031878621] 'agreement among raft nodes before linearized reading' (duration: 152.789531ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:45:44.509345Z","caller":"traceutil/trace.go:171","msg":"trace[667420141] transaction","detail":"{read_only:false; response_revision:4934; number_of_response:1; }","duration":"156.611269ms","start":"2026-04-03T01:45:44.352701Z","end":"2026-04-03T01:45:44.509312Z","steps":["trace[667420141] 'process raft request' (duration: 155.948145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:44.509452Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"122.995057ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliumloadbalancerippools/\" range_end:\"/registry/cilium.io/ciliumloadbalancerippools0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:45:44.509497Z","caller":"traceutil/trace.go:171","msg":"trace[1192819494] range","detail":"{range_begin:/registry/cilium.io/ciliumloadbalancerippools/; range_end:/registry/cilium.io/ciliumloadbalancerippools0; response_count:0; response_revision:4935; }","duration":"123.091399ms","start":"2026-04-03T01:45:44.386395Z","end":"2026-04-03T01:45:44.509486Z","steps":["trace[1192819494] 'agreement among raft nodes before linearized reading' (duration: 123.014268ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:44.509717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.760331ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mdmgk.18a2b57a9a41fd65\" ","response":"range_response_count:1 size:962"} {"level":"info","ts":"2026-04-03T01:45:44.509754Z","caller":"traceutil/trace.go:171","msg":"trace[1040964012] range","detail":"{range_begin:/registry/events/monitoring/kube-prometheus-stack-prometheus-node-exporter-mdmgk.18a2b57a9a41fd65; range_end:; response_count:1; response_revision:4935; }","duration":"152.815102ms","start":"2026-04-03T01:45:44.35693Z","end":"2026-04-03T01:45:44.509745Z","steps":["trace[1040964012] 'agreement among raft nodes before linearized reading' (duration: 152.71242ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:46.898837Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"215.807072ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-04-03T01:45:46.899016Z","caller":"traceutil/trace.go:171","msg":"trace[208808889] linearizableReadLoop","detail":"{readStateIndex:5167; appliedIndex:5165; }","duration":"216.300682ms","start":"2026-04-03T01:45:46.6827Z","end":"2026-04-03T01:45:46.899001Z","steps":["trace[208808889] 'read index received' (duration: 262.167µs)","trace[208808889] 'applied index is now lower than readState.Index' (duration: 216.037655ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:45:46.899109Z","caller":"traceutil/trace.go:171","msg":"trace[1856720237] transaction","detail":"{read_only:false; response_revision:4976; number_of_response:1; }","duration":"304.646655ms","start":"2026-04-03T01:45:46.594451Z","end":"2026-04-03T01:45:46.899098Z","steps":["trace[1856720237] 'process raft request' (duration: 88.497647ms)","trace[1856720237] 'compare' (duration: 215.495595ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:45:46.899164Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:45:46.594432Z","time spent":"304.700876ms","remote":"127.0.0.1:36396","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-04-03T01:45:46.899424Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"216.713929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:45:46.899492Z","caller":"traceutil/trace.go:171","msg":"trace[2022341015] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4977; }","duration":"216.820241ms","start":"2026-04-03T01:45:46.682657Z","end":"2026-04-03T01:45:46.899477Z","steps":["trace[2022341015] 'agreement among raft nodes before linearized reading' (duration: 216.666728ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:45:46.899537Z","caller":"traceutil/trace.go:171","msg":"trace[492867554] transaction","detail":"{read_only:false; response_revision:4977; number_of_response:1; }","duration":"304.495832ms","start":"2026-04-03T01:45:46.595Z","end":"2026-04-03T01:45:46.899495Z","steps":["trace[492867554] 'process raft request' (duration: 303.945131ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:46.899673Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.218089ms","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-04-03T01:45:46.899716Z","caller":"traceutil/trace.go:171","msg":"trace[41081163] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4977; }","duration":"149.308311ms","start":"2026-04-03T01:45:46.750397Z","end":"2026-04-03T01:45:46.899705Z","steps":["trace[41081163] 'agreement among raft nodes before linearized reading' (duration: 148.940234ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:45:46.900116Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:45:46.594984Z","time spent":"304.668455ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":423,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-04-03T01:46:04.705767Z","caller":"traceutil/trace.go:171","msg":"trace[954066743] transaction","detail":"{read_only:false; response_revision:5342; number_of_response:1; }","duration":"113.082379ms","start":"2026-04-03T01:46:04.592659Z","end":"2026-04-03T01:46:04.705742Z","steps":["trace[954066743] 'process raft request' (duration: 112.714312ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:46:05.823884Z","caller":"traceutil/trace.go:171","msg":"trace[577456799] transaction","detail":"{read_only:false; response_revision:5349; number_of_response:1; }","duration":"117.272332ms","start":"2026-04-03T01:46:05.706578Z","end":"2026-04-03T01:46:05.82385Z","steps":["trace[577456799] 'process raft request' (duration: 117.053348ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:46:14.468707Z","caller":"traceutil/trace.go:171","msg":"trace[1172689938] linearizableReadLoop","detail":"{readStateIndex:5693; appliedIndex:5692; }","duration":"148.955775ms","start":"2026-04-03T01:46:14.319724Z","end":"2026-04-03T01:46:14.468679Z","steps":["trace[1172689938] 'read index received' (duration: 148.784551ms)","trace[1172689938] 'applied index is now lower than readState.Index' (duration: 169.734µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:46:14.468785Z","caller":"traceutil/trace.go:171","msg":"trace[590731777] transaction","detail":"{read_only:false; response_revision:5490; number_of_response:1; }","duration":"157.144729ms","start":"2026-04-03T01:46:14.311585Z","end":"2026-04-03T01:46:14.46873Z","steps":["trace[590731777] 'process raft request' (duration: 156.923294ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:46:14.469118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"149.343293ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-03T01:46:14.469255Z","caller":"traceutil/trace.go:171","msg":"trace[484267552] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5490; }","duration":"149.548516ms","start":"2026-04-03T01:46:14.319677Z","end":"2026-04-03T01:46:14.469225Z","steps":["trace[484267552] 'agreement among raft nodes before linearized reading' (duration: 149.122898ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:46:14.97485Z","caller":"traceutil/trace.go:171","msg":"trace[8316092] linearizableReadLoop","detail":"{readStateIndex:5705; appliedIndex:5704; }","duration":"127.68451ms","start":"2026-04-03T01:46:14.847141Z","end":"2026-04-03T01:46:14.974825Z","steps":["trace[8316092] 'read index received' (duration: 127.521697ms)","trace[8316092] 'applied index is now lower than readState.Index' (duration: 161.703µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:46:14.974918Z","caller":"traceutil/trace.go:171","msg":"trace[209297602] transaction","detail":"{read_only:false; response_revision:5502; number_of_response:1; }","duration":"181.009335ms","start":"2026-04-03T01:46:14.793867Z","end":"2026-04-03T01:46:14.974877Z","steps":["trace[209297602] 'process raft request' (duration: 180.776421ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:46:14.975212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"190.79384ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-03T01:46:14.975264Z","caller":"traceutil/trace.go:171","msg":"trace[1954530200] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5502; }","duration":"190.881423ms","start":"2026-04-03T01:46:14.784368Z","end":"2026-04-03T01:46:14.975249Z","steps":["trace[1954530200] 'agreement among raft nodes before linearized reading' (duration: 190.560977ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:47:26.797438Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2982} {"level":"info","ts":"2026-04-03T01:47:26.866831Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2982,"took":"67.891595ms","hash":2589643708,"current-db-size-bytes":58310656,"current-db-size":"58 MB","current-db-size-in-use-bytes":33804288,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-04-03T01:47:26.866891Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2589643708,"revision":2982,"compact-revision":-1} {"level":"info","ts":"2026-04-03T01:51:54.130955Z","caller":"traceutil/trace.go:171","msg":"trace[449916109] transaction","detail":"{read_only:false; response_revision:8089; number_of_response:1; }","duration":"292.882273ms","start":"2026-04-03T01:51:53.838043Z","end":"2026-04-03T01:51:54.130925Z","steps":["trace[449916109] 'process raft request' (duration: 292.631139ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:05.371043Z","caller":"traceutil/trace.go:171","msg":"trace[1689039813] transaction","detail":"{read_only:false; response_revision:8146; number_of_response:1; }","duration":"107.828834ms","start":"2026-04-03T01:52:05.263187Z","end":"2026-04-03T01:52:05.371016Z","steps":["trace[1689039813] 'process raft request' (duration: 107.771053ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:05.371432Z","caller":"traceutil/trace.go:171","msg":"trace[194051375] transaction","detail":"{read_only:false; response_revision:8145; number_of_response:1; }","duration":"114.61569ms","start":"2026-04-03T01:52:05.256805Z","end":"2026-04-03T01:52:05.37142Z","steps":["trace[194051375] 'process raft request' (duration: 114.008808ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:05.67411Z","caller":"traceutil/trace.go:171","msg":"trace[1468125996] transaction","detail":"{read_only:false; response_revision:8147; number_of_response:1; }","duration":"178.088379ms","start":"2026-04-03T01:52:05.495989Z","end":"2026-04-03T01:52:05.674078Z","steps":["trace[1468125996] 'process raft request' (duration: 177.880854ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:05.818242Z","caller":"traceutil/trace.go:171","msg":"trace[1031120837] linearizableReadLoop","detail":"{readStateIndex:8435; appliedIndex:8434; }","duration":"132.359595ms","start":"2026-04-03T01:52:05.685863Z","end":"2026-04-03T01:52:05.818223Z","steps":["trace[1031120837] 'read index received' (duration: 124.577639ms)","trace[1031120837] 'applied index is now lower than readState.Index' (duration: 7.781176ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:52:05.818413Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.519488ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-04-03T01:52:05.818452Z","caller":"traceutil/trace.go:171","msg":"trace[1740483413] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:8148; }","duration":"132.61325ms","start":"2026-04-03T01:52:05.685828Z","end":"2026-04-03T01:52:05.818441Z","steps":["trace[1740483413] 'agreement among raft nodes before linearized reading' (duration: 132.481467ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:05.818604Z","caller":"traceutil/trace.go:171","msg":"trace[2069278923] transaction","detail":"{read_only:false; response_revision:8148; number_of_response:1; }","duration":"133.669612ms","start":"2026-04-03T01:52:05.684908Z","end":"2026-04-03T01:52:05.818578Z","steps":["trace[2069278923] 'process raft request' (duration: 125.59899ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:06.663969Z","caller":"traceutil/trace.go:171","msg":"trace[1269607236] linearizableReadLoop","detail":"{readStateIndex:8438; appliedIndex:8437; }","duration":"108.713752ms","start":"2026-04-03T01:52:06.555229Z","end":"2026-04-03T01:52:06.663943Z","steps":["trace[1269607236] 'read index received' (duration: 108.5876ms)","trace[1269607236] 'applied index is now lower than readState.Index' (duration: 125.072µs)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:52:06.664059Z","caller":"traceutil/trace.go:171","msg":"trace[1816925337] transaction","detail":"{read_only:false; response_revision:8151; number_of_response:1; }","duration":"293.805031ms","start":"2026-04-03T01:52:06.370208Z","end":"2026-04-03T01:52:06.664013Z","steps":["trace[1816925337] 'process raft request' (duration: 293.547506ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:06.664241Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"108.987857ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/percona-xtradb-pxc-0\" ","response":"range_response_count:1 size:12214"} {"level":"info","ts":"2026-04-03T01:52:06.664321Z","caller":"traceutil/trace.go:171","msg":"trace[1805887325] range","detail":"{range_begin:/registry/pods/openstack/percona-xtradb-pxc-0; range_end:; response_count:1; response_revision:8151; }","duration":"109.12347ms","start":"2026-04-03T01:52:06.555179Z","end":"2026-04-03T01:52:06.664302Z","steps":["trace[1805887325] 'agreement among raft nodes before linearized reading' (duration: 108.854495ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:26.803485Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6096} {"level":"info","ts":"2026-04-03T01:52:26.895547Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6096,"took":"90.052389ms","hash":2244989588,"current-db-size-bytes":58310656,"current-db-size":"58 MB","current-db-size-in-use-bytes":22949888,"current-db-size-in-use":"23 MB"} {"level":"info","ts":"2026-04-03T01:52:26.895643Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2244989588,"revision":6096,"compact-revision":2982} {"level":"info","ts":"2026-04-03T01:52:33.483002Z","caller":"traceutil/trace.go:171","msg":"trace[221086812] linearizableReadLoop","detail":"{readStateIndex:8644; appliedIndex:8643; }","duration":"406.634553ms","start":"2026-04-03T01:52:33.076342Z","end":"2026-04-03T01:52:33.482977Z","steps":["trace[221086812] 'read index received' (duration: 309.131786ms)","trace[221086812] 'applied index is now lower than readState.Index' (duration: 97.501247ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:52:33.48306Z","caller":"traceutil/trace.go:171","msg":"trace[595385394] transaction","detail":"{read_only:false; response_revision:8349; number_of_response:1; }","duration":"474.857116ms","start":"2026-04-03T01:52:33.008169Z","end":"2026-04-03T01:52:33.483026Z","steps":["trace[595385394] 'process raft request' (duration: 377.377589ms)","trace[595385394] 'compare' (duration: 97.097149ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:52:33.483231Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:52:33.008143Z","time spent":"475.008019ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":421,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:52:33.484785Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"394.657124ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:556"} {"level":"info","ts":"2026-04-03T01:52:33.484861Z","caller":"traceutil/trace.go:171","msg":"trace[1047013533] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8349; }","duration":"394.739096ms","start":"2026-04-03T01:52:33.090087Z","end":"2026-04-03T01:52:33.484826Z","steps":["trace[1047013533] 'agreement among raft nodes before linearized reading' (duration: 393.090823ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:33.484922Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:52:33.090081Z","time spent":"394.831978ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":579,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-03T01:52:33.484975Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"408.594113ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-03T01:52:33.485078Z","caller":"traceutil/trace.go:171","msg":"trace[1499992575] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8349; }","duration":"408.741856ms","start":"2026-04-03T01:52:33.07631Z","end":"2026-04-03T01:52:33.485052Z","steps":["trace[1499992575] 'agreement among raft nodes before linearized reading' (duration: 406.803616ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:33.485138Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:52:33.076293Z","time spent":"408.834157ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":456,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"info","ts":"2026-04-03T01:52:34.911535Z","caller":"traceutil/trace.go:171","msg":"trace[347517088] transaction","detail":"{read_only:false; response_revision:8356; number_of_response:1; }","duration":"103.808814ms","start":"2026-04-03T01:52:34.8077Z","end":"2026-04-03T01:52:34.911509Z","steps":["trace[347517088] 'process raft request' (duration: 103.630771ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:35.743343Z","caller":"traceutil/trace.go:171","msg":"trace[1700887532] linearizableReadLoop","detail":"{readStateIndex:8655; appliedIndex:8654; }","duration":"238.29038ms","start":"2026-04-03T01:52:35.505024Z","end":"2026-04-03T01:52:35.743315Z","steps":["trace[1700887532] 'read index received' (duration: 183.141779ms)","trace[1700887532] 'applied index is now lower than readState.Index' (duration: 55.147371ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:52:35.743467Z","caller":"traceutil/trace.go:171","msg":"trace[1601723553] transaction","detail":"{read_only:false; response_revision:8359; number_of_response:1; }","duration":"243.104296ms","start":"2026-04-03T01:52:35.500307Z","end":"2026-04-03T01:52:35.743411Z","steps":["trace[1601723553] 'process raft request' (duration: 187.840913ms)","trace[1601723553] 'compare' (duration: 55.013918ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:52:35.743555Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.972983ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:433"} {"level":"info","ts":"2026-04-03T01:52:35.743614Z","caller":"traceutil/trace.go:171","msg":"trace[565491241] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8359; }","duration":"246.085985ms","start":"2026-04-03T01:52:35.497516Z","end":"2026-04-03T01:52:35.743602Z","steps":["trace[565491241] 'agreement among raft nodes before linearized reading' (duration: 245.902961ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:35.753523Z","caller":"traceutil/trace.go:171","msg":"trace[953973078] transaction","detail":"{read_only:false; response_revision:8360; number_of_response:1; }","duration":"245.013285ms","start":"2026-04-03T01:52:35.508482Z","end":"2026-04-03T01:52:35.753496Z","steps":["trace[953973078] 'process raft request' (duration: 244.78344ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:35.753585Z","caller":"traceutil/trace.go:171","msg":"trace[2061769491] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"241.227869ms","start":"2026-04-03T01:52:35.51233Z","end":"2026-04-03T01:52:35.753558Z","steps":["trace[2061769491] 'process raft request' (duration: 241.079176ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:45.410281Z","caller":"traceutil/trace.go:171","msg":"trace[2080627709] transaction","detail":"{read_only:false; response_revision:8453; number_of_response:1; }","duration":"137.926386ms","start":"2026-04-03T01:52:45.272313Z","end":"2026-04-03T01:52:45.41024Z","steps":["trace[2080627709] 'process raft request' (duration: 58.713713ms)","trace[2080627709] 'compare' (duration: 78.58937ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:52:46.02248Z","caller":"traceutil/trace.go:171","msg":"trace[1441846192] transaction","detail":"{read_only:false; response_revision:8455; number_of_response:1; }","duration":"250.215169ms","start":"2026-04-03T01:52:45.772237Z","end":"2026-04-03T01:52:46.022452Z","steps":["trace[1441846192] 'process raft request' (duration: 250.015045ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:46.120529Z","caller":"traceutil/trace.go:171","msg":"trace[1016305439] transaction","detail":"{read_only:false; response_revision:8457; number_of_response:1; }","duration":"242.950834ms","start":"2026-04-03T01:52:45.877544Z","end":"2026-04-03T01:52:46.120495Z","steps":["trace[1016305439] 'process raft request' (duration: 242.838232ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:46.120672Z","caller":"traceutil/trace.go:171","msg":"trace[105889878] linearizableReadLoop","detail":"{readStateIndex:8756; appliedIndex:8754; }","duration":"330.573874ms","start":"2026-04-03T01:52:45.790073Z","end":"2026-04-03T01:52:46.120647Z","steps":["trace[105889878] 'read index received' (duration: 232.294271ms)","trace[105889878] 'applied index is now lower than readState.Index' (duration: 98.278353ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:52:46.120777Z","caller":"traceutil/trace.go:171","msg":"trace[928753952] transaction","detail":"{read_only:false; response_revision:8456; number_of_response:1; }","duration":"337.920171ms","start":"2026-04-03T01:52:45.782844Z","end":"2026-04-03T01:52:46.120764Z","steps":["trace[928753952] 'process raft request' (duration: 317.585804ms)","trace[928753952] 'compare' (duration: 19.813967ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:52:46.120959Z","caller":"traceutil/trace.go:171","msg":"trace[1862020772] transaction","detail":"{read_only:false; response_revision:8458; number_of_response:1; }","duration":"175.343923ms","start":"2026-04-03T01:52:45.945603Z","end":"2026-04-03T01:52:46.120947Z","steps":["trace[1862020772] 'process raft request' (duration: 174.851923ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:46.121235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"331.152725ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" ","response":"range_response_count:1 size:557"} {"level":"info","ts":"2026-04-03T01:52:46.12128Z","caller":"traceutil/trace.go:171","msg":"trace[465219644] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:8458; }","duration":"331.246777ms","start":"2026-04-03T01:52:45.790019Z","end":"2026-04-03T01:52:46.121266Z","steps":["trace[465219644] 'agreement among raft nodes before linearized reading' (duration: 331.118145ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:46.121311Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:52:45.789996Z","time spent":"331.306839ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":70,"response count":1,"response size":580,"request content":"key:\"/registry/leases/openstack/rabbitmq-cluster-operator-leader-election\" "} {"level":"warn","ts":"2026-04-03T01:52:46.121499Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"318.026934ms","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-04-03T01:52:46.121533Z","caller":"traceutil/trace.go:171","msg":"trace[553826153] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8458; }","duration":"318.083105ms","start":"2026-04-03T01:52:45.803442Z","end":"2026-04-03T01:52:46.121525Z","steps":["trace[553826153] 'agreement among raft nodes before linearized reading' (duration: 317.995463ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:46.12156Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:52:45.80343Z","time spent":"318.124266ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":457,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-04-03T01:52:46.12155Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-04-03T01:52:45.782836Z","time spent":"337.976432ms","remote":"127.0.0.1:36396","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":556,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-04-03T01:52:46.121683Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"220.342762ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:480"} {"level":"info","ts":"2026-04-03T01:52:46.121713Z","caller":"traceutil/trace.go:171","msg":"trace[533880321] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8458; }","duration":"220.386144ms","start":"2026-04-03T01:52:45.90132Z","end":"2026-04-03T01:52:46.121706Z","steps":["trace[533880321] 'agreement among raft nodes before linearized reading' (duration: 220.311412ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:46.121845Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.138966ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/rook-ceph-detect-version-bnm44\" ","response":"range_response_count:1 size:4640"} {"level":"info","ts":"2026-04-03T01:52:46.121875Z","caller":"traceutil/trace.go:171","msg":"trace[668618081] range","detail":"{range_begin:/registry/pods/openstack/rook-ceph-detect-version-bnm44; range_end:; response_count:1; response_revision:8458; }","duration":"245.209128ms","start":"2026-04-03T01:52:45.876659Z","end":"2026-04-03T01:52:46.121868Z","steps":["trace[668618081] 'agreement among raft nodes before linearized reading' (duration: 245.133856ms)"],"step_count":1} {"level":"warn","ts":"2026-04-03T01:52:47.156451Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"182.669229ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:492"} {"level":"info","ts":"2026-04-03T01:52:47.156528Z","caller":"traceutil/trace.go:171","msg":"trace[1669642596] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:8466; }","duration":"182.797872ms","start":"2026-04-03T01:52:46.973712Z","end":"2026-04-03T01:52:47.156509Z","steps":["trace[1669642596] 'range keys from in-memory index tree' (duration: 182.493105ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:47.156539Z","caller":"traceutil/trace.go:171","msg":"trace[1257735213] linearizableReadLoop","detail":"{readStateIndex:8767; appliedIndex:8766; }","duration":"110.828694ms","start":"2026-04-03T01:52:47.045687Z","end":"2026-04-03T01:52:47.156516Z","steps":["trace[1257735213] 'read index received' (duration: 101.907416ms)","trace[1257735213] 'applied index is now lower than readState.Index' (duration: 8.919738ms)"],"step_count":2} {"level":"warn","ts":"2026-04-03T01:52:47.156684Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"110.993928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:505"} {"level":"info","ts":"2026-04-03T01:52:47.156725Z","caller":"traceutil/trace.go:171","msg":"trace[1794374955] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:8467; }","duration":"111.07456ms","start":"2026-04-03T01:52:47.045639Z","end":"2026-04-03T01:52:47.156713Z","steps":["trace[1794374955] 'agreement among raft nodes before linearized reading' (duration: 110.958407ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:47.156673Z","caller":"traceutil/trace.go:171","msg":"trace[1149062682] transaction","detail":"{read_only:false; response_revision:8467; number_of_response:1; }","duration":"167.018516ms","start":"2026-04-03T01:52:46.989547Z","end":"2026-04-03T01:52:47.156565Z","steps":["trace[1149062682] 'process raft request' (duration: 158.104518ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:47.340257Z","caller":"traceutil/trace.go:171","msg":"trace[1590769148] transaction","detail":"{read_only:false; response_revision:8469; number_of_response:1; }","duration":"178.761042ms","start":"2026-04-03T01:52:47.161445Z","end":"2026-04-03T01:52:47.340206Z","steps":["trace[1590769148] 'process raft request' (duration: 178.695821ms)"],"step_count":1} {"level":"info","ts":"2026-04-03T01:52:47.34028Z","caller":"traceutil/trace.go:171","msg":"trace[766435542] transaction","detail":"{read_only:false; response_revision:8468; number_of_response:1; }","duration":"179.111599ms","start":"2026-04-03T01:52:47.161129Z","end":"2026-04-03T01:52:47.340241Z","steps":["trace[766435542] 'process raft request' (duration: 110.14475ms)","trace[766435542] 'compare' (duration: 68.684363ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:53:50.235484Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-00000000000024b0.wal"} {"level":"info","ts":"2026-04-03T01:53:56.779073Z","caller":"traceutil/trace.go:171","msg":"trace[898177760] transaction","detail":"{read_only:false; response_revision:9117; number_of_response:1; }","duration":"152.770083ms","start":"2026-04-03T01:53:56.626256Z","end":"2026-04-03T01:53:56.779026Z","steps":["trace[898177760] 'process raft request' (duration: 89.651241ms)","trace[898177760] 'compare' (duration: 62.788184ms)"],"step_count":2} {"level":"info","ts":"2026-04-03T01:55:00.959768Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"597401b06ce1cf3d","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-04-03T01:55:00.965099Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-04-03T01:55:00.965188Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-04-03T01:57:26.809493Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8268} {"level":"info","ts":"2026-04-03T01:57:26.885281Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8268,"took":"73.651743ms","hash":3499036654,"current-db-size-bytes":58310656,"current-db-size":"58 MB","current-db-size-in-use-bytes":25165824,"current-db-size-in-use":"25 MB"} {"level":"info","ts":"2026-04-03T01:57:26.885347Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3499036654,"revision":8268,"compact-revision":6096} {"level":"info","ts":"2026-04-03T02:02:26.814368Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10694} {"level":"info","ts":"2026-04-03T02:02:26.891716Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10694,"took":"74.936545ms","hash":729751204,"current-db-size-bytes":58310656,"current-db-size":"58 MB","current-db-size-in-use-bytes":20271104,"current-db-size-in-use":"20 MB"} {"level":"info","ts":"2026-04-03T02:02:26.891827Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":729751204,"revision":10694,"compact-revision":8268}