{"level":"warn","ts":"2026-09-07T18:12:40.714363Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T18:12:40.714441Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://162.253.55.135: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://162.253.55.135:2380","--initial-cluster=instance=https://162.253.55.135:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://162.253.55.135:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://162.253.55.135: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-09-07T18:12:40.714496Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-09-07T18:12:40.714518Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://162.253.55.135:2380"]} {"level":"info","ts":"2026-09-07T18:12:40.714535Z","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-09-07T18:12:40.715074Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"]} {"level":"info","ts":"2026-09-07T18:12:40.715144Z","caller":"embed/etcd.go:308","msg":"starting an etcd server","etcd-version":"3.5.12","git-sha":"e7b3bb6cc","go-version":"go1.20.13","go-os":"linux","go-arch":"amd64","max-cpu-set":8,"max-cpu-available":8,"member-initialized":false,"name":"instance","data-dir":"/var/lib/etcd","wal-dir":"","wal-dir-dedicated":"","member-dir":"/var/lib/etcd/member","force-new-cluster":false,"heartbeat-interval":"100ms","election-timeout":"1s","initial-election-tick-advance":true,"snapshot-count":10000,"max-wals":5,"max-snapshots":5,"snapshot-catchup-entries":5000,"initial-advertise-peer-urls":["https://162.253.55.135:2380"],"listen-peer-urls":["https://162.253.55.135:2380"],"advertise-client-urls":["https://162.253.55.135:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://162.253.55.135: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-09-07T18:12:40.719558Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"4.21768ms"} {"level":"info","ts":"2026-09-07T18:12:40.72739Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"36725369a67988c9","cluster-id":"458f7f83a0fed211"} {"level":"info","ts":"2026-09-07T18:12:40.727446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=()"} {"level":"info","ts":"2026-09-07T18:12:40.72746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became follower at term 0"} {"level":"info","ts":"2026-09-07T18:12:40.72747Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 36725369a67988c9 [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-09-07T18:12:40.727482Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became follower at term 1"} {"level":"info","ts":"2026-09-07T18:12:40.727509Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=(3923289938622777545)"} {"level":"warn","ts":"2026-09-07T18:12:40.735792Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-09-07T18:12:40.742082Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-09-07T18:12:40.743688Z","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-09-07T18:12:40.745302Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"36725369a67988c9","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-09-07T18:12:40.745486Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"36725369a67988c9","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-09-07T18:12:40.745592Z","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-09-07T18:12:40.745641Z","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-09-07T18:12:40.745649Z","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-09-07T18:12:40.746371Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 switched to configuration voters=(3923289938622777545)"} {"level":"info","ts":"2026-09-07T18:12:40.746523Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"458f7f83a0fed211","local-member-id":"36725369a67988c9","added-peer-id":"36725369a67988c9","added-peer-peer-urls":["https://162.253.55.135:2380"]} {"level":"info","ts":"2026-09-07T18:12:40.74742Z","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-09-07T18:12:40.747584Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"36725369a67988c9","initial-advertise-peer-urls":["https://162.253.55.135:2380"],"listen-peer-urls":["https://162.253.55.135:2380"],"advertise-client-urls":["https://162.253.55.135:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://162.253.55.135:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-09-07T18:12:40.747608Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-09-07T18:12:40.747721Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"162.253.55.135:2380"} {"level":"info","ts":"2026-09-07T18:12:40.747733Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"162.253.55.135:2380"} {"level":"info","ts":"2026-09-07T18:12:41.228154Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 is starting a new election at term 1"} {"level":"info","ts":"2026-09-07T18:12:41.228241Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became pre-candidate at term 1"} {"level":"info","ts":"2026-09-07T18:12:41.228301Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 received MsgPreVoteResp from 36725369a67988c9 at term 1"} {"level":"info","ts":"2026-09-07T18:12:41.22833Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became candidate at term 2"} {"level":"info","ts":"2026-09-07T18:12:41.228346Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 received MsgVoteResp from 36725369a67988c9 at term 2"} {"level":"info","ts":"2026-09-07T18:12:41.228387Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"36725369a67988c9 became leader at term 2"} {"level":"info","ts":"2026-09-07T18:12:41.228416Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 36725369a67988c9 elected leader 36725369a67988c9 at term 2"} {"level":"info","ts":"2026-09-07T18:12:41.25049Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"36725369a67988c9","local-member-attributes":"{Name:instance ClientURLs:[https://162.253.55.135:2379]}","request-path":"/0/members/36725369a67988c9/attributes","cluster-id":"458f7f83a0fed211","publish-timeout":"7s"} {"level":"info","ts":"2026-09-07T18:12:41.250472Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:12:41.250766Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T18:12:41.251053Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-09-07T18:12:41.251472Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-09-07T18:12:41.251506Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-09-07T18:12:41.253991Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"162.253.55.135:2379"} {"level":"info","ts":"2026-09-07T18:12:41.255115Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-09-07T18:12:41.269669Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"458f7f83a0fed211","local-member-id":"36725369a67988c9","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:12:41.270045Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:12:41.270209Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-09-07T18:12:51.119597Z","caller":"traceutil/trace.go:171","msg":"trace[1621067499] transaction","detail":"{read_only:false; response_revision:299; number_of_response:1; }","duration":"115.929481ms","start":"2026-09-07T18:12:51.003632Z","end":"2026-09-07T18:12:51.119562Z","steps":["trace[1621067499] 'process raft request' (duration: 103.070485ms)","trace[1621067499] 'compare' (duration: 12.742412ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:13:22.925557Z","caller":"traceutil/trace.go:171","msg":"trace[612644295] transaction","detail":"{read_only:false; response_revision:496; number_of_response:1; }","duration":"553.476338ms","start":"2026-09-07T18:13:22.372046Z","end":"2026-09-07T18:13:22.925523Z","steps":["trace[612644295] 'process raft request' (duration: 553.279493ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:22.926672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.372025Z","time spent":"553.855518ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":6315,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:22.948329Z","caller":"traceutil/trace.go:171","msg":"trace[869415238] transaction","detail":"{read_only:false; response_revision:497; number_of_response:1; }","duration":"569.144406ms","start":"2026-09-07T18:13:22.379156Z","end":"2026-09-07T18:13:22.9483Z","steps":["trace[869415238] 'process raft request' (duration: 568.93627ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:22.948477Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.379126Z","time spent":"569.29078ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":8162,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:22.948616Z","caller":"traceutil/trace.go:171","msg":"trace[1687095944] transaction","detail":"{read_only:false; response_revision:500; number_of_response:1; }","duration":"535.194194ms","start":"2026-09-07T18:13:22.413408Z","end":"2026-09-07T18:13:22.948602Z","steps":["trace[1687095944] 'process raft request' (duration: 535.001359ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:22.948724Z","caller":"traceutil/trace.go:171","msg":"trace[170263082] transaction","detail":"{read_only:false; response_revision:502; number_of_response:1; }","duration":"528.253855ms","start":"2026-09-07T18:13:22.420416Z","end":"2026-09-07T18:13:22.94867Z","steps":["trace[170263082] 'process raft request' (duration: 528.094341ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:22.948773Z","caller":"traceutil/trace.go:171","msg":"trace[1345785154] transaction","detail":"{read_only:false; response_revision:501; number_of_response:1; }","duration":"531.432687ms","start":"2026-09-07T18:13:22.417319Z","end":"2026-09-07T18:13:22.948752Z","steps":["trace[1345785154] 'process raft request' (duration: 531.15237ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:22.948861Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.417288Z","time spent":"531.5316ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29801,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:22.948995Z","caller":"traceutil/trace.go:171","msg":"trace[358817271] transaction","detail":"{read_only:false; response_revision:507; number_of_response:1; }","duration":"358.276114ms","start":"2026-09-07T18:13:22.590595Z","end":"2026-09-07T18:13:22.948872Z","steps":["trace[358817271] 'process raft request' (duration: 358.196042ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:22.949046Z","caller":"traceutil/trace.go:171","msg":"trace[1089898176] transaction","detail":"{read_only:false; response_revision:498; number_of_response:1; }","duration":"551.523338ms","start":"2026-09-07T18:13:22.397513Z","end":"2026-09-07T18:13:22.949036Z","steps":["trace[1089898176] 'process raft request' (duration: 550.692476ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:22.949097Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.397481Z","time spent":"551.59254ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9490,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:13:22.94914Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.420401Z","time spent":"528.43086ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":22019,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:22.949189Z","caller":"traceutil/trace.go:171","msg":"trace[1976777689] transaction","detail":"{read_only:false; response_revision:499; number_of_response:1; }","duration":"547.828113ms","start":"2026-09-07T18:13:22.401353Z","end":"2026-09-07T18:13:22.949181Z","steps":["trace[1976777689] 'process raft request' (duration: 547.004711ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:22.949212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.590574Z","time spent":"358.500741ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":149907,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:13:22.949238Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.401339Z","time spent":"547.880384ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":29820,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:22.949313Z","caller":"traceutil/trace.go:171","msg":"trace[2117783110] transaction","detail":"{read_only:false; response_revision:504; number_of_response:1; }","duration":"508.193313ms","start":"2026-09-07T18:13:22.441104Z","end":"2026-09-07T18:13:22.949297Z","steps":["trace[2117783110] 'process raft request' (duration: 507.500405ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:22.949338Z","caller":"traceutil/trace.go:171","msg":"trace[1836047379] transaction","detail":"{read_only:false; response_revision:505; number_of_response:1; }","duration":"498.379249ms","start":"2026-09-07T18:13:22.450949Z","end":"2026-09-07T18:13:22.949328Z","steps":["trace[1836047379] 'process raft request' (duration: 497.708722ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:22.949361Z","caller":"traceutil/trace.go:171","msg":"trace[2098314659] transaction","detail":"{read_only:false; response_revision:506; number_of_response:1; }","duration":"471.486572ms","start":"2026-09-07T18:13:22.477863Z","end":"2026-09-07T18:13:22.94935Z","steps":["trace[2098314659] 'process raft request' (duration: 470.852765ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:22.949378Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.450893Z","time spent":"498.465102ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":58271,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:13:22.949405Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.477851Z","time spent":"471.533374ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":79374,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:22.949414Z","caller":"traceutil/trace.go:171","msg":"trace[268879262] transaction","detail":"{read_only:false; response_revision:503; number_of_response:1; }","duration":"524.186449ms","start":"2026-09-07T18:13:22.425218Z","end":"2026-09-07T18:13:22.949405Z","steps":["trace[268879262] 'process raft request' (duration: 523.340127ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:22.94938Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.441066Z","time spent":"508.287066ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":63889,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:13:22.949451Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.425205Z","time spent":"524.22961ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28166,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:13:22.949672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.413393Z","time spent":"535.270077ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":28462,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:23.299597Z","caller":"traceutil/trace.go:171","msg":"trace[1211792405] transaction","detail":"{read_only:false; response_revision:518; number_of_response:1; }","duration":"305.447594ms","start":"2026-09-07T18:13:22.994115Z","end":"2026-09-07T18:13:23.299562Z","steps":["trace[1211792405] 'process raft request' (duration: 262.328326ms)","trace[1211792405] 'compare' (duration: 42.931974ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:13:23.299971Z","caller":"traceutil/trace.go:171","msg":"trace[38089139] linearizableReadLoop","detail":"{readStateIndex:537; appliedIndex:535; }","duration":"303.831963ms","start":"2026-09-07T18:13:22.99612Z","end":"2026-09-07T18:13:23.299952Z","steps":["trace[38089139] 'read index received' (duration: 27.083138ms)","trace[38089139] 'applied index is now lower than readState.Index' (duration: 276.747775ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:13:23.299976Z","caller":"traceutil/trace.go:171","msg":"trace[868580648] transaction","detail":"{read_only:false; number_of_response:0; response_revision:518; }","duration":"301.761639ms","start":"2026-09-07T18:13:22.998183Z","end":"2026-09-07T18:13:23.299944Z","steps":["trace[868580648] 'process raft request' (duration: 301.345639ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.300083Z","caller":"traceutil/trace.go:171","msg":"trace[1473681742] transaction","detail":"{read_only:false; number_of_response:0; response_revision:518; }","duration":"300.798515ms","start":"2026-09-07T18:13:22.999275Z","end":"2026-09-07T18:13:23.300073Z","steps":["trace[1473681742] 'process raft request' (duration: 300.515677ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:23.300123Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.998174Z","time spent":"301.879913ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:13:23.300146Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.999267Z","time spent":"300.847136ms","remote":"127.0.0.1:51252","response type":"/etcdserverpb.KV/Txn","request count":0,"request size":0,"response count":0,"response size":27,"request content":"compare: success:> failure:<>"} {"level":"info","ts":"2026-09-07T18:13:23.300249Z","caller":"traceutil/trace.go:171","msg":"trace[1074624611] transaction","detail":"{read_only:false; response_revision:519; number_of_response:1; }","duration":"289.78643ms","start":"2026-09-07T18:13:23.010417Z","end":"2026-09-07T18:13:23.300203Z","steps":["trace[1074624611] 'process raft request' (duration: 289.42373ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:23.300621Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.994096Z","time spent":"305.618048ms","remote":"127.0.0.1:50742","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":9125,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T18:13:23.301095Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"304.952022ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:13:23.301256Z","caller":"traceutil/trace.go:171","msg":"trace[737712327] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:519; }","duration":"305.149277ms","start":"2026-09-07T18:13:22.996088Z","end":"2026-09-07T18:13:23.301237Z","steps":["trace[737712327] 'agreement among raft nodes before linearized reading' (duration: 304.137571ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:23.301308Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:22.996079Z","time spent":"305.216518ms","remote":"127.0.0.1:50696","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":27,"request content":"key:\"/registry/health\" "} {"level":"info","ts":"2026-09-07T18:13:23.30761Z","caller":"traceutil/trace.go:171","msg":"trace[2142555846] transaction","detail":"{read_only:false; number_of_response:0; response_revision:519; }","duration":"282.949733ms","start":"2026-09-07T18:13:23.024611Z","end":"2026-09-07T18:13:23.307561Z","steps":["trace[2142555846] 'process raft request' (duration: 282.550963ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.307898Z","caller":"traceutil/trace.go:171","msg":"trace[1987858097] transaction","detail":"{read_only:false; number_of_response:0; response_revision:519; }","duration":"283.341323ms","start":"2026-09-07T18:13:23.024544Z","end":"2026-09-07T18:13:23.307885Z","steps":["trace[1987858097] 'process raft request' (duration: 282.553613ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.307895Z","caller":"traceutil/trace.go:171","msg":"trace[1454305443] transaction","detail":"{read_only:false; response_revision:520; number_of_response:1; }","duration":"267.126697ms","start":"2026-09-07T18:13:23.040525Z","end":"2026-09-07T18:13:23.307652Z","steps":["trace[1454305443] 'process raft request' (duration: 266.763547ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.308105Z","caller":"traceutil/trace.go:171","msg":"trace[1649515508] transaction","detail":"{read_only:false; response_revision:521; number_of_response:1; }","duration":"257.190941ms","start":"2026-09-07T18:13:23.050884Z","end":"2026-09-07T18:13:23.308075Z","steps":["trace[1649515508] 'process raft request' (duration: 256.620997ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.308669Z","caller":"traceutil/trace.go:171","msg":"trace[1829026157] transaction","detail":"{read_only:false; response_revision:522; number_of_response:1; }","duration":"250.282774ms","start":"2026-09-07T18:13:23.058207Z","end":"2026-09-07T18:13:23.308489Z","steps":["trace[1829026157] 'process raft request' (duration: 249.775331ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.309027Z","caller":"traceutil/trace.go:171","msg":"trace[1524493625] transaction","detail":"{read_only:false; response_revision:523; number_of_response:1; }","duration":"223.429513ms","start":"2026-09-07T18:13:23.085578Z","end":"2026-09-07T18:13:23.309007Z","steps":["trace[1524493625] 'process raft request' (duration: 222.764166ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.559007Z","caller":"traceutil/trace.go:171","msg":"trace[1720675997] linearizableReadLoop","detail":"{readStateIndex:552; appliedIndex:551; }","duration":"146.145668ms","start":"2026-09-07T18:13:23.412837Z","end":"2026-09-07T18:13:23.558983Z","steps":["trace[1720675997] 'read index received' (duration: 76.062106ms)","trace[1720675997] 'applied index is now lower than readState.Index' (duration: 70.082792ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:13:23.559105Z","caller":"traceutil/trace.go:171","msg":"trace[991575457] transaction","detail":"{read_only:false; response_revision:529; number_of_response:1; }","duration":"183.553379ms","start":"2026-09-07T18:13:23.375543Z","end":"2026-09-07T18:13:23.559097Z","steps":["trace[991575457] 'process raft request' (duration: 113.120299ms)","trace[991575457] 'compare' (duration: 70.190414ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:13:23.559371Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"146.521266ms","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-09-07T18:13:23.559457Z","caller":"traceutil/trace.go:171","msg":"trace[1542797179] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:529; }","duration":"146.673751ms","start":"2026-09-07T18:13:23.412764Z","end":"2026-09-07T18:13:23.559437Z","steps":["trace[1542797179] 'agreement among raft nodes before linearized reading' (duration: 146.337622ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:23.561756Z","caller":"traceutil/trace.go:171","msg":"trace[1903134595] transaction","detail":"{read_only:false; response_revision:530; number_of_response:1; }","duration":"140.302086ms","start":"2026-09-07T18:13:23.421428Z","end":"2026-09-07T18:13:23.56173Z","steps":["trace[1903134595] 'process raft request' (duration: 139.795953ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:30.09275Z","caller":"traceutil/trace.go:171","msg":"trace[1561367072] transaction","detail":"{read_only:false; response_revision:607; number_of_response:1; }","duration":"125.220172ms","start":"2026-09-07T18:13:29.967498Z","end":"2026-09-07T18:13:30.092718Z","steps":["trace[1561367072] 'process raft request' (duration: 124.577347ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:30.59539Z","caller":"traceutil/trace.go:171","msg":"trace[2012219552] transaction","detail":"{read_only:false; response_revision:609; number_of_response:1; }","duration":"412.934074ms","start":"2026-09-07T18:13:30.182422Z","end":"2026-09-07T18:13:30.595356Z","steps":["trace[2012219552] 'process raft request' (duration: 412.74995ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:30.595845Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:13:30.182391Z","time spent":"413.353944ms","remote":"127.0.0.1:51236","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1627,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:13:30.768218Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"159.659807ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:13:30.768347Z","caller":"traceutil/trace.go:171","msg":"trace[1131008670] range","detail":"{range_begin:/registry/jobs/envoy-gateway-system/envoy-gateway-gateway-helm-certgen; range_end:; response_count:0; response_revision:609; }","duration":"159.859981ms","start":"2026-09-07T18:13:30.608447Z","end":"2026-09-07T18:13:30.768307Z","steps":["trace[1131008670] 'range keys from in-memory index tree' (duration: 159.532494ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:44.853677Z","caller":"traceutil/trace.go:171","msg":"trace[689496242] transaction","detail":"{read_only:false; response_revision:761; number_of_response:1; }","duration":"147.464814ms","start":"2026-09-07T18:13:44.706183Z","end":"2026-09-07T18:13:44.853648Z","steps":["trace[689496242] 'process raft request' (duration: 147.238139ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:47.864211Z","caller":"traceutil/trace.go:171","msg":"trace[1195854063] linearizableReadLoop","detail":"{readStateIndex:807; appliedIndex:806; }","duration":"137.761656ms","start":"2026-09-07T18:13:47.726419Z","end":"2026-09-07T18:13:47.864181Z","steps":["trace[1195854063] 'read index received' (duration: 137.49353ms)","trace[1195854063] 'applied index is now lower than readState.Index' (duration: 266.726µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:13:47.864341Z","caller":"traceutil/trace.go:171","msg":"trace[1486755642] transaction","detail":"{read_only:false; response_revision:777; number_of_response:1; }","duration":"147.204954ms","start":"2026-09-07T18:13:47.71711Z","end":"2026-09-07T18:13:47.864315Z","steps":["trace[1486755642] 'process raft request' (duration: 146.871388ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:47.86454Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"138.103873ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-07T18:13:47.864606Z","caller":"traceutil/trace.go:171","msg":"trace[48277574] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:777; }","duration":"138.236338ms","start":"2026-09-07T18:13:47.726341Z","end":"2026-09-07T18:13:47.864577Z","steps":["trace[48277574] 'agreement among raft nodes before linearized reading' (duration: 138.019272ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:47.86478Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.692376ms","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-09-07T18:13:47.864931Z","caller":"traceutil/trace.go:171","msg":"trace[1227580161] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:777; }","duration":"137.890519ms","start":"2026-09-07T18:13:47.727017Z","end":"2026-09-07T18:13:47.864907Z","steps":["trace[1227580161] 'agreement among raft nodes before linearized reading' (duration: 137.46009ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:13:48.106123Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.80398ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T18:13:48.106389Z","caller":"traceutil/trace.go:171","msg":"trace[1958215016] transaction","detail":"{read_only:false; response_revision:779; number_of_response:1; }","duration":"236.648391ms","start":"2026-09-07T18:13:47.869722Z","end":"2026-09-07T18:13:48.10637Z","steps":["trace[1958215016] 'process raft request' (duration: 236.588109ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:13:48.106519Z","caller":"traceutil/trace.go:171","msg":"trace[1686637253] transaction","detail":"{read_only:false; response_revision:778; number_of_response:1; }","duration":"237.494908ms","start":"2026-09-07T18:13:47.86901Z","end":"2026-09-07T18:13:48.106505Z","steps":["trace[1686637253] 'process raft request' (duration: 110.033204ms)","trace[1686637253] 'compare' (duration: 126.603796ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:13:55.438335Z","caller":"traceutil/trace.go:171","msg":"trace[970030400] transaction","detail":"{read_only:false; response_revision:853; number_of_response:1; }","duration":"110.163473ms","start":"2026-09-07T18:13:55.328132Z","end":"2026-09-07T18:13:55.438295Z","steps":["trace[970030400] 'process raft request' (duration: 101.027882ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:14:02.462856Z","caller":"traceutil/trace.go:171","msg":"trace[1883907285] transaction","detail":"{read_only:false; response_revision:942; number_of_response:1; }","duration":"140.232847ms","start":"2026-09-07T18:14:02.322597Z","end":"2026-09-07T18:14:02.46283Z","steps":["trace[1883907285] 'process raft request' (duration: 135.210033ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:14:02.463056Z","caller":"traceutil/trace.go:171","msg":"trace[1831733186] linearizableReadLoop","detail":"{readStateIndex:975; appliedIndex:974; }","duration":"125.059521ms","start":"2026-09-07T18:14:02.337703Z","end":"2026-09-07T18:14:02.462763Z","steps":["trace[1831733186] 'read index received' (duration: 120.048317ms)","trace[1831733186] 'applied index is now lower than readState.Index' (duration: 5.009714ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:14:02.463104Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.379889ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-07T18:14:02.463171Z","caller":"traceutil/trace.go:171","msg":"trace[903818620] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:942; }","duration":"125.50562ms","start":"2026-09-07T18:14:02.33765Z","end":"2026-09-07T18:14:02.463156Z","steps":["trace[903818620] 'agreement among raft nodes before linearized reading' (duration: 125.260445ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:14:08.482263Z","caller":"traceutil/trace.go:171","msg":"trace[952641635] transaction","detail":"{read_only:false; response_revision:1040; number_of_response:1; }","duration":"104.10349ms","start":"2026-09-07T18:14:08.3781Z","end":"2026-09-07T18:14:08.482203Z","steps":["trace[952641635] 'process raft request' (duration: 103.959598ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:14:08.482276Z","caller":"traceutil/trace.go:171","msg":"trace[2027585819] transaction","detail":"{read_only:false; response_revision:1039; number_of_response:1; }","duration":"104.262233ms","start":"2026-09-07T18:14:08.37798Z","end":"2026-09-07T18:14:08.482242Z","steps":["trace[2027585819] 'process raft request' (duration: 62.077997ms)","trace[2027585819] 'compare' (duration: 41.81692ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:14:08.482323Z","caller":"traceutil/trace.go:171","msg":"trace[1124650034] transaction","detail":"{read_only:false; response_revision:1041; number_of_response:1; }","duration":"104.064319ms","start":"2026-09-07T18:14:08.378246Z","end":"2026-09-07T18:14:08.48231Z","steps":["trace[1124650034] 'process raft request' (duration: 103.864546ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:14:08.482671Z","caller":"traceutil/trace.go:171","msg":"trace[726932233] transaction","detail":"{read_only:false; response_revision:1042; number_of_response:1; }","duration":"104.300503ms","start":"2026-09-07T18:14:08.378339Z","end":"2026-09-07T18:14:08.482639Z","steps":["trace[726932233] 'process raft request' (duration: 103.803514ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:14:20.772519Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"100.481928ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"info","ts":"2026-09-07T18:14:20.772745Z","caller":"traceutil/trace.go:171","msg":"trace[1063704877] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:1188; }","duration":"100.775443ms","start":"2026-09-07T18:14:20.671947Z","end":"2026-09-07T18:14:20.772722Z","steps":["trace[1063704877] 'range keys from in-memory index tree' (duration: 100.241973ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:14:43.027971Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"113.83436ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/ingress-nginx/ingress-nginx-admission\" ","response":"range_response_count:1 size:1827"} {"level":"info","ts":"2026-09-07T18:14:43.028072Z","caller":"traceutil/trace.go:171","msg":"trace[1029486578] range","detail":"{range_begin:/registry/secrets/ingress-nginx/ingress-nginx-admission; range_end:; response_count:1; response_revision:1440; }","duration":"113.998582ms","start":"2026-09-07T18:14:42.914054Z","end":"2026-09-07T18:14:43.028053Z","steps":["trace[1029486578] 'range keys from in-memory index tree' (duration: 113.640217ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:14:43.028198Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"130.806358ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-controller\" ","response":"range_response_count:1 size:530"} {"level":"info","ts":"2026-09-07T18:14:43.028339Z","caller":"traceutil/trace.go:171","msg":"trace[1803056882] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-controller; range_end:; response_count:1; response_revision:1440; }","duration":"130.99993ms","start":"2026-09-07T18:14:42.897315Z","end":"2026-09-07T18:14:43.028314Z","steps":["trace[1803056882] 'range keys from in-memory index tree' (duration: 130.498451ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:11.594041Z","caller":"traceutil/trace.go:171","msg":"trace[2092056722] transaction","detail":"{read_only:false; response_revision:1871; number_of_response:1; }","duration":"141.799312ms","start":"2026-09-07T18:15:11.452201Z","end":"2026-09-07T18:15:11.594Z","steps":["trace[2092056722] 'process raft request' (duration: 141.762121ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:11.594163Z","caller":"traceutil/trace.go:171","msg":"trace[143394521] transaction","detail":"{read_only:false; response_revision:1870; number_of_response:1; }","duration":"144.003921ms","start":"2026-09-07T18:15:11.450078Z","end":"2026-09-07T18:15:11.594082Z","steps":["trace[143394521] 'process raft request' (duration: 88.658001ms)","trace[143394521] 'compare' (duration: 55.099477ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:15:11.988392Z","caller":"traceutil/trace.go:171","msg":"trace[1438077106] transaction","detail":"{read_only:false; response_revision:1872; number_of_response:1; }","duration":"229.442699ms","start":"2026-09-07T18:15:11.758907Z","end":"2026-09-07T18:15:11.988349Z","steps":["trace[1438077106] 'process raft request' (duration: 173.537282ms)","trace[1438077106] 'compare' (duration: 55.501472ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:15:12.414009Z","caller":"traceutil/trace.go:171","msg":"trace[1497429054] linearizableReadLoop","detail":"{readStateIndex:1945; appliedIndex:1944; }","duration":"133.333811ms","start":"2026-09-07T18:15:12.280648Z","end":"2026-09-07T18:15:12.413981Z","steps":["trace[1497429054] 'read index received' (duration: 133.091848ms)","trace[1497429054] 'applied index is now lower than readState.Index' (duration: 240.533µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:15:12.414303Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"112.762153ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"warn","ts":"2026-09-07T18:15:12.414335Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.600485ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-d1a7d7aa-0cde-4032-b594-e7194d1853cc\" ","response":"range_response_count:1 size:3744"} {"level":"info","ts":"2026-09-07T18:15:12.414361Z","caller":"traceutil/trace.go:171","msg":"trace[930129603] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1874; }","duration":"112.868573ms","start":"2026-09-07T18:15:12.301475Z","end":"2026-09-07T18:15:12.414343Z","steps":["trace[930129603] 'agreement among raft nodes before linearized reading' (duration: 112.691111ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:12.414375Z","caller":"traceutil/trace.go:171","msg":"trace[1605586961] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-d1a7d7aa-0cde-4032-b594-e7194d1853cc; range_end:; response_count:1; response_revision:1874; }","duration":"133.762877ms","start":"2026-09-07T18:15:12.2806Z","end":"2026-09-07T18:15:12.414363Z","steps":["trace[1605586961] 'agreement among raft nodes before linearized reading' (duration: 133.545174ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:12.414754Z","caller":"traceutil/trace.go:171","msg":"trace[1872794959] transaction","detail":"{read_only:false; response_revision:1874; number_of_response:1; }","duration":"191.779101ms","start":"2026-09-07T18:15:12.222268Z","end":"2026-09-07T18:15:12.414047Z","steps":["trace[1872794959] 'process raft request' (duration: 191.550598ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:50.8808Z","caller":"traceutil/trace.go:171","msg":"trace[56831974] linearizableReadLoop","detail":"{readStateIndex:2212; appliedIndex:2211; }","duration":"156.403246ms","start":"2026-09-07T18:15:50.72437Z","end":"2026-09-07T18:15:50.880773Z","steps":["trace[56831974] 'read index received' (duration: 156.229883ms)","trace[56831974] 'applied index is now lower than readState.Index' (duration: 172.083µs)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:15:50.880852Z","caller":"traceutil/trace.go:171","msg":"trace[531909728] transaction","detail":"{read_only:false; response_revision:2132; number_of_response:1; }","duration":"290.476854ms","start":"2026-09-07T18:15:50.590329Z","end":"2026-09-07T18:15:50.880806Z","steps":["trace[531909728] 'process raft request' (duration: 290.21801ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:15:50.881155Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.76023ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5444"} {"level":"info","ts":"2026-09-07T18:15:50.881253Z","caller":"traceutil/trace.go:171","msg":"trace[469684079] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:2132; }","duration":"156.922391ms","start":"2026-09-07T18:15:50.724303Z","end":"2026-09-07T18:15:50.881225Z","steps":["trace[469684079] 'agreement among raft nodes before linearized reading' (duration: 156.622367ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:51.086857Z","caller":"traceutil/trace.go:171","msg":"trace[1820619535] linearizableReadLoop","detail":"{readStateIndex:2214; appliedIndex:2212; }","duration":"205.939262ms","start":"2026-09-07T18:15:50.88089Z","end":"2026-09-07T18:15:51.08683Z","steps":["trace[1820619535] 'read index received' (duration: 174.651318ms)","trace[1820619535] 'applied index is now lower than readState.Index' (duration: 31.286444ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:15:51.086906Z","caller":"traceutil/trace.go:171","msg":"trace[1314378606] transaction","detail":"{read_only:false; response_revision:2134; number_of_response:1; }","duration":"233.067707ms","start":"2026-09-07T18:15:50.853795Z","end":"2026-09-07T18:15:51.086863Z","steps":["trace[1314378606] 'process raft request' (duration: 232.971646ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:15:51.086903Z","caller":"traceutil/trace.go:171","msg":"trace[454663118] transaction","detail":"{read_only:false; response_revision:2133; number_of_response:1; }","duration":"240.586949ms","start":"2026-09-07T18:15:50.846265Z","end":"2026-09-07T18:15:51.086852Z","steps":["trace[454663118] 'process raft request' (duration: 209.350675ms)","trace[454663118] 'compare' (duration: 30.994291ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:15:51.087224Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"209.049281ms","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-09-07T18:15:51.087298Z","caller":"traceutil/trace.go:171","msg":"trace[896104671] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:2134; }","duration":"209.236493ms","start":"2026-09-07T18:15:50.87804Z","end":"2026-09-07T18:15:51.087277Z","steps":["trace[896104671] 'agreement among raft nodes before linearized reading' (duration: 208.95947ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:15:51.087219Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.43054ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:15:51.087454Z","caller":"traceutil/trace.go:171","msg":"trace[1489165772] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:2134; }","duration":"120.765304ms","start":"2026-09-07T18:15:50.966673Z","end":"2026-09-07T18:15:51.087438Z","steps":["trace[1489165772] 'agreement among raft nodes before linearized reading' (duration: 120.457821ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:17:29.755052Z","caller":"traceutil/trace.go:171","msg":"trace[1840912443] linearizableReadLoop","detail":"{readStateIndex:2872; appliedIndex:2871; }","duration":"165.270298ms","start":"2026-09-07T18:17:29.589747Z","end":"2026-09-07T18:17:29.755017Z","steps":["trace[1840912443] 'read index received' (duration: 116.636378ms)","trace[1840912443] 'applied index is now lower than readState.Index' (duration: 48.632589ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:17:29.755091Z","caller":"traceutil/trace.go:171","msg":"trace[1478935828] transaction","detail":"{read_only:false; response_revision:2771; number_of_response:1; }","duration":"219.017645ms","start":"2026-09-07T18:17:29.536015Z","end":"2026-09-07T18:17:29.755033Z","steps":["trace[1478935828] 'process raft request' (duration: 170.344854ms)","trace[1478935828] 'compare' (duration: 48.523425ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:17:29.755758Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"165.972231ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/cert-manager/cert-manager-cainjector-leader-election\" ","response":"range_response_count:1 size:559"} {"level":"info","ts":"2026-09-07T18:17:29.755882Z","caller":"traceutil/trace.go:171","msg":"trace[779256176] range","detail":"{range_begin:/registry/leases/cert-manager/cert-manager-cainjector-leader-election; range_end:; response_count:1; response_revision:2771; }","duration":"166.151167ms","start":"2026-09-07T18:17:29.589698Z","end":"2026-09-07T18:17:29.755849Z","steps":["trace[779256176] 'agreement among raft nodes before linearized reading' (duration: 165.476034ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:57.564103Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.195024ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T18:21:57.56425Z","caller":"traceutil/trace.go:171","msg":"trace[871126022] transaction","detail":"{read_only:false; response_revision:4797; number_of_response:1; }","duration":"235.979695ms","start":"2026-09-07T18:21:57.328247Z","end":"2026-09-07T18:21:57.564227Z","steps":["trace[871126022] 'process raft request' (duration: 33.505326ms)","trace[871126022] 'compare' (duration: 201.96847ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:21:57.564366Z","caller":"traceutil/trace.go:171","msg":"trace[270334127] transaction","detail":"{read_only:false; response_revision:4798; number_of_response:1; }","duration":"130.977661ms","start":"2026-09-07T18:21:57.433371Z","end":"2026-09-07T18:21:57.564349Z","steps":["trace[270334127] 'process raft request' (duration: 130.882639ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:21:57.56446Z","caller":"traceutil/trace.go:171","msg":"trace[1244412324] linearizableReadLoop","detail":"{readStateIndex:4979; appliedIndex:4978; }","duration":"232.226639ms","start":"2026-09-07T18:21:57.332223Z","end":"2026-09-07T18:21:57.56445Z","steps":["trace[1244412324] 'read index received' (duration: 10.202618ms)","trace[1244412324] 'applied index is now lower than readState.Index' (duration: 222.023151ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:21:57.564596Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"232.354001ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53117333-474d-4fd9-b36a-edb1bcfaf816\" ","response":"range_response_count:1 size:3774"} {"level":"info","ts":"2026-09-07T18:21:57.56463Z","caller":"traceutil/trace.go:171","msg":"trace[509562032] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53117333-474d-4fd9-b36a-edb1bcfaf816; range_end:; response_count:1; response_revision:4798; }","duration":"232.425943ms","start":"2026-09-07T18:21:57.332197Z","end":"2026-09-07T18:21:57.564623Z","steps":["trace[509562032] 'agreement among raft nodes before linearized reading' (duration: 232.294901ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:21:57.565087Z","caller":"traceutil/trace.go:171","msg":"trace[783861456] transaction","detail":"{read_only:false; response_revision:4799; number_of_response:1; }","duration":"116.097669ms","start":"2026-09-07T18:21:57.448967Z","end":"2026-09-07T18:21:57.565065Z","steps":["trace[783861456] 'process raft request' (duration: 115.949657ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:57.56627Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.459246ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"info","ts":"2026-09-07T18:21:57.566375Z","caller":"traceutil/trace.go:171","msg":"trace[329765123] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4799; }","duration":"120.642358ms","start":"2026-09-07T18:21:57.445708Z","end":"2026-09-07T18:21:57.56635Z","steps":["trace[329765123] 'agreement among raft nodes before linearized reading' (duration: 119.285914ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:59.916667Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"348.575039ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"warn","ts":"2026-09-07T18:21:59.916674Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.357896ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.x-k8s.io/xlistenersets/\" range_end:\"/registry/gateway.networking.x-k8s.io/xlistenersets0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:21:59.916754Z","caller":"traceutil/trace.go:171","msg":"trace[1896857471] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:4844; }","duration":"348.723612ms","start":"2026-09-07T18:21:59.568011Z","end":"2026-09-07T18:21:59.916734Z","steps":["trace[1896857471] 'range keys from in-memory index tree' (duration: 348.383197ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:59.916795Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:21:59.567986Z","time spent":"348.800143ms","remote":"127.0.0.1:50964","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-09-07T18:21:59.916783Z","caller":"traceutil/trace.go:171","msg":"trace[9724047] range","detail":"{range_begin:/registry/gateway.networking.x-k8s.io/xlistenersets/; range_end:/registry/gateway.networking.x-k8s.io/xlistenersets0; response_count:0; response_revision:4844; }","duration":"164.52639ms","start":"2026-09-07T18:21:59.752226Z","end":"2026-09-07T18:21:59.916753Z","steps":["trace[9724047] 'count revisions from in-memory index tree' (duration: 164.196744ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:59.917118Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"111.854971ms","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":"warn","ts":"2026-09-07T18:21:59.917767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.349051ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" ","response":"range_response_count:47 size:2207418"} {"level":"warn","ts":"2026-09-07T18:21:59.917161Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"144.761925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e4750ba4-4031-4739-9d5f-4466afb85c73\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-09-07T18:21:59.917866Z","caller":"traceutil/trace.go:171","msg":"trace[1383755273] range","detail":"{range_begin:/registry/configmaps/monitoring/; range_end:/registry/configmaps/monitoring0; response_count:47; response_revision:4844; }","duration":"381.470563ms","start":"2026-09-07T18:21:59.536374Z","end":"2026-09-07T18:21:59.917844Z","steps":["trace[1383755273] 'range keys from in-memory index tree' (duration: 380.450416ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:21:59.917802Z","caller":"traceutil/trace.go:171","msg":"trace[926551363] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:4844; }","duration":"112.601013ms","start":"2026-09-07T18:21:59.805173Z","end":"2026-09-07T18:21:59.917774Z","steps":["trace[926551363] 'range keys from in-memory index tree' (duration: 111.636737ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:59.917909Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:21:59.536369Z","time spent":"381.530004ms","remote":"127.0.0.1:50804","response type":"/etcdserverpb.KV/Range","request count":0,"request size":68,"response count":47,"response size":2207440,"request content":"key:\"/registry/configmaps/monitoring/\" range_end:\"/registry/configmaps/monitoring0\" "} {"level":"info","ts":"2026-09-07T18:21:59.917927Z","caller":"traceutil/trace.go:171","msg":"trace[1521779751] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e4750ba4-4031-4739-9d5f-4466afb85c73; range_end:; response_count:1; response_revision:4844; }","duration":"145.568379ms","start":"2026-09-07T18:21:59.772326Z","end":"2026-09-07T18:21:59.917895Z","steps":["trace[1521779751] 'range keys from in-memory index tree' (duration: 144.50518ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:59.917285Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"389.703997ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:21:59.918248Z","caller":"traceutil/trace.go:171","msg":"trace[162966848] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusterbackups/; range_end:/registry/pxc.percona.com/perconaxtradbclusterbackups0; response_count:0; response_revision:4844; }","duration":"391.58913ms","start":"2026-09-07T18:21:59.526641Z","end":"2026-09-07T18:21:59.91823Z","steps":["trace[162966848] 'count revisions from in-memory index tree' (duration: 389.602105ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:21:59.918303Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:21:59.526614Z","time spent":"391.670522ms","remote":"127.0.0.1:54774","response type":"/etcdserverpb.KV/Range","request count":0,"request size":114,"response count":0,"response size":27,"request content":"key:\"/registry/pxc.percona.com/perconaxtradbclusterbackups/\" range_end:\"/registry/pxc.percona.com/perconaxtradbclusterbackups0\" count_only:true "} {"level":"info","ts":"2026-09-07T18:22:00.228469Z","caller":"traceutil/trace.go:171","msg":"trace[1295027021] transaction","detail":"{read_only:false; number_of_response:1; response_revision:4854; }","duration":"120.709573ms","start":"2026-09-07T18:22:00.107727Z","end":"2026-09-07T18:22:00.228437Z","steps":["trace[1295027021] 'process raft request' (duration: 81.329017ms)","trace[1295027021] 'compare' (duration: 39.169872ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:22:00.228693Z","caller":"traceutil/trace.go:171","msg":"trace[316643640] linearizableReadLoop","detail":"{readStateIndex:5039; appliedIndex:5037; }","duration":"119.014233ms","start":"2026-09-07T18:22:00.10967Z","end":"2026-09-07T18:22:00.228685Z","steps":["trace[316643640] 'read index received' (duration: 25.80234ms)","trace[316643640] 'applied index is now lower than readState.Index' (duration: 93.211063ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:22:00.228908Z","caller":"traceutil/trace.go:171","msg":"trace[101030865] transaction","detail":"{read_only:false; response_revision:4855; number_of_response:1; }","duration":"110.211761ms","start":"2026-09-07T18:22:00.118688Z","end":"2026-09-07T18:22:00.2289Z","steps":["trace[101030865] 'process raft request' (duration: 109.677451ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:00.229368Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.680145ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus\" ","response":"range_response_count:1 size:3506"} {"level":"info","ts":"2026-09-07T18:22:00.229397Z","caller":"traceutil/trace.go:171","msg":"trace[2141375318] range","detail":"{range_begin:/registry/secrets/monitoring/prometheus-kube-prometheus-stack-prometheus; range_end:; response_count:1; response_revision:4855; }","duration":"119.754097ms","start":"2026-09-07T18:22:00.109634Z","end":"2026-09-07T18:22:00.229388Z","steps":["trace[2141375318] 'agreement among raft nodes before linearized reading' (duration: 119.588764ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:00.898735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"354.814231ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T18:22:00.899502Z","caller":"traceutil/trace.go:171","msg":"trace[653860729] transaction","detail":"{read_only:false; response_revision:4856; number_of_response:1; }","duration":"622.819851ms","start":"2026-09-07T18:22:00.276636Z","end":"2026-09-07T18:22:00.899456Z","steps":["trace[653860729] 'process raft request' (duration: 267.177585ms)","trace[653860729] 'compare' (duration: 354.354414ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:22:00.899581Z","caller":"traceutil/trace.go:171","msg":"trace[941592592] linearizableReadLoop","detail":"{readStateIndex:5041; appliedIndex:5040; }","duration":"560.16375ms","start":"2026-09-07T18:22:00.339389Z","end":"2026-09-07T18:22:00.899553Z","steps":["trace[941592592] 'read index received' (duration: 204.389661ms)","trace[941592592] 'applied index is now lower than readState.Index' (duration: 355.771459ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:22:00.899701Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:22:00.276624Z","time spent":"622.959433ms","remote":"127.0.0.1:60920","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":7450,"response count":0,"response size":38,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-09-07T18:22:00.900325Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"528.682411ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e4750ba4-4031-4739-9d5f-4466afb85c73\" ","response":"range_response_count:1 size:4050"} {"level":"info","ts":"2026-09-07T18:22:00.900377Z","caller":"traceutil/trace.go:171","msg":"trace[1003035038] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-e4750ba4-4031-4739-9d5f-4466afb85c73; range_end:; response_count:1; response_revision:4858; }","duration":"528.769612ms","start":"2026-09-07T18:22:00.37159Z","end":"2026-09-07T18:22:00.90036Z","steps":["trace[1003035038] 'agreement among raft nodes before linearized reading' (duration: 528.608609ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:00.900357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"560.944563ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53117333-474d-4fd9-b36a-edb1bcfaf816\" ","response":"range_response_count:1 size:4080"} {"level":"warn","ts":"2026-09-07T18:22:00.900422Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:22:00.371558Z","time spent":"528.855044ms","remote":"127.0.0.1:50876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":4072,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-e4750ba4-4031-4739-9d5f-4466afb85c73\" "} {"level":"info","ts":"2026-09-07T18:22:00.900502Z","caller":"traceutil/trace.go:171","msg":"trace[944240210] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-53117333-474d-4fd9-b36a-edb1bcfaf816; range_end:; response_count:1; response_revision:4858; }","duration":"561.091746ms","start":"2026-09-07T18:22:00.339331Z","end":"2026-09-07T18:22:00.900423Z","steps":["trace[944240210] 'agreement among raft nodes before linearized reading' (duration: 560.811121ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:00.90061Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:22:00.339307Z","time spent":"561.240938ms","remote":"127.0.0.1:50876","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":4102,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-53117333-474d-4fd9-b36a-edb1bcfaf816\" "} {"level":"info","ts":"2026-09-07T18:22:00.900632Z","caller":"traceutil/trace.go:171","msg":"trace[1871403169] transaction","detail":"{read_only:false; response_revision:4857; number_of_response:1; }","duration":"224.870278ms","start":"2026-09-07T18:22:00.675726Z","end":"2026-09-07T18:22:00.900596Z","steps":["trace[1871403169] 'process raft request' (duration: 223.748318ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:00.901075Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"452.097527ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:507"} {"level":"info","ts":"2026-09-07T18:22:00.901144Z","caller":"traceutil/trace.go:171","msg":"trace[1915282886] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:4858; }","duration":"452.213649ms","start":"2026-09-07T18:22:00.448911Z","end":"2026-09-07T18:22:00.901125Z","steps":["trace[1915282886] 'agreement among raft nodes before linearized reading' (duration: 452.003686ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:00.901212Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:22:00.448892Z","time spent":"452.307041ms","remote":"127.0.0.1:50964","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":529,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"info","ts":"2026-09-07T18:22:01.122555Z","caller":"traceutil/trace.go:171","msg":"trace[1686714862] linearizableReadLoop","detail":"{readStateIndex:5047; appliedIndex:5045; }","duration":"156.745318ms","start":"2026-09-07T18:22:00.965776Z","end":"2026-09-07T18:22:01.122521Z","steps":["trace[1686714862] 'read index received' (duration: 61.186386ms)","trace[1686714862] 'applied index is now lower than readState.Index' (duration: 95.556882ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:22:01.122655Z","caller":"traceutil/trace.go:171","msg":"trace[158708239] transaction","detail":"{read_only:false; response_revision:4861; number_of_response:1; }","duration":"177.336628ms","start":"2026-09-07T18:22:00.945282Z","end":"2026-09-07T18:22:01.122618Z","steps":["trace[158708239] 'process raft request' (duration: 81.679124ms)","trace[158708239] 'compare' (duration: 95.185486ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:22:01.122723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"156.930182ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:22:01.122704Z","caller":"traceutil/trace.go:171","msg":"trace[679537586] transaction","detail":"{read_only:false; response_revision:4862; number_of_response:1; }","duration":"171.247461ms","start":"2026-09-07T18:22:00.951373Z","end":"2026-09-07T18:22:01.122621Z","steps":["trace[679537586] 'process raft request' (duration: 171.034668ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:01.122769Z","caller":"traceutil/trace.go:171","msg":"trace[568700560] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:4862; }","duration":"157.053774ms","start":"2026-09-07T18:22:00.965702Z","end":"2026-09-07T18:22:01.122756Z","steps":["trace[568700560] 'agreement among raft nodes before linearized reading' (duration: 156.953103ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:07.6027Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"186.314383ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure:<>>","response":"size:16"} {"level":"info","ts":"2026-09-07T18:22:07.602927Z","caller":"traceutil/trace.go:171","msg":"trace[169951693] linearizableReadLoop","detail":"{readStateIndex:5181; appliedIndex:5179; }","duration":"192.792464ms","start":"2026-09-07T18:22:07.410117Z","end":"2026-09-07T18:22:07.60291Z","steps":["trace[169951693] 'read index received' (duration: 6.152286ms)","trace[169951693] 'applied index is now lower than readState.Index' (duration: 186.638898ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:22:07.603018Z","caller":"traceutil/trace.go:171","msg":"trace[414162788] transaction","detail":"{read_only:false; response_revision:4992; number_of_response:1; }","duration":"416.060665ms","start":"2026-09-07T18:22:07.186946Z","end":"2026-09-07T18:22:07.603007Z","steps":["trace[414162788] 'process raft request' (duration: 229.368426ms)","trace[414162788] 'compare' (duration: 185.610961ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:22:07.603065Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-09-07T18:22:07.186922Z","time spent":"416.117536ms","remote":"127.0.0.1:50786","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":853,"response count":0,"response size":38,"request content":"compare: success:> failure:<>"} {"level":"warn","ts":"2026-09-07T18:22:07.603389Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"193.250402ms","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-09-07T18:22:07.603485Z","caller":"traceutil/trace.go:171","msg":"trace[733073141] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:4993; }","duration":"193.414575ms","start":"2026-09-07T18:22:07.410047Z","end":"2026-09-07T18:22:07.603461Z","steps":["trace[733073141] 'agreement among raft nodes before linearized reading' (duration: 193.047239ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:07.603547Z","caller":"traceutil/trace.go:171","msg":"trace[1240645409] transaction","detail":"{read_only:false; response_revision:4993; number_of_response:1; }","duration":"210.663264ms","start":"2026-09-07T18:22:07.392868Z","end":"2026-09-07T18:22:07.603531Z","steps":["trace[1240645409] 'process raft request' (duration: 209.956411ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:07.603717Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"180.555772ms","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-09-07T18:22:07.603762Z","caller":"traceutil/trace.go:171","msg":"trace[724688307] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:4993; }","duration":"180.677404ms","start":"2026-09-07T18:22:07.423071Z","end":"2026-09-07T18:22:07.603749Z","steps":["trace[724688307] 'agreement among raft nodes before linearized reading' (duration: 180.572913ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:07.603903Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"163.015579ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0\" ","response":"range_response_count:1 size:16233"} {"level":"warn","ts":"2026-09-07T18:22:07.603865Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.804034ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-bcb3adf1-a5d6-43b2-952a-bd3e30442615\" ","response":"range_response_count:1 size:3646"} {"level":"info","ts":"2026-09-07T18:22:07.604045Z","caller":"traceutil/trace.go:171","msg":"trace[1229224294] range","detail":"{range_begin:/registry/pods/monitoring/prometheus-kube-prometheus-stack-prometheus-0; range_end:; response_count:1; response_revision:4993; }","duration":"163.203093ms","start":"2026-09-07T18:22:07.440827Z","end":"2026-09-07T18:22:07.60403Z","steps":["trace[1229224294] 'agreement among raft nodes before linearized reading' (duration: 163.000259ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:07.604183Z","caller":"traceutil/trace.go:171","msg":"trace[478154421] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-bcb3adf1-a5d6-43b2-952a-bd3e30442615; range_end:; response_count:1; response_revision:4993; }","duration":"127.116669ms","start":"2026-09-07T18:22:07.476972Z","end":"2026-09-07T18:22:07.604089Z","steps":["trace[478154421] 'agreement among raft nodes before linearized reading' (duration: 126.693261ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:10.862993Z","caller":"traceutil/trace.go:171","msg":"trace[1253352906] transaction","detail":"{read_only:false; response_revision:5049; number_of_response:1; }","duration":"180.213837ms","start":"2026-09-07T18:22:10.682738Z","end":"2026-09-07T18:22:10.862952Z","steps":["trace[1253352906] 'process raft request' (duration: 175.953164ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:20.476158Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"213.963073ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:438"} {"level":"warn","ts":"2026-09-07T18:22:20.476202Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.156696ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/httproutes/\" range_end:\"/registry/gateway.networking.k8s.io/httproutes0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-09-07T18:22:20.476244Z","caller":"traceutil/trace.go:171","msg":"trace[1416459994] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:5161; }","duration":"214.130286ms","start":"2026-09-07T18:22:20.262095Z","end":"2026-09-07T18:22:20.476225Z","steps":["trace[1416459994] 'range keys from in-memory index tree' (duration: 213.686648ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:20.476255Z","caller":"traceutil/trace.go:171","msg":"trace[778684010] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/httproutes/; range_end:/registry/gateway.networking.k8s.io/httproutes0; response_count:0; response_revision:5161; }","duration":"132.278069ms","start":"2026-09-07T18:22:20.343963Z","end":"2026-09-07T18:22:20.476241Z","steps":["trace[778684010] 'count revisions from in-memory index tree' (duration: 131.959043ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:20.476471Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.33109ms","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-09-07T18:22:20.476576Z","caller":"traceutil/trace.go:171","msg":"trace[1007630585] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:5161; }","duration":"214.576304ms","start":"2026-09-07T18:22:20.261972Z","end":"2026-09-07T18:22:20.476549Z","steps":["trace[1007630585] 'range keys from in-memory index tree' (duration: 214.001524ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:20.476714Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"240.530806ms","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-09-07T18:22:20.476754Z","caller":"traceutil/trace.go:171","msg":"trace[548020759] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:5161; }","duration":"240.638779ms","start":"2026-09-07T18:22:20.236105Z","end":"2026-09-07T18:22:20.476744Z","steps":["trace[548020759] 'range keys from in-memory index tree' (duration: 240.358485ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:20.663386Z","caller":"traceutil/trace.go:171","msg":"trace[550236055] transaction","detail":"{read_only:false; response_revision:5162; number_of_response:1; }","duration":"180.95545ms","start":"2026-09-07T18:22:20.482394Z","end":"2026-09-07T18:22:20.66335Z","steps":["trace[550236055] 'process raft request' (duration: 180.620634ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:20.667962Z","caller":"traceutil/trace.go:171","msg":"trace[918158540] transaction","detail":"{read_only:false; response_revision:5163; number_of_response:1; }","duration":"184.49105ms","start":"2026-09-07T18:22:20.483455Z","end":"2026-09-07T18:22:20.667946Z","steps":["trace[918158540] 'process raft request' (duration: 184.364178ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:20.668203Z","caller":"traceutil/trace.go:171","msg":"trace[857101014] transaction","detail":"{read_only:false; response_revision:5164; number_of_response:1; }","duration":"184.580262ms","start":"2026-09-07T18:22:20.483589Z","end":"2026-09-07T18:22:20.668169Z","steps":["trace[857101014] 'process raft request' (duration: 184.321387ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:21.232054Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"142.996899ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-09-07T18:22:21.232275Z","caller":"traceutil/trace.go:171","msg":"trace[1835201642] linearizableReadLoop","detail":"{readStateIndex:5365; appliedIndex:5363; }","duration":"202.247559ms","start":"2026-09-07T18:22:21.030004Z","end":"2026-09-07T18:22:21.232252Z","steps":["trace[1835201642] 'read index received' (duration: 35.899452ms)","trace[1835201642] 'applied index is now lower than readState.Index' (duration: 166.346127ms)"],"step_count":2} {"level":"info","ts":"2026-09-07T18:22:21.232438Z","caller":"traceutil/trace.go:171","msg":"trace[250224430] transaction","detail":"{read_only:false; response_revision:5171; number_of_response:1; }","duration":"229.622216ms","start":"2026-09-07T18:22:21.002794Z","end":"2026-09-07T18:22:21.232416Z","steps":["trace[250224430] 'process raft request' (duration: 86.107948ms)","trace[250224430] 'compare' (duration: 142.861197ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:22:21.232727Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"152.460141ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone\" ","response":"range_response_count:1 size:3244"} {"level":"info","ts":"2026-09-07T18:22:21.232809Z","caller":"traceutil/trace.go:171","msg":"trace[614177752] range","detail":"{range_begin:/registry/rabbitmq.com/rabbitmqclusters/openstack/rabbitmq-keystone; range_end:; response_count:1; response_revision:5171; }","duration":"152.612364ms","start":"2026-09-07T18:22:21.080178Z","end":"2026-09-07T18:22:21.23279Z","steps":["trace[614177752] 'agreement among raft nodes before linearized reading' (duration: 152.35546ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:22:21.232835Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"202.816739ms","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-09-07T18:22:21.232911Z","caller":"traceutil/trace.go:171","msg":"trace[1093578805] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:5171; }","duration":"202.966901ms","start":"2026-09-07T18:22:21.029926Z","end":"2026-09-07T18:22:21.232893Z","steps":["trace[1093578805] 'agreement among raft nodes before linearized reading' (duration: 202.731998ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:22:41.290696Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2832} {"level":"info","ts":"2026-09-07T18:22:41.377374Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2832,"took":"85.034976ms","hash":1322318823,"current-db-size-bytes":52129792,"current-db-size":"52 MB","current-db-size-in-use-bytes":27533312,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-09-07T18:22:41.377454Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1322318823,"revision":2832,"compact-revision":-1} {"level":"warn","ts":"2026-09-07T18:23:20.189687Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.584365ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:27"} {"level":"info","ts":"2026-09-07T18:23:20.189842Z","caller":"traceutil/trace.go:171","msg":"trace[1321027869] linearizableReadLoop","detail":"{readStateIndex:5855; appliedIndex:5854; }","duration":"123.004104ms","start":"2026-09-07T18:23:20.066824Z","end":"2026-09-07T18:23:20.189828Z","steps":["trace[1321027869] 'read index received' (duration: 7.187576ms)","trace[1321027869] 'applied index is now lower than readState.Index' (duration: 115.815768ms)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:23:20.191686Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"119.04921ms","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-09-07T18:23:20.191758Z","caller":"traceutil/trace.go:171","msg":"trace[1650756420] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:5647; }","duration":"119.154963ms","start":"2026-09-07T18:23:20.072584Z","end":"2026-09-07T18:23:20.191739Z","steps":["trace[1650756420] 'agreement among raft nodes before linearized reading' (duration: 117.469526ms)"],"step_count":1} {"level":"warn","ts":"2026-09-07T18:23:20.191884Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"125.061769ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:478"} {"level":"info","ts":"2026-09-07T18:23:20.191919Z","caller":"traceutil/trace.go:171","msg":"trace[1533961026] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5647; }","duration":"125.145501ms","start":"2026-09-07T18:23:20.066765Z","end":"2026-09-07T18:23:20.19191Z","steps":["trace[1533961026] 'agreement among raft nodes before linearized reading' (duration: 123.257099ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:26:49.54823Z","caller":"traceutil/trace.go:171","msg":"trace[106541046] linearizableReadLoop","detail":"{readStateIndex:7338; appliedIndex:7337; }","duration":"132.068104ms","start":"2026-09-07T18:26:49.41614Z","end":"2026-09-07T18:26:49.548208Z","steps":["trace[106541046] 'read index received' (duration: 131.863558ms)","trace[106541046] 'applied index is now lower than readState.Index' (duration: 203.686µs)"],"step_count":2} {"level":"warn","ts":"2026-09-07T18:26:49.548723Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.221339ms","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-09-07T18:26:49.548775Z","caller":"traceutil/trace.go:171","msg":"trace[728128789] range","detail":"{range_begin:/registry/leases/openstack/rabbitmq-cluster-operator-leader-election; range_end:; response_count:1; response_revision:7079; }","duration":"132.64116ms","start":"2026-09-07T18:26:49.41612Z","end":"2026-09-07T18:26:49.548761Z","steps":["trace[728128789] 'agreement among raft nodes before linearized reading' (duration: 132.189067ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:26:49.548642Z","caller":"traceutil/trace.go:171","msg":"trace[1689992001] transaction","detail":"{read_only:false; response_revision:7079; number_of_response:1; }","duration":"132.63728ms","start":"2026-09-07T18:26:49.415937Z","end":"2026-09-07T18:26:49.548574Z","steps":["trace[1689992001] 'process raft request' (duration: 132.131855ms)"],"step_count":1} {"level":"info","ts":"2026-09-07T18:27:41.297487Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":5304} {"level":"info","ts":"2026-09-07T18:27:41.384569Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":5304,"took":"84.610369ms","hash":247283657,"current-db-size-bytes":52129792,"current-db-size":"52 MB","current-db-size-in-use-bytes":18657280,"current-db-size-in-use":"19 MB"} {"level":"info","ts":"2026-09-07T18:27:41.384628Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":247283657,"revision":5304,"compact-revision":2832}