{"level":"warn","ts":"2026-08-22T02:52:21.082566Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T02:52:21.08269Z","caller":"etcdmain/etcd.go:73","msg":"Running: ","args":["etcd","--advertise-client-urls=https://199.19.213.96:2379","--cert-file=/etc/kubernetes/pki/etcd/server.crt","--client-cert-auth=true","--data-dir=/var/lib/etcd","--experimental-initial-corrupt-check=true","--experimental-watch-progress-notify-interval=5s","--initial-advertise-peer-urls=https://199.19.213.96:2380","--initial-cluster=instance=https://199.19.213.96:2380","--key-file=/etc/kubernetes/pki/etcd/server.key","--listen-client-urls=https://127.0.0.1:2379,https://199.19.213.96:2379","--listen-metrics-urls=http://127.0.0.1:2381","--listen-peer-urls=https://199.19.213.96:2380","--name=instance","--peer-cert-file=/etc/kubernetes/pki/etcd/peer.crt","--peer-client-cert-auth=true","--peer-key-file=/etc/kubernetes/pki/etcd/peer.key","--peer-trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt","--snapshot-count=10000","--tls-min-version=TLS1.3","--trusted-ca-file=/etc/kubernetes/pki/etcd/ca.crt"]} {"level":"warn","ts":"2026-08-22T02:52:21.082779Z","caller":"embed/config.go:679","msg":"Running http and grpc server on single port. This is not recommended for production."} {"level":"info","ts":"2026-08-22T02:52:21.082798Z","caller":"embed/etcd.go:127","msg":"configuring peer listeners","listen-peer-urls":["https://199.19.213.96:2380"]} {"level":"info","ts":"2026-08-22T02:52:21.082825Z","caller":"embed/etcd.go:494","msg":"starting with peer TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/peer.crt, key = /etc/kubernetes/pki/etcd/peer.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T02:52:21.083643Z","caller":"embed/etcd.go:135","msg":"configuring client listeners","listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.96:2379"]} {"level":"info","ts":"2026-08-22T02:52:21.08375Z","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.19.213.96:2380"],"listen-peer-urls":["https://199.19.213.96:2380"],"advertise-client-urls":["https://199.19.213.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"],"cors":["*"],"host-whitelist":["*"],"initial-cluster":"instance=https://199.19.213.96:2380","initial-cluster-state":"new","initial-cluster-token":"etcd-cluster","quota-backend-bytes":2147483648,"max-request-bytes":1572864,"max-concurrent-streams":4294967295,"pre-vote":true,"initial-corrupt-check":true,"corrupt-check-time-interval":"0s","compact-check-time-enabled":false,"compact-check-time-interval":"1m0s","auto-compaction-mode":"periodic","auto-compaction-retention":"0s","auto-compaction-interval":"0s","discovery-url":"","discovery-proxy":"","downgrade-check-interval":"5s"} {"level":"info","ts":"2026-08-22T02:52:21.086685Z","caller":"etcdserver/backend.go:81","msg":"opened backend db","path":"/var/lib/etcd/member/snap/db","took":"2.651072ms"} {"level":"info","ts":"2026-08-22T02:52:21.097301Z","caller":"etcdserver/raft.go:495","msg":"starting local member","local-member-id":"59b38ffafb07452b","cluster-id":"f6b359b7e8f93d01"} {"level":"info","ts":"2026-08-22T02:52:21.097404Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b switched to configuration voters=()"} {"level":"info","ts":"2026-08-22T02:52:21.097427Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b became follower at term 0"} {"level":"info","ts":"2026-08-22T02:52:21.097446Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"newRaft 59b38ffafb07452b [peers: [], term: 0, commit: 0, applied: 0, lastindex: 0, lastterm: 0]"} {"level":"info","ts":"2026-08-22T02:52:21.09746Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b became follower at term 1"} {"level":"info","ts":"2026-08-22T02:52:21.097504Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b switched to configuration voters=(6463668198322947371)"} {"level":"warn","ts":"2026-08-22T02:52:21.102284Z","caller":"auth/store.go:1241","msg":"simple token is not cryptographically signed"} {"level":"info","ts":"2026-08-22T02:52:21.104853Z","caller":"mvcc/kvstore.go:407","msg":"kvstore restored","current-rev":1} {"level":"info","ts":"2026-08-22T02:52:21.10653Z","caller":"etcdserver/quota.go:94","msg":"enabled backend quota with default value","quota-name":"v3-applier","quota-size-bytes":2147483648,"quota-size":"2.1 GB"} {"level":"info","ts":"2026-08-22T02:52:21.109424Z","caller":"etcdserver/server.go:860","msg":"starting etcd server","local-member-id":"59b38ffafb07452b","local-server-version":"3.5.12","cluster-version":"to_be_decided"} {"level":"info","ts":"2026-08-22T02:52:21.109697Z","caller":"etcdserver/server.go:744","msg":"started as single-node; fast-forwarding election ticks","local-member-id":"59b38ffafb07452b","forward-ticks":9,"forward-duration":"900ms","election-ticks":10,"election-timeout":"1s"} {"level":"info","ts":"2026-08-22T02:52:21.109713Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap.db","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T02:52:21.10983Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/snap","suffix":"snap","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T02:52:21.109855Z","caller":"fileutil/purge.go:50","msg":"started to purge file","dir":"/var/lib/etcd/member/wal","suffix":"wal","max":5,"interval":"30s"} {"level":"info","ts":"2026-08-22T02:52:21.112311Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b switched to configuration voters=(6463668198322947371)"} {"level":"info","ts":"2026-08-22T02:52:21.112528Z","caller":"membership/cluster.go:421","msg":"added member","cluster-id":"f6b359b7e8f93d01","local-member-id":"59b38ffafb07452b","added-peer-id":"59b38ffafb07452b","added-peer-peer-urls":["https://199.19.213.96:2380"]} {"level":"info","ts":"2026-08-22T02:52:21.114815Z","caller":"embed/etcd.go:726","msg":"starting with client TLS","tls-info":"cert = /etc/kubernetes/pki/etcd/server.crt, key = /etc/kubernetes/pki/etcd/server.key, client-cert=, client-key=, trusted-ca = /etc/kubernetes/pki/etcd/ca.crt, client-cert-auth = true, crl-file = ","cipher-suites":[]} {"level":"info","ts":"2026-08-22T02:52:21.114955Z","caller":"embed/etcd.go:597","msg":"serving peer traffic","address":"199.19.213.96:2380"} {"level":"info","ts":"2026-08-22T02:52:21.115043Z","caller":"embed/etcd.go:569","msg":"cmux::serve","address":"199.19.213.96:2380"} {"level":"info","ts":"2026-08-22T02:52:21.115084Z","caller":"embed/etcd.go:277","msg":"now serving peer/client/metrics","local-member-id":"59b38ffafb07452b","initial-advertise-peer-urls":["https://199.19.213.96:2380"],"listen-peer-urls":["https://199.19.213.96:2380"],"advertise-client-urls":["https://199.19.213.96:2379"],"listen-client-urls":["https://127.0.0.1:2379","https://199.19.213.96:2379"],"listen-metrics-urls":["http://127.0.0.1:2381"]} {"level":"info","ts":"2026-08-22T02:52:21.115142Z","caller":"embed/etcd.go:857","msg":"serving metrics","address":"http://127.0.0.1:2381"} {"level":"info","ts":"2026-08-22T02:52:22.098349Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b is starting a new election at term 1"} {"level":"info","ts":"2026-08-22T02:52:22.098412Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b became pre-candidate at term 1"} {"level":"info","ts":"2026-08-22T02:52:22.098461Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b received MsgPreVoteResp from 59b38ffafb07452b at term 1"} {"level":"info","ts":"2026-08-22T02:52:22.098486Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b became candidate at term 2"} {"level":"info","ts":"2026-08-22T02:52:22.098501Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b received MsgVoteResp from 59b38ffafb07452b at term 2"} {"level":"info","ts":"2026-08-22T02:52:22.09868Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"59b38ffafb07452b became leader at term 2"} {"level":"info","ts":"2026-08-22T02:52:22.0987Z","logger":"raft","caller":"etcdserver/zap_raft.go:77","msg":"raft.node: 59b38ffafb07452b elected leader 59b38ffafb07452b at term 2"} {"level":"info","ts":"2026-08-22T02:52:22.099691Z","caller":"etcdserver/server.go:2578","msg":"setting up initial cluster version using v2 API","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:52:22.100603Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T02:52:22.10061Z","caller":"etcdserver/server.go:2068","msg":"published local member to cluster through raft","local-member-id":"59b38ffafb07452b","local-member-attributes":"{Name:instance ClientURLs:[https://199.19.213.96:2379]}","request-path":"/0/members/59b38ffafb07452b/attributes","cluster-id":"f6b359b7e8f93d01","publish-timeout":"7s"} {"level":"info","ts":"2026-08-22T02:52:22.100681Z","caller":"embed/serve.go:103","msg":"ready to serve client requests"} {"level":"info","ts":"2026-08-22T02:52:22.101063Z","caller":"etcdmain/main.go:44","msg":"notifying init daemon"} {"level":"info","ts":"2026-08-22T02:52:22.101138Z","caller":"etcdmain/main.go:50","msg":"successfully notified init daemon"} {"level":"info","ts":"2026-08-22T02:52:22.102006Z","caller":"membership/cluster.go:584","msg":"set initial cluster version","cluster-id":"f6b359b7e8f93d01","local-member-id":"59b38ffafb07452b","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:52:22.102129Z","caller":"api/capability.go:75","msg":"enabled capabilities for version","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:52:22.102278Z","caller":"etcdserver/server.go:2602","msg":"cluster version is updated","cluster-version":"3.5"} {"level":"info","ts":"2026-08-22T02:52:22.104056Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"127.0.0.1:2379"} {"level":"info","ts":"2026-08-22T02:52:22.10453Z","caller":"embed/serve.go:250","msg":"serving client traffic securely","traffic":"grpc+http","address":"199.19.213.96:2379"} {"level":"info","ts":"2026-08-22T02:52:59.049316Z","caller":"traceutil/trace.go:171","msg":"trace[411988301] transaction","detail":"{read_only:false; response_revision:483; number_of_response:1; }","duration":"107.029014ms","start":"2026-08-22T02:52:58.94226Z","end":"2026-08-22T02:52:59.049289Z","steps":["trace[411988301] 'process raft request' (duration: 106.88108ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:59.053823Z","caller":"traceutil/trace.go:171","msg":"trace[317705362] transaction","detail":"{read_only:false; response_revision:484; number_of_response:1; }","duration":"109.117384ms","start":"2026-08-22T02:52:58.944675Z","end":"2026-08-22T02:52:59.053792Z","steps":["trace[317705362] 'process raft request' (duration: 108.704903ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:52:59.053908Z","caller":"traceutil/trace.go:171","msg":"trace[149451055] transaction","detail":"{read_only:false; response_revision:485; number_of_response:1; }","duration":"108.837687ms","start":"2026-08-22T02:52:58.944985Z","end":"2026-08-22T02:52:59.053823Z","steps":["trace[149451055] 'process raft request' (duration: 108.503718ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:53:05.145887Z","caller":"traceutil/trace.go:171","msg":"trace[680214578] linearizableReadLoop","detail":"{readStateIndex:609; appliedIndex:608; }","duration":"124.482712ms","start":"2026-08-22T02:53:05.021379Z","end":"2026-08-22T02:53:05.145862Z","steps":["trace[680214578] 'read index received' (duration: 124.297898ms)","trace[680214578] 'applied index is now lower than readState.Index' (duration: 183.474µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:53:05.145976Z","caller":"traceutil/trace.go:171","msg":"trace[1078829989] transaction","detail":"{read_only:false; response_revision:589; number_of_response:1; }","duration":"156.448822ms","start":"2026-08-22T02:53:04.989482Z","end":"2026-08-22T02:53:05.145931Z","steps":["trace[1078829989] 'process raft request' (duration: 156.182436ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:05.146205Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.805321ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/kube-system/cilium-75zh4\" ","response":"range_response_count:1 size:16961"} {"level":"info","ts":"2026-08-22T02:53:05.14636Z","caller":"traceutil/trace.go:171","msg":"trace[2005771151] range","detail":"{range_begin:/registry/pods/kube-system/cilium-75zh4; range_end:; response_count:1; response_revision:589; }","duration":"125.006145ms","start":"2026-08-22T02:53:05.021326Z","end":"2026-08-22T02:53:05.146332Z","steps":["trace[2005771151] 'agreement among raft nodes before linearized reading' (duration: 124.660237ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:53:06.072954Z","caller":"traceutil/trace.go:171","msg":"trace[328653159] linearizableReadLoop","detail":"{readStateIndex:615; appliedIndex:614; }","duration":"329.427562ms","start":"2026-08-22T02:53:05.743499Z","end":"2026-08-22T02:53:06.072926Z","steps":["trace[328653159] 'read index received' (duration: 328.611812ms)","trace[328653159] 'applied index is now lower than readState.Index' (duration: 814.56µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:53:06.07302Z","caller":"traceutil/trace.go:171","msg":"trace[1120230267] transaction","detail":"{read_only:false; response_revision:594; number_of_response:1; }","duration":"433.922355ms","start":"2026-08-22T02:53:05.639063Z","end":"2026-08-22T02:53:06.072985Z","steps":["trace[1120230267] 'process raft request' (duration: 433.229879ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:06.073132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"329.616486ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T02:53:06.073166Z","caller":"traceutil/trace.go:171","msg":"trace[1882007458] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:594; }","duration":"329.729839ms","start":"2026-08-22T02:53:05.743425Z","end":"2026-08-22T02:53:06.073155Z","steps":["trace[1882007458] 'agreement among raft nodes before linearized reading' (duration: 329.613476ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:06.073207Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:05.743397Z","time spent":"329.801871ms","remote":"127.0.0.1:35388","response type":"/etcdserverpb.KV/Range","request count":0,"request size":18,"response count":0,"response size":28,"request content":"key:\"/registry/health\" "} {"level":"warn","ts":"2026-08-22T02:53:06.073805Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:05.639028Z","time spent":"434.073379ms","remote":"127.0.0.1:35486","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":1036305,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:53:22.354261Z","caller":"traceutil/trace.go:171","msg":"trace[1446264235] transaction","detail":"{read_only:false; response_revision:758; number_of_response:1; }","duration":"122.099187ms","start":"2026-08-22T02:53:22.232137Z","end":"2026-08-22T02:53:22.354236Z","steps":["trace[1446264235] 'process raft request' (duration: 121.958644ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:53:22.536056Z","caller":"traceutil/trace.go:171","msg":"trace[753720885] transaction","detail":"{read_only:false; response_revision:759; number_of_response:1; }","duration":"303.021197ms","start":"2026-08-22T02:53:22.233009Z","end":"2026-08-22T02:53:22.53603Z","steps":["trace[753720885] 'process raft request' (duration: 295.68915ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:53:22.536232Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:53:22.232989Z","time spent":"303.148309ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":422,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T02:54:35.212943Z","caller":"traceutil/trace.go:171","msg":"trace[19747828] linearizableReadLoop","detail":"{readStateIndex:1887; appliedIndex:1886; }","duration":"132.446469ms","start":"2026-08-22T02:54:35.080408Z","end":"2026-08-22T02:54:35.212855Z","steps":["trace[19747828] 'read index received' (duration: 132.236144ms)","trace[19747828] 'applied index is now lower than readState.Index' (duration: 208.935µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:54:35.213021Z","caller":"traceutil/trace.go:171","msg":"trace[517013125] transaction","detail":"{read_only:false; response_revision:1818; number_of_response:1; }","duration":"207.330408ms","start":"2026-08-22T02:54:35.005654Z","end":"2026-08-22T02:54:35.212985Z","steps":["trace[517013125] 'process raft request' (duration: 206.99536ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:54:35.213235Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"132.810848ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/199.19.213.96\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-22T02:54:35.213281Z","caller":"traceutil/trace.go:171","msg":"trace[487738625] range","detail":"{range_begin:/registry/masterleases/199.19.213.96; range_end:; response_count:1; response_revision:1818; }","duration":"132.93058ms","start":"2026-08-22T02:54:35.080338Z","end":"2026-08-22T02:54:35.213269Z","steps":["trace[487738625] 'agreement among raft nodes before linearized reading' (duration: 132.739106ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:54:35.82761Z","caller":"traceutil/trace.go:171","msg":"trace[271929693] transaction","detail":"{read_only:false; response_revision:1821; number_of_response:1; }","duration":"321.409094ms","start":"2026-08-22T02:54:35.50617Z","end":"2026-08-22T02:54:35.827579Z","steps":["trace[271929693] 'process raft request' (duration: 311.930294ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:54:35.82777Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:54:35.506154Z","time spent":"321.524047ms","remote":"127.0.0.1:35594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":3731,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T02:54:35.82784Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"276.11829ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/masterleases/\" range_end:\"/registry/masterleases0\" ","response":"range_response_count:1 size:133"} {"level":"info","ts":"2026-08-22T02:54:35.827929Z","caller":"traceutil/trace.go:171","msg":"trace[743937079] range","detail":"{range_begin:/registry/masterleases/; range_end:/registry/masterleases0; response_count:1; response_revision:1821; }","duration":"276.263094ms","start":"2026-08-22T02:54:35.551645Z","end":"2026-08-22T02:54:35.827908Z","steps":["trace[743937079] 'agreement among raft nodes before linearized reading' (duration: 276.016068ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:54:35.828332Z","caller":"traceutil/trace.go:171","msg":"trace[293139453] linearizableReadLoop","detail":"{readStateIndex:1891; appliedIndex:1890; }","duration":"275.810923ms","start":"2026-08-22T02:54:35.551704Z","end":"2026-08-22T02:54:35.827514Z","steps":["trace[293139453] 'read index received' (duration: 266.425346ms)","trace[293139453] 'applied index is now lower than readState.Index' (duration: 9.383747ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T02:54:35.828648Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"245.584882ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/priorityclasses/\" range_end:\"/registry/priorityclasses0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T02:54:35.828715Z","caller":"traceutil/trace.go:171","msg":"trace[68730091] range","detail":"{range_begin:/registry/priorityclasses/; range_end:/registry/priorityclasses0; response_count:0; response_revision:1821; }","duration":"245.705975ms","start":"2026-08-22T02:54:35.582987Z","end":"2026-08-22T02:54:35.828693Z","steps":["trace[68730091] 'agreement among raft nodes before linearized reading' (duration: 245.47247ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:54:35.829305Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.030122ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:434"} {"level":"info","ts":"2026-08-22T02:54:35.829367Z","caller":"traceutil/trace.go:171","msg":"trace[830083108] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:1821; }","duration":"164.132224ms","start":"2026-08-22T02:54:35.665221Z","end":"2026-08-22T02:54:35.829353Z","steps":["trace[830083108] 'agreement among raft nodes before linearized reading' (duration: 163.942ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:54:35.829655Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.483398ms","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-08-22T02:54:35.829928Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"164.615925ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:506"} {"level":"info","ts":"2026-08-22T02:54:35.829987Z","caller":"traceutil/trace.go:171","msg":"trace[114472694] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:1821; }","duration":"129.866117ms","start":"2026-08-22T02:54:35.700103Z","end":"2026-08-22T02:54:35.829969Z","steps":["trace[114472694] 'agreement among raft nodes before linearized reading' (duration: 129.404136ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:54:35.829999Z","caller":"traceutil/trace.go:171","msg":"trace[1487514893] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:1821; }","duration":"164.725348ms","start":"2026-08-22T02:54:35.665254Z","end":"2026-08-22T02:54:35.82998Z","steps":["trace[1487514893] 'agreement among raft nodes before linearized reading' (duration: 164.39315ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:54:43.752231Z","caller":"traceutil/trace.go:171","msg":"trace[166113373] transaction","detail":"{read_only:false; response_revision:1894; number_of_response:1; }","duration":"107.245356ms","start":"2026-08-22T02:54:43.644953Z","end":"2026-08-22T02:54:43.752198Z","steps":["trace[166113373] 'process raft request' (duration: 107.033481ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:54:49.430475Z","caller":"traceutil/trace.go:171","msg":"trace[1170699440] linearizableReadLoop","detail":"{readStateIndex:2002; appliedIndex:2001; }","duration":"123.260062ms","start":"2026-08-22T02:54:49.307153Z","end":"2026-08-22T02:54:49.430413Z","steps":["trace[1170699440] 'read index received' (duration: 123.099098ms)","trace[1170699440] 'applied index is now lower than readState.Index' (duration: 159.384µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:54:49.430499Z","caller":"traceutil/trace.go:171","msg":"trace[790867360] transaction","detail":"{read_only:false; response_revision:1929; number_of_response:1; }","duration":"146.221043ms","start":"2026-08-22T02:54:49.284251Z","end":"2026-08-22T02:54:49.430472Z","steps":["trace[790867360] 'process raft request' (duration: 146.013568ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:54:49.43076Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"123.584189ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5412"} {"level":"info","ts":"2026-08-22T02:54:49.430849Z","caller":"traceutil/trace.go:171","msg":"trace[492717918] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:1929; }","duration":"123.731364ms","start":"2026-08-22T02:54:49.307095Z","end":"2026-08-22T02:54:49.430826Z","steps":["trace[492717918] 'agreement among raft nodes before linearized reading' (duration: 123.454486ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:59:21.583726Z","caller":"traceutil/trace.go:171","msg":"trace[1813274524] transaction","detail":"{read_only:false; response_revision:3788; number_of_response:1; }","duration":"161.106264ms","start":"2026-08-22T02:59:21.422585Z","end":"2026-08-22T02:59:21.583691Z","steps":["trace[1813274524] 'process raft request' (duration: 138.575548ms)","trace[1813274524] 'compare' (duration: 22.288431ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:59:21.583934Z","caller":"traceutil/trace.go:171","msg":"trace[553064538] linearizableReadLoop","detail":"{readStateIndex:3930; appliedIndex:3928; }","duration":"124.607265ms","start":"2026-08-22T02:59:21.459297Z","end":"2026-08-22T02:59:21.583905Z","steps":["trace[553064538] 'read index received' (duration: 101.872644ms)","trace[553064538] 'applied index is now lower than readState.Index' (duration: 22.732881ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:59:21.584144Z","caller":"traceutil/trace.go:171","msg":"trace[1758128245] transaction","detail":"{read_only:false; response_revision:3789; number_of_response:1; }","duration":"161.478853ms","start":"2026-08-22T02:59:21.422638Z","end":"2026-08-22T02:59:21.584117Z","steps":["trace[1758128245] 'process raft request' (duration: 160.986132ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:59:21.58426Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"124.800929ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.envoyproxy.io/backends/\" range_end:\"/registry/gateway.envoyproxy.io/backends0\" count_only:true ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T02:59:21.584805Z","caller":"traceutil/trace.go:171","msg":"trace[263713015] range","detail":"{range_begin:/registry/gateway.envoyproxy.io/backends/; range_end:/registry/gateway.envoyproxy.io/backends0; response_count:0; response_revision:3789; }","duration":"125.050275ms","start":"2026-08-22T02:59:21.459248Z","end":"2026-08-22T02:59:21.584298Z","steps":["trace[263713015] 'agreement among raft nodes before linearized reading' (duration: 124.80157ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T02:59:27.140755Z","caller":"traceutil/trace.go:171","msg":"trace[12871734] linearizableReadLoop","detail":"{readStateIndex:3959; appliedIndex:3958; }","duration":"221.83978ms","start":"2026-08-22T02:59:26.91889Z","end":"2026-08-22T02:59:27.14073Z","steps":["trace[12871734] 'read index received' (duration: 221.683016ms)","trace[12871734] 'applied index is now lower than readState.Index' (duration: 155.724µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T02:59:27.140811Z","caller":"traceutil/trace.go:171","msg":"trace[1759552850] transaction","detail":"{read_only:false; response_revision:3817; number_of_response:1; }","duration":"325.20141ms","start":"2026-08-22T02:59:26.815577Z","end":"2026-08-22T02:59:27.140779Z","steps":["trace[1759552850] 'process raft request' (duration: 324.950904ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:59:27.141008Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"222.101366ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:439"} {"level":"info","ts":"2026-08-22T02:59:27.141084Z","caller":"traceutil/trace.go:171","msg":"trace[1779958370] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:3817; }","duration":"222.227719ms","start":"2026-08-22T02:59:26.91884Z","end":"2026-08-22T02:59:27.141067Z","steps":["trace[1779958370] 'agreement among raft nodes before linearized reading' (duration: 221.998424ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T02:59:27.141012Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T02:59:26.81556Z","time spent":"325.357854ms","remote":"127.0.0.1:35660","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-08-22T02:59:27.141884Z","caller":"traceutil/trace.go:171","msg":"trace[585864049] transaction","detail":"{read_only:false; response_revision:3818; number_of_response:1; }","duration":"214.684029ms","start":"2026-08-22T02:59:26.927179Z","end":"2026-08-22T02:59:27.141863Z","steps":["trace[585864049] 'process raft request' (duration: 214.552566ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:01:00.319212Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"106.114758ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/\" range_end:\"/registry/pods0\" count_only:true ","response":"range_response_count:0 size:7"} {"level":"info","ts":"2026-08-22T03:01:00.319297Z","caller":"traceutil/trace.go:171","msg":"trace[438774760] range","detail":"{range_begin:/registry/pods/; range_end:/registry/pods0; response_count:0; response_revision:5053; }","duration":"106.266231ms","start":"2026-08-22T03:01:00.213014Z","end":"2026-08-22T03:01:00.31928Z","steps":["trace[438774760] 'count revisions from in-memory index tree' (duration: 106.030246ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:01:00.714013Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"384.190435ms","expected-duration":"100ms","prefix":"","request":"header: lease_revoke:","response":"size:28"} {"level":"info","ts":"2026-08-22T03:01:00.714341Z","caller":"traceutil/trace.go:171","msg":"trace[1641446477] linearizableReadLoop","detail":"{readStateIndex:5243; appliedIndex:5242; }","duration":"422.77515ms","start":"2026-08-22T03:01:00.291527Z","end":"2026-08-22T03:01:00.714302Z","steps":["trace[1641446477] 'read index received' (duration: 37.901669ms)","trace[1641446477] 'applied index is now lower than readState.Index' (duration: 384.871671ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T03:01:00.714574Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"423.031286ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-823b980f-e345-42a2-849d-804fc7ee8300\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-08-22T03:01:00.71461Z","caller":"traceutil/trace.go:171","msg":"trace[138240601] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-823b980f-e345-42a2-849d-804fc7ee8300; range_end:; response_count:1; response_revision:5053; }","duration":"423.122418ms","start":"2026-08-22T03:01:00.291478Z","end":"2026-08-22T03:01:00.714601Z","steps":["trace[138240601] 'agreement among raft nodes before linearized reading' (duration: 422.916663ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:01:00.714639Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:01:00.291454Z","time spent":"423.17844ms","remote":"127.0.0.1:35594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3623,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-823b980f-e345-42a2-849d-804fc7ee8300\" "} {"level":"warn","ts":"2026-08-22T03:01:00.715128Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.226749ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T03:01:00.715162Z","caller":"traceutil/trace.go:171","msg":"trace[137700934] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:5053; }","duration":"173.300851ms","start":"2026-08-22T03:01:00.541852Z","end":"2026-08-22T03:01:00.715152Z","steps":["trace[137700934] 'agreement among raft nodes before linearized reading' (duration: 173.24457ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:01:00.715308Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"341.310097ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-823b980f-e345-42a2-849d-804fc7ee8300\" ","response":"range_response_count:1 size:3600"} {"level":"info","ts":"2026-08-22T03:01:00.7154Z","caller":"traceutil/trace.go:171","msg":"trace[1672202149] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-823b980f-e345-42a2-849d-804fc7ee8300; range_end:; response_count:1; response_revision:5053; }","duration":"341.4374ms","start":"2026-08-22T03:01:00.373939Z","end":"2026-08-22T03:01:00.715377Z","steps":["trace[1672202149] 'agreement among raft nodes before linearized reading' (duration: 341.144714ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:01:00.71549Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:01:00.373924Z","time spent":"341.553373ms","remote":"127.0.0.1:35594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3623,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-823b980f-e345-42a2-849d-804fc7ee8300\" "} {"level":"info","ts":"2026-08-22T03:01:12.600501Z","caller":"traceutil/trace.go:171","msg":"trace[1448192335] transaction","detail":"{read_only:false; response_revision:5283; number_of_response:1; }","duration":"156.559095ms","start":"2026-08-22T03:01:12.443907Z","end":"2026-08-22T03:01:12.600466Z","steps":["trace[1448192335] 'process raft request' (duration: 91.241744ms)","trace[1448192335] 'compare' (duration: 64.540151ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T03:01:13.048009Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"183.723698ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/keepalived-jzw7t\" ","response":"range_response_count:1 size:6520"} {"level":"info","ts":"2026-08-22T03:01:13.048097Z","caller":"traceutil/trace.go:171","msg":"trace[721017409] range","detail":"{range_begin:/registry/pods/openstack/keepalived-jzw7t; range_end:; response_count:1; response_revision:5290; }","duration":"183.8219ms","start":"2026-08-22T03:01:12.864254Z","end":"2026-08-22T03:01:13.048076Z","steps":["trace[721017409] 'range keys from in-memory index tree' (duration: 183.499113ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:20.752806Z","caller":"traceutil/trace.go:171","msg":"trace[973787465] linearizableReadLoop","detail":"{readStateIndex:5663; appliedIndex:5662; }","duration":"140.74761ms","start":"2026-08-22T03:01:20.612039Z","end":"2026-08-22T03:01:20.752787Z","steps":["trace[973787465] 'read index received' (duration: 140.551925ms)","trace[973787465] 'applied index is now lower than readState.Index' (duration: 194.665µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:01:20.752852Z","caller":"traceutil/trace.go:171","msg":"trace[1937789674] transaction","detail":"{read_only:false; response_revision:5459; number_of_response:1; }","duration":"160.400976ms","start":"2026-08-22T03:01:20.59242Z","end":"2026-08-22T03:01:20.752821Z","steps":["trace[1937789674] 'process raft request' (duration: 160.230242ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:01:20.753141Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"141.071377ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/monitoring/storage-loki-0\" ","response":"range_response_count:1 size:1781"} {"level":"info","ts":"2026-08-22T03:01:20.753242Z","caller":"traceutil/trace.go:171","msg":"trace[2005679381] range","detail":"{range_begin:/registry/persistentvolumeclaims/monitoring/storage-loki-0; range_end:; response_count:1; response_revision:5459; }","duration":"141.228431ms","start":"2026-08-22T03:01:20.611997Z","end":"2026-08-22T03:01:20.753225Z","steps":["trace[2005679381] 'agreement among raft nodes before linearized reading' (duration: 140.904104ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:20.994681Z","caller":"traceutil/trace.go:171","msg":"trace[1036188510] linearizableReadLoop","detail":"{readStateIndex:5664; appliedIndex:5663; }","duration":"133.655862ms","start":"2026-08-22T03:01:20.861004Z","end":"2026-08-22T03:01:20.99466Z","steps":["trace[1036188510] 'read index received' (duration: 122.357194ms)","trace[1036188510] 'applied index is now lower than readState.Index' (duration: 11.297988ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T03:01:20.994868Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"133.851216ms","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-08-22T03:01:20.994898Z","caller":"traceutil/trace.go:171","msg":"trace[1772363436] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:5460; }","duration":"133.926968ms","start":"2026-08-22T03:01:20.860963Z","end":"2026-08-22T03:01:20.99489Z","steps":["trace[1772363436] 'agreement among raft nodes before linearized reading' (duration: 133.786805ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:20.994868Z","caller":"traceutil/trace.go:171","msg":"trace[1192491656] transaction","detail":"{read_only:false; response_revision:5460; number_of_response:1; }","duration":"228.186783ms","start":"2026-08-22T03:01:20.766647Z","end":"2026-08-22T03:01:20.994834Z","steps":["trace[1192491656] 'process raft request' (duration: 216.69806ms)","trace[1192491656] 'compare' (duration: 11.217116ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:01:21.107227Z","caller":"traceutil/trace.go:171","msg":"trace[1000763751] transaction","detail":"{read_only:false; response_revision:5462; number_of_response:1; }","duration":"106.208149ms","start":"2026-08-22T03:01:21.000987Z","end":"2026-08-22T03:01:21.107195Z","steps":["trace[1000763751] 'process raft request' (duration: 100.821682ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:21.107452Z","caller":"traceutil/trace.go:171","msg":"trace[546337270] transaction","detail":"{read_only:false; response_revision:5463; number_of_response:1; }","duration":"106.440395ms","start":"2026-08-22T03:01:21.000987Z","end":"2026-08-22T03:01:21.107428Z","steps":["trace[546337270] 'process raft request' (duration: 106.123688ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:21.107892Z","caller":"traceutil/trace.go:171","msg":"trace[1637937923] transaction","detail":"{read_only:false; response_revision:5464; number_of_response:1; }","duration":"106.845705ms","start":"2026-08-22T03:01:21.001029Z","end":"2026-08-22T03:01:21.107874Z","steps":["trace[1637937923] 'process raft request' (duration: 106.321943ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:21.107917Z","caller":"traceutil/trace.go:171","msg":"trace[155815133] transaction","detail":"{read_only:false; response_revision:5465; number_of_response:1; }","duration":"105.862401ms","start":"2026-08-22T03:01:21.00203Z","end":"2026-08-22T03:01:21.107893Z","steps":["trace[155815133] 'process raft request' (duration: 105.704247ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:21.10818Z","caller":"traceutil/trace.go:171","msg":"trace[321084365] transaction","detail":"{read_only:false; response_revision:5466; number_of_response:1; }","duration":"106.025966ms","start":"2026-08-22T03:01:21.002141Z","end":"2026-08-22T03:01:21.108167Z","steps":["trace[321084365] 'process raft request' (duration: 105.700148ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:21.108314Z","caller":"traceutil/trace.go:171","msg":"trace[726565131] transaction","detail":"{read_only:false; response_revision:5467; number_of_response:1; }","duration":"106.20195ms","start":"2026-08-22T03:01:21.002098Z","end":"2026-08-22T03:01:21.1083Z","steps":["trace[726565131] 'process raft request' (duration: 106.022176ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:22.795207Z","caller":"traceutil/trace.go:171","msg":"trace[876298771] transaction","detail":"{read_only:false; response_revision:5491; number_of_response:1; }","duration":"134.820549ms","start":"2026-08-22T03:01:22.660356Z","end":"2026-08-22T03:01:22.795177Z","steps":["trace[876298771] 'process raft request' (duration: 130.559377ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:01:22.795338Z","caller":"traceutil/trace.go:171","msg":"trace[1919017453] transaction","detail":"{read_only:false; response_revision:5492; number_of_response:1; }","duration":"134.379378ms","start":"2026-08-22T03:01:22.660912Z","end":"2026-08-22T03:01:22.795291Z","steps":["trace[1919017453] 'process raft request' (duration: 134.154793ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:02:22.130617Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":2964} {"level":"info","ts":"2026-08-22T03:02:22.206612Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":2964,"took":"74.500503ms","hash":3437143649,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":33738752,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T03:02:22.206704Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3437143649,"revision":2964,"compact-revision":-1} {"level":"info","ts":"2026-08-22T03:07:22.138055Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":6038} {"level":"info","ts":"2026-08-22T03:07:22.235077Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":6038,"took":"94.954182ms","hash":796874818,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":21876736,"current-db-size-in-use":"22 MB"} {"level":"info","ts":"2026-08-22T03:07:22.235172Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":796874818,"revision":6038,"compact-revision":2964} {"level":"info","ts":"2026-08-22T03:07:41.016094Z","caller":"traceutil/trace.go:171","msg":"trace[77638482] transaction","detail":"{read_only:false; response_revision:8359; number_of_response:1; }","duration":"193.146121ms","start":"2026-08-22T03:07:40.822921Z","end":"2026-08-22T03:07:41.016067Z","steps":["trace[77638482] 'process raft request' (duration: 193.002797ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:07:41.016136Z","caller":"traceutil/trace.go:171","msg":"trace[1091919629] linearizableReadLoop","detail":"{readStateIndex:8654; appliedIndex:8654; }","duration":"172.403853ms","start":"2026-08-22T03:07:40.843693Z","end":"2026-08-22T03:07:41.016097Z","steps":["trace[1091919629] 'read index received' (duration: 172.382082ms)","trace[1091919629] 'applied index is now lower than readState.Index' (duration: 13.58µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T03:07:41.016406Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"172.665478ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb\" ","response":"range_response_count:1 size:5651"} {"level":"info","ts":"2026-08-22T03:07:41.016445Z","caller":"traceutil/trace.go:171","msg":"trace[614659668] range","detail":"{range_begin:/registry/pxc.percona.com/perconaxtradbclusters/openstack/percona-xtradb; range_end:; response_count:1; response_revision:8359; }","duration":"172.759711ms","start":"2026-08-22T03:07:40.843675Z","end":"2026-08-22T03:07:41.016435Z","steps":["trace[614659668] 'agreement among raft nodes before linearized reading' (duration: 172.567046ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:07:41.210728Z","caller":"traceutil/trace.go:171","msg":"trace[1893988632] linearizableReadLoop","detail":"{readStateIndex:8655; appliedIndex:8654; }","duration":"194.483634ms","start":"2026-08-22T03:07:41.016212Z","end":"2026-08-22T03:07:41.210696Z","steps":["trace[1893988632] 'read index received' (duration: 194.249618ms)","trace[1893988632] 'applied index is now lower than readState.Index' (duration: 232.716µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:07:41.210836Z","caller":"traceutil/trace.go:171","msg":"trace[393769225] transaction","detail":"{read_only:false; response_revision:8360; number_of_response:1; }","duration":"332.660434ms","start":"2026-08-22T03:07:40.878127Z","end":"2026-08-22T03:07:41.210787Z","steps":["trace[393769225] 'process raft request' (duration: 332.420008ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:07:41.210967Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"234.953536ms","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-08-22T03:07:41.211013Z","caller":"traceutil/trace.go:171","msg":"trace[1712026330] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:8360; }","duration":"235.061988ms","start":"2026-08-22T03:07:40.97594Z","end":"2026-08-22T03:07:41.211002Z","steps":["trace[1712026330] 'agreement among raft nodes before linearized reading' (duration: 234.904094ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:07:41.211063Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:07:40.878107Z","time spent":"332.846228ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":509,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T03:07:41.211987Z","caller":"traceutil/trace.go:171","msg":"trace[943778633] transaction","detail":"{read_only:false; response_revision:8361; number_of_response:1; }","duration":"154.858101ms","start":"2026-08-22T03:07:41.057109Z","end":"2026-08-22T03:07:41.211968Z","steps":["trace[943778633] 'process raft request' (duration: 154.720288ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:07:41.212221Z","caller":"traceutil/trace.go:171","msg":"trace[457441261] transaction","detail":"{read_only:false; response_revision:8362; number_of_response:1; }","duration":"154.383839ms","start":"2026-08-22T03:07:41.057807Z","end":"2026-08-22T03:07:41.212191Z","steps":["trace[457441261] 'process raft request' (duration: 154.132593ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:07:52.452041Z","caller":"traceutil/trace.go:171","msg":"trace[121845271] linearizableReadLoop","detail":"{readStateIndex:8717; appliedIndex:8716; }","duration":"114.840809ms","start":"2026-08-22T03:07:52.337176Z","end":"2026-08-22T03:07:52.452017Z","steps":["trace[121845271] 'read index received' (duration: 114.597572ms)","trace[121845271] 'applied index is now lower than readState.Index' (duration: 242.097µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:07:52.452119Z","caller":"traceutil/trace.go:171","msg":"trace[434365377] transaction","detail":"{read_only:false; response_revision:8420; number_of_response:1; }","duration":"167.874673ms","start":"2026-08-22T03:07:52.284194Z","end":"2026-08-22T03:07:52.452069Z","steps":["trace[434365377] 'process raft request' (duration: 167.625406ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:07:52.45228Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.089546ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-22T03:07:52.45231Z","caller":"traceutil/trace.go:171","msg":"trace[1000051818] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8420; }","duration":"115.193848ms","start":"2026-08-22T03:07:52.337108Z","end":"2026-08-22T03:07:52.452302Z","steps":["trace[1000051818] 'agreement among raft nodes before linearized reading' (duration: 115.012864ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:07:53.628194Z","caller":"traceutil/trace.go:171","msg":"trace[509902342] transaction","detail":"{read_only:false; response_revision:8426; number_of_response:1; }","duration":"185.269621ms","start":"2026-08-22T03:07:53.442895Z","end":"2026-08-22T03:07:53.628164Z","steps":["trace[509902342] 'process raft request' (duration: 185.103617ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:08:22.9388Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"120.896125ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:435"} {"level":"info","ts":"2026-08-22T03:08:22.938907Z","caller":"traceutil/trace.go:171","msg":"trace[1395499110] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:8637; }","duration":"121.063469ms","start":"2026-08-22T03:08:22.81782Z","end":"2026-08-22T03:08:22.938883Z","steps":["trace[1395499110] 'range keys from in-memory index tree' (duration: 120.648119ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:08:34.388778Z","caller":"traceutil/trace.go:171","msg":"trace[1090092197] transaction","detail":"{read_only:false; response_revision:8700; number_of_response:1; }","duration":"200.974199ms","start":"2026-08-22T03:08:34.187771Z","end":"2026-08-22T03:08:34.388745Z","steps":["trace[1090092197] 'process raft request' (duration: 200.747204ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:08:35.33951Z","caller":"traceutil/trace.go:171","msg":"trace[144680987] transaction","detail":"{read_only:false; response_revision:8703; number_of_response:1; }","duration":"122.377191ms","start":"2026-08-22T03:08:35.217106Z","end":"2026-08-22T03:08:35.339483Z","steps":["trace[144680987] 'process raft request' (duration: 95.33804ms)","trace[144680987] 'compare' (duration: 26.921108ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:08:35.515715Z","caller":"traceutil/trace.go:171","msg":"trace[1836820716] transaction","detail":"{read_only:false; response_revision:8704; number_of_response:1; }","duration":"123.936757ms","start":"2026-08-22T03:08:35.391751Z","end":"2026-08-22T03:08:35.515687Z","steps":["trace[1836820716] 'process raft request' (duration: 115.802652ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:08:39.614666Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000001-0000000000002364.wal"} {"level":"info","ts":"2026-08-22T03:10:15.281834Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"59b38ffafb07452b","local-member-applied-index":10001,"local-member-snapshot-index":0,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T03:10:15.287661Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":10001} {"level":"info","ts":"2026-08-22T03:10:15.287783Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":5001} {"level":"info","ts":"2026-08-22T03:12:22.143578Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":8092} {"level":"info","ts":"2026-08-22T03:12:22.203459Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":8092,"took":"57.485043ms","hash":3378968961,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":27877376,"current-db-size-in-use":"28 MB"} {"level":"info","ts":"2026-08-22T03:12:22.20351Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3378968961,"revision":8092,"compact-revision":6038} {"level":"info","ts":"2026-08-22T03:14:15.787522Z","caller":"traceutil/trace.go:171","msg":"trace[1950704724] transaction","detail":"{read_only:false; response_revision:11185; number_of_response:1; }","duration":"116.726907ms","start":"2026-08-22T03:14:15.670738Z","end":"2026-08-22T03:14:15.787465Z","steps":["trace[1950704724] 'process raft request' (duration: 116.380639ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:15:39.135111Z","caller":"traceutil/trace.go:171","msg":"trace[1149558456] transaction","detail":"{read_only:false; response_revision:11968; number_of_response:1; }","duration":"117.526321ms","start":"2026-08-22T03:15:39.017544Z","end":"2026-08-22T03:15:39.13507Z","steps":["trace[1149558456] 'process raft request' (duration: 98.181676ms)","trace[1149558456] 'compare' (duration: 19.089239ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:15:39.468474Z","caller":"traceutil/trace.go:171","msg":"trace[679125849] transaction","detail":"{read_only:false; response_revision:11971; number_of_response:1; }","duration":"229.616911ms","start":"2026-08-22T03:15:39.238829Z","end":"2026-08-22T03:15:39.468445Z","steps":["trace[679125849] 'process raft request' (duration: 229.539959ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:15:39.468557Z","caller":"traceutil/trace.go:171","msg":"trace[19036496] transaction","detail":"{read_only:false; response_revision:11970; number_of_response:1; }","duration":"229.686742ms","start":"2026-08-22T03:15:39.238833Z","end":"2026-08-22T03:15:39.468519Z","steps":["trace[19036496] 'process raft request' (duration: 229.329363ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:15:39.479455Z","caller":"traceutil/trace.go:171","msg":"trace[1189426921] transaction","detail":"{read_only:false; response_revision:11972; number_of_response:1; }","duration":"131.492735ms","start":"2026-08-22T03:15:39.347926Z","end":"2026-08-22T03:15:39.479419Z","steps":["trace[1189426921] 'process raft request' (duration: 131.349192ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:15:39.627887Z","caller":"traceutil/trace.go:171","msg":"trace[1747121992] transaction","detail":"{read_only:false; response_revision:11975; number_of_response:1; }","duration":"112.785406ms","start":"2026-08-22T03:15:39.515059Z","end":"2026-08-22T03:15:39.627844Z","steps":["trace[1747121992] 'process raft request' (duration: 103.434912ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:17:22.149781Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":10489} {"level":"info","ts":"2026-08-22T03:17:22.231825Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":10489,"took":"79.62429ms","hash":3651587572,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":25952256,"current-db-size-in-use":"26 MB"} {"level":"info","ts":"2026-08-22T03:17:22.231906Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":3651587572,"revision":10489,"compact-revision":8092} {"level":"info","ts":"2026-08-22T03:22:22.155619Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":12655} {"level":"info","ts":"2026-08-22T03:22:22.231685Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":12655,"took":"74.035439ms","hash":2858942475,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":27209728,"current-db-size-in-use":"27 MB"} {"level":"info","ts":"2026-08-22T03:22:22.23174Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2858942475,"revision":12655,"compact-revision":10489} {"level":"warn","ts":"2026-08-22T03:22:27.314922Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"206.901198ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:16"} {"level":"info","ts":"2026-08-22T03:22:27.315129Z","caller":"traceutil/trace.go:171","msg":"trace[1855879297] transaction","detail":"{read_only:false; response_revision:14683; number_of_response:1; }","duration":"349.06674ms","start":"2026-08-22T03:22:26.966034Z","end":"2026-08-22T03:22:27.315101Z","steps":["trace[1855879297] 'process raft request' (duration: 141.900236ms)","trace[1855879297] 'compare' (duration: 206.768695ms)"],"step_count":2} {"level":"warn","ts":"2026-08-22T03:22:27.315264Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:22:26.966003Z","time spent":"349.187154ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T03:22:27.315435Z","caller":"traceutil/trace.go:171","msg":"trace[1709896738] transaction","detail":"{read_only:false; response_revision:14684; number_of_response:1; }","duration":"345.762581ms","start":"2026-08-22T03:22:26.969648Z","end":"2026-08-22T03:22:27.31541Z","steps":["trace[1709896738] 'process raft request' (duration: 345.369651ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:22:27.315513Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:22:26.96962Z","time spent":"345.857523ms","remote":"127.0.0.1:35660","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-08-22T03:22:27.315635Z","caller":"traceutil/trace.go:171","msg":"trace[626236516] transaction","detail":"{read_only:false; response_revision:14685; number_of_response:1; }","duration":"341.614692ms","start":"2026-08-22T03:22:26.97399Z","end":"2026-08-22T03:22:27.315605Z","steps":["trace[626236516] 'process raft request' (duration: 341.137461ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:22:27.315773Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:22:26.973977Z","time spent":"341.723955ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":39,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T03:22:36.791181Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"314.489602ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5c4a8e0-28c2-4fff-8c86-dc478aca59f9\" ","response":"range_response_count:1 size:3606"} {"level":"info","ts":"2026-08-22T03:22:36.791333Z","caller":"traceutil/trace.go:171","msg":"trace[409326911] range","detail":"{range_begin:/registry/pods/local-path-storage/helper-pod-create-pvc-f5c4a8e0-28c2-4fff-8c86-dc478aca59f9; range_end:; response_count:1; response_revision:14849; }","duration":"314.727707ms","start":"2026-08-22T03:22:36.476576Z","end":"2026-08-22T03:22:36.791303Z","steps":["trace[409326911] 'range keys from in-memory index tree' (duration: 314.236165ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:22:36.791403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:22:36.476553Z","time spent":"314.832139ms","remote":"127.0.0.1:35594","response type":"/etcdserverpb.KV/Range","request count":0,"request size":94,"response count":1,"response size":3629,"request content":"key:\"/registry/pods/local-path-storage/helper-pod-create-pvc-f5c4a8e0-28c2-4fff-8c86-dc478aca59f9\" "} {"level":"info","ts":"2026-08-22T03:22:36.875989Z","caller":"traceutil/trace.go:171","msg":"trace[1032163135] linearizableReadLoop","detail":"{readStateIndex:15360; appliedIndex:15359; }","duration":"170.533985ms","start":"2026-08-22T03:22:36.705428Z","end":"2026-08-22T03:22:36.875962Z","steps":["trace[1032163135] 'read index received' (duration: 170.438193ms)","trace[1032163135] 'applied index is now lower than readState.Index' (duration: 94.352µs)"],"step_count":2} {"level":"warn","ts":"2026-08-22T03:22:36.876254Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"170.798581ms","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-08-22T03:22:36.876368Z","caller":"traceutil/trace.go:171","msg":"trace[1287197882] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:14850; }","duration":"170.950895ms","start":"2026-08-22T03:22:36.705385Z","end":"2026-08-22T03:22:36.876335Z","steps":["trace[1287197882] 'agreement among raft nodes before linearized reading' (duration: 170.679558ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:22:36.876628Z","caller":"traceutil/trace.go:171","msg":"trace[9233226] transaction","detail":"{read_only:false; response_revision:14850; number_of_response:1; }","duration":"194.901369ms","start":"2026-08-22T03:22:36.681122Z","end":"2026-08-22T03:22:36.876024Z","steps":["trace[9233226] 'process raft request' (duration: 194.669784ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:24:17.977424Z","caller":"traceutil/trace.go:171","msg":"trace[813309863] linearizableReadLoop","detail":"{readStateIndex:16492; appliedIndex:16489; }","duration":"210.584079ms","start":"2026-08-22T03:24:17.766813Z","end":"2026-08-22T03:24:17.977397Z","steps":["trace[813309863] 'read index received' (duration: 37.05983ms)","trace[813309863] 'applied index is now lower than readState.Index' (duration: 173.523199ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:24:17.977515Z","caller":"traceutil/trace.go:171","msg":"trace[417330316] transaction","detail":"{read_only:false; response_revision:15949; number_of_response:1; }","duration":"252.086267ms","start":"2026-08-22T03:24:17.725392Z","end":"2026-08-22T03:24:17.977478Z","steps":["trace[417330316] 'process raft request' (duration: 251.953254ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:24:17.977494Z","caller":"traceutil/trace.go:171","msg":"trace[1232293511] transaction","detail":"{read_only:false; response_revision:15948; number_of_response:1; }","duration":"257.369074ms","start":"2026-08-22T03:24:17.720073Z","end":"2026-08-22T03:24:17.977442Z","steps":["trace[1232293511] 'process raft request' (duration: 257.100138ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:24:17.977759Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.920567ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/nova-api\" ","response":"range_response_count:1 size:667"} {"level":"info","ts":"2026-08-22T03:24:17.977818Z","caller":"traceutil/trace.go:171","msg":"trace[316433915] range","detail":"{range_begin:/registry/services/endpoints/openstack/nova-api; range_end:; response_count:1; response_revision:15949; }","duration":"211.029209ms","start":"2026-08-22T03:24:17.766774Z","end":"2026-08-22T03:24:17.977803Z","steps":["trace[316433915] 'agreement among raft nodes before linearized reading' (duration: 210.777934ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:24:17.977735Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.119248ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-rabbit-init\" ","response":"range_response_count:0 size:5"} {"level":"info","ts":"2026-08-22T03:24:17.97812Z","caller":"traceutil/trace.go:171","msg":"trace[982265566] range","detail":"{range_begin:/registry/jobs/openstack/nova-rabbit-init; range_end:; response_count:0; response_revision:15949; }","duration":"210.533618ms","start":"2026-08-22T03:24:17.767559Z","end":"2026-08-22T03:24:17.978093Z","steps":["trace[982265566] 'agreement among raft nodes before linearized reading' (duration: 210.060947ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:24:17.978203Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"210.033027ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/nova-db-sync\" ","response":"range_response_count:1 size:5521"} {"level":"info","ts":"2026-08-22T03:24:17.978299Z","caller":"traceutil/trace.go:171","msg":"trace[100463582] range","detail":"{range_begin:/registry/jobs/openstack/nova-db-sync; range_end:; response_count:1; response_revision:15949; }","duration":"210.130478ms","start":"2026-08-22T03:24:17.768135Z","end":"2026-08-22T03:24:17.978265Z","steps":["trace[100463582] 'agreement among raft nodes before linearized reading' (duration: 209.957444ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:27:22.174426Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":14643} {"level":"info","ts":"2026-08-22T03:27:22.27767Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":14643,"took":"99.563731ms","hash":1036031517,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":33996800,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T03:27:22.277754Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1036031517,"revision":14643,"compact-revision":12655} {"level":"warn","ts":"2026-08-22T03:29:59.365767Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"137.69839ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/nova-cell-setup-28nz4\" ","response":"range_response_count:1 size:9788"} {"level":"info","ts":"2026-08-22T03:29:59.365867Z","caller":"traceutil/trace.go:171","msg":"trace[799010436] range","detail":"{range_begin:/registry/pods/openstack/nova-cell-setup-28nz4; range_end:; response_count:1; response_revision:18447; }","duration":"137.842064ms","start":"2026-08-22T03:29:59.228005Z","end":"2026-08-22T03:29:59.365847Z","steps":["trace[799010436] 'range keys from in-memory index tree' (duration: 137.548657ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:29:59.365923Z","caller":"traceutil/trace.go:171","msg":"trace[759827414] transaction","detail":"{read_only:false; response_revision:18448; number_of_response:1; }","duration":"124.294129ms","start":"2026-08-22T03:29:59.241593Z","end":"2026-08-22T03:29:59.365887Z","steps":["trace[759827414] 'process raft request' (duration: 61.326064ms)","trace[759827414] 'compare' (duration: 62.623366ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:29:59.371914Z","caller":"traceutil/trace.go:171","msg":"trace[1216059038] transaction","detail":"{read_only:false; response_revision:18449; number_of_response:1; }","duration":"122.938856ms","start":"2026-08-22T03:29:59.248951Z","end":"2026-08-22T03:29:59.37189Z","steps":["trace[1216059038] 'process raft request' (duration: 122.770672ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:29:59.792227Z","caller":"traceutil/trace.go:171","msg":"trace[444180474] linearizableReadLoop","detail":"{readStateIndex:19077; appliedIndex:19076; }","duration":"204.338943ms","start":"2026-08-22T03:29:59.587862Z","end":"2026-08-22T03:29:59.792201Z","steps":["trace[444180474] 'read index received' (duration: 204.099468ms)","trace[444180474] 'applied index is now lower than readState.Index' (duration: 238.465µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:29:59.792539Z","caller":"traceutil/trace.go:171","msg":"trace[875577123] transaction","detail":"{read_only:false; response_revision:18450; number_of_response:1; }","duration":"210.758167ms","start":"2026-08-22T03:29:59.581734Z","end":"2026-08-22T03:29:59.792492Z","steps":["trace[875577123] 'process raft request' (duration: 210.292306ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:29:59.792883Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"205.002939ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/neutron-server-77d75d57b7-kc9mw\" ","response":"range_response_count:1 size:13180"} {"level":"info","ts":"2026-08-22T03:29:59.792926Z","caller":"traceutil/trace.go:171","msg":"trace[269724319] range","detail":"{range_begin:/registry/pods/openstack/neutron-server-77d75d57b7-kc9mw; range_end:; response_count:1; response_revision:18450; }","duration":"205.117141ms","start":"2026-08-22T03:29:59.587799Z","end":"2026-08-22T03:29:59.792916Z","steps":["trace[269724319] 'agreement among raft nodes before linearized reading' (duration: 204.931067ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:29:59.914758Z","caller":"traceutil/trace.go:171","msg":"trace[2019560169] transaction","detail":"{read_only:false; response_revision:18451; number_of_response:1; }","duration":"109.635806ms","start":"2026-08-22T03:29:59.805088Z","end":"2026-08-22T03:29:59.914724Z","steps":["trace[2019560169] 'process raft request' (duration: 57.315008ms)","trace[2019560169] 'compare' (duration: 52.00518ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:30:00.215562Z","caller":"traceutil/trace.go:171","msg":"trace[580208528] linearizableReadLoop","detail":"{readStateIndex:19080; appliedIndex:19078; }","duration":"125.909667ms","start":"2026-08-22T03:30:00.089626Z","end":"2026-08-22T03:30:00.215536Z","steps":["trace[580208528] 'read index received' (duration: 69.426889ms)","trace[580208528] 'applied index is now lower than readState.Index' (duration: 56.481578ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:30:00.215591Z","caller":"traceutil/trace.go:171","msg":"trace[1959095959] transaction","detail":"{read_only:false; response_revision:18452; number_of_response:1; }","duration":"294.410189ms","start":"2026-08-22T03:29:59.921148Z","end":"2026-08-22T03:30:00.215558Z","steps":["trace[1959095959] 'process raft request' (duration: 237.847109ms)","trace[1959095959] 'compare' (duration: 56.317244ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:30:00.215619Z","caller":"traceutil/trace.go:171","msg":"trace[944856523] transaction","detail":"{read_only:false; response_revision:18453; number_of_response:1; }","duration":"294.329697ms","start":"2026-08-22T03:29:59.921253Z","end":"2026-08-22T03:30:00.215583Z","steps":["trace[944856523] 'process raft request' (duration: 294.201124ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:30:00.215789Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"126.150584ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/pods/openstack/libvirt-libvirt-default-dp5rs\" ","response":"range_response_count:1 size:20736"} {"level":"info","ts":"2026-08-22T03:30:00.215851Z","caller":"traceutil/trace.go:171","msg":"trace[640819097] range","detail":"{range_begin:/registry/pods/openstack/libvirt-libvirt-default-dp5rs; range_end:; response_count:1; response_revision:18453; }","duration":"126.266926ms","start":"2026-08-22T03:30:00.089567Z","end":"2026-08-22T03:30:00.215834Z","steps":["trace[640819097] 'agreement among raft nodes before linearized reading' (duration: 126.070942ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:30:00.53711Z","caller":"traceutil/trace.go:171","msg":"trace[605079098] linearizableReadLoop","detail":"{readStateIndex:19081; appliedIndex:19080; }","duration":"298.131199ms","start":"2026-08-22T03:30:00.23895Z","end":"2026-08-22T03:30:00.537081Z","steps":["trace[605079098] 'read index received' (duration: 297.993425ms)","trace[605079098] 'applied index is now lower than readState.Index' (duration: 136.224µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:30:00.537227Z","caller":"traceutil/trace.go:171","msg":"trace[1026480552] transaction","detail":"{read_only:false; response_revision:18454; number_of_response:1; }","duration":"299.956842ms","start":"2026-08-22T03:30:00.237233Z","end":"2026-08-22T03:30:00.53719Z","steps":["trace[1026480552] 'process raft request' (duration: 299.621473ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:30:00.537383Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"298.400765ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"warn","ts":"2026-08-22T03:30:00.537403Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:30:00.237206Z","time spent":"300.107695ms","remote":"127.0.0.1:35594","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":20853,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T03:30:00.537432Z","caller":"traceutil/trace.go:171","msg":"trace[946293928] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18454; }","duration":"298.516268ms","start":"2026-08-22T03:30:00.238906Z","end":"2026-08-22T03:30:00.537422Z","steps":["trace[946293928] 'agreement among raft nodes before linearized reading' (duration: 298.320153ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:30:00.622062Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"381.204726ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/neutron-server\" ","response":"range_response_count:1 size:702"} {"level":"info","ts":"2026-08-22T03:30:00.622154Z","caller":"traceutil/trace.go:171","msg":"trace[1160521012] range","detail":"{range_begin:/registry/services/endpoints/openstack/neutron-server; range_end:; response_count:1; response_revision:18454; }","duration":"381.368949ms","start":"2026-08-22T03:30:00.240765Z","end":"2026-08-22T03:30:00.622134Z","steps":["trace[1160521012] 'agreement among raft nodes before linearized reading' (duration: 381.093323ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:30:00.622194Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:30:00.24074Z","time spent":"381.447312ms","remote":"127.0.0.1:35572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":55,"response count":1,"response size":725,"request content":"key:\"/registry/services/endpoints/openstack/neutron-server\" "} {"level":"warn","ts":"2026-08-22T03:30:00.622156Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"173.38936ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cilium.io/ciliuml2announcementpolicies/\" range_end:\"/registry/cilium.io/ciliuml2announcementpolicies0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T03:30:00.622264Z","caller":"traceutil/trace.go:171","msg":"trace[2051638181] range","detail":"{range_begin:/registry/cilium.io/ciliuml2announcementpolicies/; range_end:/registry/cilium.io/ciliuml2announcementpolicies0; response_count:0; response_revision:18454; }","duration":"173.525173ms","start":"2026-08-22T03:30:00.44871Z","end":"2026-08-22T03:30:00.622235Z","steps":["trace[2051638181] 'agreement among raft nodes before linearized reading' (duration: 173.302988ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:30:00.622267Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"337.188867ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"info","ts":"2026-08-22T03:30:00.622357Z","caller":"traceutil/trace.go:171","msg":"trace[1117135578] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:18454; }","duration":"337.344871ms","start":"2026-08-22T03:30:00.284989Z","end":"2026-08-22T03:30:00.622334Z","steps":["trace[1117135578] 'agreement among raft nodes before linearized reading' (duration: 337.046124ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:30:00.622408Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:30:00.28496Z","time spent":"337.437893ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"info","ts":"2026-08-22T03:30:00.73724Z","caller":"traceutil/trace.go:171","msg":"trace[1253490814] transaction","detail":"{read_only:false; response_revision:18455; number_of_response:1; }","duration":"112.427314ms","start":"2026-08-22T03:30:00.624787Z","end":"2026-08-22T03:30:00.737214Z","steps":["trace[1253490814] 'process raft request' (duration: 112.239659ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:30:00.753196Z","caller":"traceutil/trace.go:171","msg":"trace[1756684724] transaction","detail":"{read_only:false; response_revision:18456; number_of_response:1; }","duration":"124.951945ms","start":"2026-08-22T03:30:00.628212Z","end":"2026-08-22T03:30:00.753164Z","steps":["trace[1756684724] 'process raft request' (duration: 124.768571ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:30:00.753248Z","caller":"traceutil/trace.go:171","msg":"trace[143585009] transaction","detail":"{read_only:false; response_revision:18457; number_of_response:1; }","duration":"123.707224ms","start":"2026-08-22T03:30:00.629491Z","end":"2026-08-22T03:30:00.753199Z","steps":["trace[143585009] 'process raft request' (duration: 123.616612ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:31:19.521967Z","caller":"etcdserver/server.go:1401","msg":"triggering snapshot","local-member-id":"59b38ffafb07452b","local-member-applied-index":20002,"local-member-snapshot-index":10001,"local-member-snapshot-count":10000} {"level":"info","ts":"2026-08-22T03:31:19.52684Z","caller":"etcdserver/server.go:2420","msg":"saved snapshot","snapshot-index":20002} {"level":"info","ts":"2026-08-22T03:31:19.526975Z","caller":"etcdserver/server.go:2450","msg":"compacted Raft logs","compact-index":15002} {"level":"info","ts":"2026-08-22T03:32:22.181762Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":17394} {"level":"info","ts":"2026-08-22T03:32:22.27474Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":17394,"took":"89.84503ms","hash":2345830192,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":34488320,"current-db-size-in-use":"34 MB"} {"level":"info","ts":"2026-08-22T03:32:22.274815Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2345830192,"revision":17394,"compact-revision":14643} {"level":"info","ts":"2026-08-22T03:36:01.954846Z","caller":"traceutil/trace.go:171","msg":"trace[321398585] linearizableReadLoop","detail":"{readStateIndex:21966; appliedIndex:21965; }","duration":"213.163906ms","start":"2026-08-22T03:36:01.741641Z","end":"2026-08-22T03:36:01.954805Z","steps":["trace[321398585] 'read index received' (duration: 212.402108ms)","trace[321398585] 'applied index is now lower than readState.Index' (duration: 760.928µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:36:01.954935Z","caller":"traceutil/trace.go:171","msg":"trace[1160670966] transaction","detail":"{read_only:false; response_revision:21248; number_of_response:1; }","duration":"226.090767ms","start":"2026-08-22T03:36:01.728801Z","end":"2026-08-22T03:36:01.954892Z","steps":["trace[1160670966] 'process raft request' (duration: 225.561574ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:36:01.955081Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"198.018812ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/gateway.networking.k8s.io/gatewayclasses/\" range_end:\"/registry/gateway.networking.k8s.io/gatewayclasses0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-22T03:36:01.956282Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"214.60596ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/health\" ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T03:36:01.956445Z","caller":"traceutil/trace.go:171","msg":"trace[887331593] range","detail":"{range_begin:/registry/health; range_end:; response_count:0; response_revision:21248; }","duration":"214.797514ms","start":"2026-08-22T03:36:01.741594Z","end":"2026-08-22T03:36:01.956391Z","steps":["trace[887331593] 'agreement among raft nodes before linearized reading' (duration: 213.383221ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:36:01.956315Z","caller":"traceutil/trace.go:171","msg":"trace[1589898641] range","detail":"{range_begin:/registry/gateway.networking.k8s.io/gatewayclasses/; range_end:/registry/gateway.networking.k8s.io/gatewayclasses0; response_count:0; response_revision:21248; }","duration":"198.153235ms","start":"2026-08-22T03:36:01.75697Z","end":"2026-08-22T03:36:01.955123Z","steps":["trace[1589898641] 'agreement among raft nodes before linearized reading' (duration: 198.010722ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:36:18.349104Z","caller":"traceutil/trace.go:171","msg":"trace[369708744] linearizableReadLoop","detail":"{readStateIndex:22053; appliedIndex:22052; }","duration":"171.214476ms","start":"2026-08-22T03:36:18.177847Z","end":"2026-08-22T03:36:18.349061Z","steps":["trace[369708744] 'read index received' (duration: 170.806276ms)","trace[369708744] 'applied index is now lower than readState.Index' (duration: 406.34µs)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:36:18.349237Z","caller":"traceutil/trace.go:171","msg":"trace[1318089003] transaction","detail":"{read_only:false; response_revision:21332; number_of_response:1; }","duration":"216.597298ms","start":"2026-08-22T03:36:18.132569Z","end":"2026-08-22T03:36:18.349166Z","steps":["trace[1318089003] 'process raft request' (duration: 216.112886ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:36:18.349365Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"171.494434ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:436"} {"level":"info","ts":"2026-08-22T03:36:18.349618Z","caller":"traceutil/trace.go:171","msg":"trace[777036048] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:21332; }","duration":"171.78954ms","start":"2026-08-22T03:36:18.17781Z","end":"2026-08-22T03:36:18.3496Z","steps":["trace[777036048] 'agreement among raft nodes before linearized reading' (duration: 171.413671ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:36:18.349625Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"129.891322ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:493"} {"level":"info","ts":"2026-08-22T03:36:18.349723Z","caller":"traceutil/trace.go:171","msg":"trace[1026020098] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:21332; }","duration":"129.971225ms","start":"2026-08-22T03:36:18.2197Z","end":"2026-08-22T03:36:18.349672Z","steps":["trace[1026020098] 'agreement among raft nodes before linearized reading' (duration: 129.75976ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:36:18.349398Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"158.549532ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/secretgen.k14s.io/rsakeys/\" range_end:\"/registry/secretgen.k14s.io/rsakeys0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T03:36:18.349938Z","caller":"traceutil/trace.go:171","msg":"trace[5229052] range","detail":"{range_begin:/registry/secretgen.k14s.io/rsakeys/; range_end:/registry/secretgen.k14s.io/rsakeys0; response_count:0; response_revision:21332; }","duration":"159.138625ms","start":"2026-08-22T03:36:18.190779Z","end":"2026-08-22T03:36:18.349917Z","steps":["trace[5229052] 'agreement among raft nodes before linearized reading' (duration: 158.516111ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:36:18.672149Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"285.008942ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-22T03:36:18.67253Z","caller":"traceutil/trace.go:171","msg":"trace[10938526] transaction","detail":"{read_only:false; response_revision:21335; number_of_response:1; }","duration":"111.645595ms","start":"2026-08-22T03:36:18.560859Z","end":"2026-08-22T03:36:18.672504Z","steps":["trace[10938526] 'process raft request' (duration: 111.582683ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:36:18.672638Z","caller":"traceutil/trace.go:171","msg":"trace[1158007851] transaction","detail":"{read_only:false; response_revision:21333; number_of_response:1; }","duration":"317.562186ms","start":"2026-08-22T03:36:18.355033Z","end":"2026-08-22T03:36:18.672595Z","steps":["trace[1158007851] 'process raft request' (duration: 31.933448ms)","trace[1158007851] 'compare' (duration: 284.357397ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:36:18.672655Z","caller":"traceutil/trace.go:171","msg":"trace[355958353] transaction","detail":"{read_only:false; response_revision:21334; number_of_response:1; }","duration":"317.251199ms","start":"2026-08-22T03:36:18.355361Z","end":"2026-08-22T03:36:18.672613Z","steps":["trace[355958353] 'process raft request' (duration: 316.983853ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:36:18.672818Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:36:18.355352Z","time spent":"317.379082ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":418,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T03:36:18.672825Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:36:18.355014Z","time spent":"317.70781ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":475,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T03:36:18.91666Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"115.496118ms","expected-duration":"100ms","prefix":"","request":"header: txn: success:> failure: >>","response":"size:18"} {"level":"info","ts":"2026-08-22T03:36:18.916809Z","caller":"traceutil/trace.go:171","msg":"trace[1781036768] transaction","detail":"{read_only:false; response_revision:21337; number_of_response:1; }","duration":"152.648771ms","start":"2026-08-22T03:36:18.764135Z","end":"2026-08-22T03:36:18.916784Z","steps":["trace[1781036768] 'process raft request' (duration: 36.903088ms)","trace[1781036768] 'compare' (duration: 115.338074ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:36:18.974658Z","caller":"traceutil/trace.go:171","msg":"trace[1931274168] transaction","detail":"{read_only:false; response_revision:21338; number_of_response:1; }","duration":"118.55673ms","start":"2026-08-22T03:36:18.85606Z","end":"2026-08-22T03:36:18.974616Z","steps":["trace[1931274168] 'process raft request' (duration: 118.323914ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:36:18.980344Z","caller":"traceutil/trace.go:171","msg":"trace[1837221637] transaction","detail":"{read_only:false; response_revision:21339; number_of_response:1; }","duration":"114.501692ms","start":"2026-08-22T03:36:18.865822Z","end":"2026-08-22T03:36:18.980324Z","steps":["trace[1837221637] 'process raft request' (duration: 114.40557ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:37:22.189473Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":19758} {"level":"info","ts":"2026-08-22T03:37:22.303891Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":19758,"took":"110.148321ms","hash":664218660,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":30334976,"current-db-size-in-use":"30 MB"} {"level":"info","ts":"2026-08-22T03:37:22.303982Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":664218660,"revision":19758,"compact-revision":17394} {"level":"warn","ts":"2026-08-22T03:38:47.735154Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4984253503627058456,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T03:38:48.236259Z","caller":"etcdserver/v3_server.go:897","msg":"waiting for ReadIndex response took too long, retrying","sent-request-id":4984253503627058456,"retry-timeout":"500ms"} {"level":"warn","ts":"2026-08-22T03:38:48.425132Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.433952004s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" ","response":"range_response_count:1 size:1858"} {"level":"info","ts":"2026-08-22T03:38:48.425214Z","caller":"traceutil/trace.go:171","msg":"trace[516485702] range","detail":"{range_begin:/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0; range_end:; response_count:1; response_revision:22497; }","duration":"1.434079427s","start":"2026-08-22T03:38:46.991115Z","end":"2026-08-22T03:38:48.425194Z","steps":["trace[516485702] 'range keys from in-memory index tree' (duration: 1.433780099s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.425254Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:46.991091Z","time spent":"1.434154159s","remote":"127.0.0.1:35556","response type":"/etcdserverpb.KV/Range","request count":0,"request size":81,"response count":1,"response size":1881,"request content":"key:\"/registry/persistentvolumeclaims/openstack/persistence-rabbitmq-cinder-server-0\" "} {"level":"warn","ts":"2026-08-22T03:38:48.429961Z","caller":"wal/wal.go:805","msg":"slow fdatasync","took":"1.195323379s","expected-duration":"1s"} {"level":"info","ts":"2026-08-22T03:38:48.430538Z","caller":"traceutil/trace.go:171","msg":"trace[1663557963] transaction","detail":"{read_only:false; response_revision:22498; number_of_response:1; }","duration":"1.195988004s","start":"2026-08-22T03:38:47.234519Z","end":"2026-08-22T03:38:48.430507Z","steps":["trace[1663557963] 'process raft request' (duration: 1.195780069s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.430709Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.234497Z","time spent":"1.196116558s","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":555,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T03:38:48.432161Z","caller":"traceutil/trace.go:171","msg":"trace[102811956] transaction","detail":"{read_only:false; response_revision:22499; number_of_response:1; }","duration":"874.501687ms","start":"2026-08-22T03:38:47.55765Z","end":"2026-08-22T03:38:48.432151Z","steps":["trace[102811956] 'process raft request' (duration: 874.420695ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.432217Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.557619Z","time spent":"874.571359ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":534,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"info","ts":"2026-08-22T03:38:48.432331Z","caller":"traceutil/trace.go:171","msg":"trace[30935689] linearizableReadLoop","detail":"{readStateIndex:23265; appliedIndex:23262; }","duration":"1.197500712s","start":"2026-08-22T03:38:47.23481Z","end":"2026-08-22T03:38:48.43231Z","steps":["trace[30935689] 'read index received' (duration: 1.195469193s)","trace[30935689] 'applied index is now lower than readState.Index' (duration: 2.030269ms)"],"step_count":2} {"level":"info","ts":"2026-08-22T03:38:48.432457Z","caller":"traceutil/trace.go:171","msg":"trace[1465802668] transaction","detail":"{read_only:false; response_revision:22500; number_of_response:1; }","duration":"841.90986ms","start":"2026-08-22T03:38:47.590536Z","end":"2026-08-22T03:38:48.432446Z","steps":["trace[1465802668] 'process raft request' (duration: 841.588313ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.432561Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.590511Z","time spent":"841.988543ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Txn","request count":1,"request size":541,"response count":0,"response size":41,"request content":"compare: success:> failure: >"} {"level":"warn","ts":"2026-08-22T03:38:48.432564Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.197749728s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"info","ts":"2026-08-22T03:38:48.432734Z","caller":"traceutil/trace.go:171","msg":"trace[2042658324] range","detail":"{range_begin:/registry/services/endpoints/; range_end:/registry/services/endpoints0; response_count:0; response_revision:22500; }","duration":"1.197889091s","start":"2026-08-22T03:38:47.234801Z","end":"2026-08-22T03:38:48.43269Z","steps":["trace[2042658324] 'agreement among raft nodes before linearized reading' (duration: 1.197664266s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.432828Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.234742Z","time spent":"1.198054265s","remote":"127.0.0.1:35572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":64,"response count":81,"response size":31,"request content":"key:\"/registry/services/endpoints/\" range_end:\"/registry/services/endpoints0\" count_only:true "} {"level":"warn","ts":"2026-08-22T03:38:48.433605Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"707.359509ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-controller-manager\" ","response":"range_response_count:1 size:509"} {"level":"info","ts":"2026-08-22T03:38:48.433655Z","caller":"traceutil/trace.go:171","msg":"trace[431274849] range","detail":"{range_begin:/registry/leases/kube-system/kube-controller-manager; range_end:; response_count:1; response_revision:22500; }","duration":"707.453901ms","start":"2026-08-22T03:38:47.726189Z","end":"2026-08-22T03:38:48.433643Z","steps":["trace[431274849] 'agreement among raft nodes before linearized reading' (duration: 707.286107ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.433618Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.603052ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"info","ts":"2026-08-22T03:38:48.433728Z","caller":"traceutil/trace.go:171","msg":"trace[480837625] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22500; }","duration":"699.733175ms","start":"2026-08-22T03:38:47.733984Z","end":"2026-08-22T03:38:48.433717Z","steps":["trace[480837625] 'agreement among raft nodes before linearized reading' (duration: 699.512049ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.433763Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"699.809877ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"info","ts":"2026-08-22T03:38:48.433796Z","caller":"traceutil/trace.go:171","msg":"trace[596117092] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22500; }","duration":"699.881868ms","start":"2026-08-22T03:38:47.733905Z","end":"2026-08-22T03:38:48.433787Z","steps":["trace[596117092] 'agreement among raft nodes before linearized reading' (duration: 699.796726ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.433685Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.726168Z","time spent":"707.509573ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":54,"response count":1,"response size":532,"request content":"key:\"/registry/leases/kube-system/kube-controller-manager\" "} {"level":"warn","ts":"2026-08-22T03:38:48.4339Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"700.124875ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-08-22T03:38:48.433928Z","caller":"traceutil/trace.go:171","msg":"trace[1522070782] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22500; }","duration":"700.171877ms","start":"2026-08-22T03:38:47.733749Z","end":"2026-08-22T03:38:48.433921Z","steps":["trace[1522070782] 'agreement among raft nodes before linearized reading' (duration: 700.092364ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.433953Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.733738Z","time spent":"700.209007ms","remote":"127.0.0.1:35572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":697,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "} {"level":"warn","ts":"2026-08-22T03:38:48.434018Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"869.972779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/kube-scheduler\" ","response":"range_response_count:1 size:482"} {"level":"warn","ts":"2026-08-22T03:38:48.434061Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.688954ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"info","ts":"2026-08-22T03:38:48.434093Z","caller":"traceutil/trace.go:171","msg":"trace[1751099262] range","detail":"{range_begin:/registry/leases/kube-system/kube-scheduler; range_end:; response_count:1; response_revision:22500; }","duration":"870.068121ms","start":"2026-08-22T03:38:47.56401Z","end":"2026-08-22T03:38:48.434078Z","steps":["trace[1751099262] 'agreement among raft nodes before linearized reading' (duration: 869.922168ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:38:48.434129Z","caller":"traceutil/trace.go:171","msg":"trace[1467124190] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22500; }","duration":"737.777686ms","start":"2026-08-22T03:38:47.696322Z","end":"2026-08-22T03:38:48.434099Z","steps":["trace[1467124190] 'agreement among raft nodes before linearized reading' (duration: 737.645503ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.434121Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"1.181859864s","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true ","response":"range_response_count:0 size:8"} {"level":"warn","ts":"2026-08-22T03:38:48.434163Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.696306Z","time spent":"737.850247ms","remote":"127.0.0.1:35628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7397,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"info","ts":"2026-08-22T03:38:48.434197Z","caller":"traceutil/trace.go:171","msg":"trace[1595183546] range","detail":"{range_begin:/registry/cert-manager.io/clusterissuers/; range_end:/registry/cert-manager.io/clusterissuers0; response_count:0; response_revision:22500; }","duration":"1.182012548s","start":"2026-08-22T03:38:47.252168Z","end":"2026-08-22T03:38:48.43418Z","steps":["trace[1595183546] 'agreement among raft nodes before linearized reading' (duration: 1.181270079s)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.434208Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.563998Z","time spent":"870.128983ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":45,"response count":1,"response size":505,"request content":"key:\"/registry/leases/kube-system/kube-scheduler\" "} {"level":"warn","ts":"2026-08-22T03:38:48.434191Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"701.431118ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"} {"level":"warn","ts":"2026-08-22T03:38:48.434237Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.252147Z","time spent":"1.182082579s","remote":"127.0.0.1:52412","response type":"/etcdserverpb.KV/Range","request count":0,"request size":88,"response count":3,"response size":31,"request content":"key:\"/registry/cert-manager.io/clusterissuers/\" range_end:\"/registry/cert-manager.io/clusterissuers0\" count_only:true "} {"level":"warn","ts":"2026-08-22T03:38:48.434234Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"941.19711ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" ","response":"range_response_count:1 size:494"} {"level":"warn","ts":"2026-08-22T03:38:48.433775Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.733977Z","time spent":"699.789846ms","remote":"127.0.0.1:35628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7397,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"info","ts":"2026-08-22T03:38:48.434271Z","caller":"traceutil/trace.go:171","msg":"trace[1324648750] range","detail":"{range_begin:/registry/leases/kube-system/cilium-operator-resource-lock; range_end:; response_count:1; response_revision:22500; }","duration":"941.279012ms","start":"2026-08-22T03:38:47.492981Z","end":"2026-08-22T03:38:48.43426Z","steps":["trace[1324648750] 'agreement among raft nodes before linearized reading' (duration: 941.19054ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:38:48.434256Z","caller":"traceutil/trace.go:171","msg":"trace[1932232449] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22500; }","duration":"701.513649ms","start":"2026-08-22T03:38:47.732733Z","end":"2026-08-22T03:38:48.434246Z","steps":["trace[1932232449] 'agreement among raft nodes before linearized reading' (duration: 701.161971ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.43431Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.492955Z","time spent":"941.346363ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":60,"response count":1,"response size":517,"request content":"key:\"/registry/leases/kube-system/cilium-operator-resource-lock\" "} {"level":"warn","ts":"2026-08-22T03:38:48.433827Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.733883Z","time spent":"699.938669ms","remote":"127.0.0.1:35628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7397,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"warn","ts":"2026-08-22T03:38:48.434376Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.732722Z","time spent":"701.643332ms","remote":"127.0.0.1:35572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":697,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "} {"level":"warn","ts":"2026-08-22T03:38:48.434362Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"938.855893ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-cp-lock\" ","response":"range_response_count:1 size:437"} {"level":"warn","ts":"2026-08-22T03:38:48.434396Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"927.513388ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"warn","ts":"2026-08-22T03:38:48.434357Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"737.95336ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/openstack/octavia-api\" ","response":"range_response_count:1 size:674"} {"level":"info","ts":"2026-08-22T03:38:48.434445Z","caller":"traceutil/trace.go:171","msg":"trace[1756215901] range","detail":"{range_begin:/registry/rabbitmq.com/queues/; range_end:/registry/rabbitmq.com/queues0; response_count:0; response_revision:22500; }","duration":"927.635371ms","start":"2026-08-22T03:38:47.506782Z","end":"2026-08-22T03:38:48.434418Z","steps":["trace[1756215901] 'agreement among raft nodes before linearized reading' (duration: 927.511889ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:38:48.434541Z","caller":"traceutil/trace.go:171","msg":"trace[623912359] range","detail":"{range_begin:/registry/services/endpoints/openstack/octavia-api; range_end:; response_count:1; response_revision:22500; }","duration":"738.188825ms","start":"2026-08-22T03:38:47.696326Z","end":"2026-08-22T03:38:48.434515Z","steps":["trace[623912359] 'agreement among raft nodes before linearized reading' (duration: 737.738034ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.4346Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.69631Z","time spent":"738.278788ms","remote":"127.0.0.1:35572","response type":"/etcdserverpb.KV/Range","request count":0,"request size":52,"response count":1,"response size":697,"request content":"key:\"/registry/services/endpoints/openstack/octavia-api\" "} {"level":"warn","ts":"2026-08-22T03:38:48.434585Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.506775Z","time spent":"927.741094ms","remote":"127.0.0.1:52002","response type":"/etcdserverpb.KV/Range","request count":0,"request size":66,"response count":0,"response size":29,"request content":"key:\"/registry/rabbitmq.com/queues/\" range_end:\"/registry/rabbitmq.com/queues0\" count_only:true "} {"level":"info","ts":"2026-08-22T03:38:48.43445Z","caller":"traceutil/trace.go:171","msg":"trace[1302468992] range","detail":"{range_begin:/registry/leases/kube-system/plndr-cp-lock; range_end:; response_count:1; response_revision:22500; }","duration":"938.980495ms","start":"2026-08-22T03:38:47.495436Z","end":"2026-08-22T03:38:48.434417Z","steps":["trace[1302468992] 'agreement among raft nodes before linearized reading' (duration: 938.75501ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.434672Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.495406Z","time spent":"939.250293ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":44,"response count":1,"response size":460,"request content":"key:\"/registry/leases/kube-system/plndr-cp-lock\" "} {"level":"warn","ts":"2026-08-22T03:38:48.434387Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"364.761063ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/jobs/openstack/octavia-ks-user\" ","response":"range_response_count:1 size:7374"} {"level":"info","ts":"2026-08-22T03:38:48.434762Z","caller":"traceutil/trace.go:171","msg":"trace[2028171600] range","detail":"{range_begin:/registry/jobs/openstack/octavia-ks-user; range_end:; response_count:1; response_revision:22500; }","duration":"365.177053ms","start":"2026-08-22T03:38:48.06957Z","end":"2026-08-22T03:38:48.434748Z","steps":["trace[2028171600] 'agreement among raft nodes before linearized reading' (duration: 364.60355ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.434814Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:48.069551Z","time spent":"365.248606ms","remote":"127.0.0.1:35628","response type":"/etcdserverpb.KV/Range","request count":0,"request size":42,"response count":1,"response size":7397,"request content":"key:\"/registry/jobs/openstack/octavia-ks-user\" "} {"level":"warn","ts":"2026-08-22T03:38:48.43469Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"756.070837ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" ","response":"range_response_count:1 size:441"} {"level":"info","ts":"2026-08-22T03:38:48.435026Z","caller":"traceutil/trace.go:171","msg":"trace[1274118502] range","detail":"{range_begin:/registry/leases/kube-system/plndr-svcs-lock; range_end:; response_count:1; response_revision:22500; }","duration":"756.422955ms","start":"2026-08-22T03:38:47.678573Z","end":"2026-08-22T03:38:48.434996Z","steps":["trace[1274118502] 'agreement among raft nodes before linearized reading' (duration: 755.496123ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:38:48.435718Z","caller":"v3rpc/interceptor.go:197","msg":"request stats","start time":"2026-08-22T03:38:47.678553Z","time spent":"757.152252ms","remote":"127.0.0.1:35660","response type":"/etcdserverpb.KV/Range","request count":0,"request size":46,"response count":1,"response size":464,"request content":"key:\"/registry/leases/kube-system/plndr-svcs-lock\" "} {"level":"warn","ts":"2026-08-22T03:40:25.522641Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"187.89779ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/ceph.rook.io/cephobjectstoreusers/\" range_end:\"/registry/ceph.rook.io/cephobjectstoreusers0\" count_only:true ","response":"range_response_count:0 size:6"} {"level":"info","ts":"2026-08-22T03:40:25.522767Z","caller":"traceutil/trace.go:171","msg":"trace[941051658] range","detail":"{range_begin:/registry/ceph.rook.io/cephobjectstoreusers/; range_end:/registry/ceph.rook.io/cephobjectstoreusers0; response_count:0; response_revision:23859; }","duration":"188.083954ms","start":"2026-08-22T03:40:25.334656Z","end":"2026-08-22T03:40:25.52274Z","steps":["trace[941051658] 'count revisions from in-memory index tree' (duration: 187.798317ms)"],"step_count":1} {"level":"warn","ts":"2026-08-22T03:40:25.522996Z","caller":"etcdserver/util.go:170","msg":"apply request took too long","took":"225.358285ms","expected-duration":"100ms","prefix":"read-only range ","request":"key:\"/registry/services/endpoints/default/kubernetes\" ","response":"range_response_count:1 size:422"} {"level":"info","ts":"2026-08-22T03:40:25.523073Z","caller":"traceutil/trace.go:171","msg":"trace[1824211333] range","detail":"{range_begin:/registry/services/endpoints/default/kubernetes; range_end:; response_count:1; response_revision:23859; }","duration":"225.475287ms","start":"2026-08-22T03:40:25.297576Z","end":"2026-08-22T03:40:25.523051Z","steps":["trace[1824211333] 'range keys from in-memory index tree' (duration: 225.18365ms)"],"step_count":1} {"level":"info","ts":"2026-08-22T03:42:22.196098Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":21931} {"level":"info","ts":"2026-08-22T03:42:22.304915Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":21931,"took":"105.115288ms","hash":2455124210,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":44019712,"current-db-size-in-use":"44 MB"} {"level":"info","ts":"2026-08-22T03:42:22.304992Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":2455124210,"revision":21931,"compact-revision":19758} {"level":"info","ts":"2026-08-22T03:46:01.818607Z","caller":"wal/wal.go:785","msg":"created a new WAL segment","path":"/var/lib/etcd/member/wal/0000000000000002-0000000000006b8f.wal"} {"level":"info","ts":"2026-08-22T03:47:22.201119Z","caller":"mvcc/index.go:214","msg":"compact tree index","revision":25012} {"level":"info","ts":"2026-08-22T03:47:22.337814Z","caller":"mvcc/kvstore_compaction.go:68","msg":"finished scheduled compaction","compact-revision":25012,"took":"133.641195ms","hash":1793299102,"current-db-size-bytes":57995264,"current-db-size":"58 MB","current-db-size-in-use-bytes":31412224,"current-db-size-in-use":"31 MB"} {"level":"info","ts":"2026-08-22T03:47:22.33788Z","caller":"mvcc/hash.go:137","msg":"storing new hash","hash":1793299102,"revision":25012,"compact-revision":21931}