Parent Log: http://ci.aztec-labs.com/1440c0fbd00c97c8 Command: fe89a5d9e20c90c9:ISOLATE=1:NAME=p2p/src/services/reqresp/reqresp.test.ts yarn-project/scripts/run_test.sh p2p/src/services/reqresp/reqresp.test.ts Commit: https://github.com/AztecProtocol/aztec-packages/commit/260d4b0cfbe16cbd8be248715852ee1ff72cc6cd Env: REF_NAME=gh-readonly-queue/master/pr-14716-b9f63e086a00464c0ad1800566372d3b7ddc6746 CURRENT_VERSION=0.87.7 CI_FULL=1 Date: Tue Jun 3 13:33:34 UTC 2025 System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=pr-14716_amd64_x1-full Resources: CPU_LIST=0-127 CPUS=2 MEM=8g TIMEOUT=600s History: http://ci.aztec-labs.com/list/a57cc872d7daa810 13:33:34 +++ id -u 13:33:34 +++ id -g 13:33:34 ++ docker run -d --name p2p_src_services_reqresp_reqresp.test.ts --net=none --cpuset-cpus=0-127 --cpus=2 --memory=8g --user 1000:1000 -v/home/aztec-dev:/home/aztec-dev --mount type=tmpfs,target=/tmp,tmpfs-size=1g --workdir /home/aztec-dev/aztec-packages -e HOME -e VERBOSE -e GIT_CONFIG_GLOBAL=/home/aztec-dev/aztec-packages/build-images/src/home/.gitconfig -e FORCE_COLOR=true -e CPUS -e MEM aztecprotocol/build:3.0 /bin/bash -c 'timeout -v 600s bash -c '\''yarn-project/scripts/run_test.sh p2p/src/services/reqresp/reqresp.test.ts'\''' 13:33:34 + cid=aa0c6377566fc7a9d59d1ad76ded35241eb11fef5ce2112fc727e98f2d3300d1 13:33:34 + set +x 13:33:43 [13:33:43.250] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:43 [13:33:43.254] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:43 [13:33:43.258] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:43 [13:33:43.258] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:43 [13:33:43.803] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:43 [13:33:43.804] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:43 [13:33:43.851] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:43 [13:33:43.852] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:43 [13:33:43.853] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:43 [13:33:43.854] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:45 [13:33:45.032] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:45 [13:33:45.033] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:45 [13:33:45.035] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:45 [13:33:45.036] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:45 [13:33:45.154] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:45 [13:33:45.155] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:45 [13:33:45.156] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:45 [13:33:45.156] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:45 [13:33:45.157] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:45 [13:33:45.157] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:45 [13:33:45.162] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:45 [13:33:45.163] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:46 [13:33:46.254] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWBMXz2YXyzv7mDP33pFMxiHEabuLZfZ3JQRa7982YMdLW 13:33:46 [13:33:46.255] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:33:46 err: { 13:33:46 "type": "ReqRespStatusError", 13:33:46 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:33:46 "stack": 13:33:46 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:33:46 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:33:46 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:33:46 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:33:46 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:33:46 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:33:46 "status": 1 13:33:46 } 13:33:46 [13:33:46.263] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWBMXz2YXyzv7mDP33pFMxiHEabuLZfZ3JQRa7982YMdLW 13:33:46 [13:33:46.263] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:33:46 err: { 13:33:46 "type": "ReqRespStatusError", 13:33:46 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:33:46 "stack": 13:33:46 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:33:46 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:33:46 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:33:46 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:33:46 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:33:46 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:33:46 "status": 1 13:33:46 } 13:33:46 [13:33:46.267] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWBMXz2YXyzv7mDP33pFMxiHEabuLZfZ3JQRa7982YMdLW 13:33:46 [13:33:46.267] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:33:46 err: { 13:33:46 "type": "ReqRespStatusError", 13:33:46 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:33:46 "stack": 13:33:46 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:33:46 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:33:46 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:33:46 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:33:46 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:33:46 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:33:46 "status": 1 13:33:46 } 13:33:46 [13:33:46.270] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWBMXz2YXyzv7mDP33pFMxiHEabuLZfZ3JQRa7982YMdLW 13:33:46 [13:33:46.270] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:33:46 err: { 13:33:46 "type": "ReqRespStatusError", 13:33:46 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:33:46 "stack": 13:33:46 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:33:46 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:33:46 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:33:46 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:33:46 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:33:46 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:33:46 "status": 1 13:33:46 } 13:33:46 [13:33:46.274] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWBMXz2YXyzv7mDP33pFMxiHEabuLZfZ3JQRa7982YMdLW 13:33:46 [13:33:46.274] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:33:46 err: { 13:33:46 "type": "ReqRespStatusError", 13:33:46 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:33:46 "stack": 13:33:46 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:33:46 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:33:46 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:33:46 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:33:46 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:33:46 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:33:46 "status": 1 13:33:46 } 13:33:46 [13:33:46.280] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:46 [13:33:46.281] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:46 [13:33:46.285] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:46 [13:33:46.285] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:47 [13:33:47.800] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:47 [13:33:47.801] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:47 [13:33:47.811] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:47 [13:33:47.813] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:48 [13:33:48.904] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:48 [13:33:48.904] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:48 [13:33:48.908] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:48 [13:33:48.908] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:49 [13:33:49.979] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:49 [13:33:49.979] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:49 [13:33:49.983] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:49 [13:33:49.983] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:53 [13:33:53.081] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:53 [13:33:53.081] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:53 [13:33:53.085] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:53 [13:33:53.085] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:58 [13:33:58.296] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:58 [13:33:58.296] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:58 [13:33:58.298] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:58 [13:33:58.298] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:58 [13:33:58.300] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:58 [13:33:58.300] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:58 [13:33:58.306] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:58 [13:33:58.306] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:58 [13:33:58.324] WARN: foundation:memory_fifo Discarding item because queue is flushing 13:33:58 [13:33:58.327] ERROR: p2p:reqresp Unexpected error sending request to peer: Error: Could not enqueue function 13:33:58 at /home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:63:24 13:33:58 at new Promise (<anonymous>) 13:33:58 at SerialQueue.put (/home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:53:16) 13:33:58 at ConnectionSampler.put [as dialProtocol] (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/connection-sampler/connection_sampler.ts:204:43) 13:33:58 at ReqResp.dialProtocol (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:449:45) 13:33:58 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:33:58 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:33:58 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:33:58 at TimeoutTask.requestFunction [as fn] (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:200:26) {"peerId":"12D3KooWNZ4HY7rzZzELJgpnmeiVci8bWor1sAcP2KUQP3f82Ckv","subProtocol":"/aztec/req/tx/0.1.0"} 13:33:59 [13:33:59.407] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:59 [13:33:59.408] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:33:59 [13:33:59.412] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:33:59 [13:33:59.413] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:00 [13:34:00.460] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:00 [13:34:00.460] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:00 [13:34:00.464] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:00 [13:34:00.465] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:01 [13:34:01.522] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:01 [13:34:01.522] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:01 [13:34:01.526] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:01 [13:34:01.527] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:02 [13:34:02.910] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:02 [13:34:02.911] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:02 [13:34:02.914] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:02 [13:34:02.914] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:04 [13:34:04.037] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWB1xRdDdUgfYdwTsHTmcenuHp7qwFUNKB51xMwvcL1hpB 13:34:04 [13:34:04.038] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:34:04 err: { 13:34:04 "type": "ReqRespStatusError", 13:34:04 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:34:04 "stack": 13:34:04 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:34:04 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:34:04 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:34:04 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:34:04 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:34:04 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:34:04 "status": 1 13:34:04 } 13:34:04 [13:34:04.062] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:04 [13:34:04.063] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:04 [13:34:04.064] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:04 [13:34:04.064] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:04 [13:34:04.067] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:04 [13:34:04.068] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:05 [13:34:05.322] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:05 [13:34:05.323] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:05 [13:34:05.324] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:05 [13:34:05.324] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:05 [13:34:05.325] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:05 [13:34:05.325] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:05 [13:34:05.329] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:05 [13:34:05.329] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:06 [13:34:06.445] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWGMfy3Y6Gw5Av5XjH4HQcq57MDLjx97DT42v6hrnQkrhT 13:34:06 [13:34:06.446] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:34:06 err: { 13:34:06 "type": "ReqRespStatusError", 13:34:06 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:34:06 "stack": 13:34:06 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:34:06 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:34:06 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:34:06 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:34:06 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:34:06 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:34:06 "status": 1 13:34:06 } 13:34:06 [13:34:06.450] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWGMfy3Y6Gw5Av5XjH4HQcq57MDLjx97DT42v6hrnQkrhT 13:34:06 [13:34:06.451] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:34:06 err: { 13:34:06 "type": "ReqRespStatusError", 13:34:06 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:34:06 "stack": 13:34:06 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:34:06 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:34:06 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:34:06 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:34:06 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:34:06 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:34:06 "status": 1 13:34:06 } 13:34:06 [13:34:06.467] WARN: p2p:reqresp Rate limit exceeded DeniedPeer for /aztec/req/ping/0.1.0 from 12D3KooWGMfy3Y6Gw5Av5XjH4HQcq57MDLjx97DT42v6hrnQkrhT 13:34:06 [13:34:06.467] WARN: p2p:reqresp Reqresp Response error: Error undefined ReqResp Error: RATE_LIMIT_EXCEEDED {"protocol":"/aztec/req/ping/0.1.0"} 13:34:06 err: { 13:34:06 "type": "ReqRespStatusError", 13:34:06 "message": "ReqResp Error: RATE_LIMIT_EXCEEDED", 13:34:06 "stack": 13:34:06 Error: ReqResp Error: RATE_LIMIT_EXCEEDED 13:34:06 at ReqResp.streamHandler (/home/aztec-dev/aztec-packages/yarn-project/p2p/src/services/reqresp/reqresp.ts:630:15) 13:34:06 at /home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:34:54 13:34:06 at NoopTracer.startActiveSpan (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/noop.js:29:16) 13:34:06 at ReqResp.replacementMethod (/home/aztec-dev/aztec-packages/yarn-project/telemetry-client/dest/telemetry.js:31:32) 13:34:06 at processTicksAndRejections (node:internal/process/task_queues:105:5) 13:34:06 "status": 1 13:34:06 } 13:34:06 [13:34:06.477] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:06 [13:34:06.478] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:06 [13:34:06.478] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:06 [13:34:06.479] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:06 [13:34:06.482] INFO: p2p:reqresp:connection-sampler Stopping connection sampler 13:34:06 [13:34:06.482] INFO: p2p:reqresp:connection-sampler Connection sampler stopped 13:34:06 FAIL src/services/reqresp/reqresp.test.ts (30.906 s) 13:34:06 ReqResp 13:34:06 should perform a ping request (1210 ms) 13:34:06 should handle gracefully if a peer connected peer is offline (592 ms) 13:34:06 should request from a later peer if other peers are offline (1341 ms) 13:34:06 should hit a rate limit if too many requests are made in quick succession (1100 ms) 13:34:06 Tx req protocol 13:34:06 can request a Tx from TxHash (1522 ms) 13:34:06 handles returning empty buffers (1096 ms) 13:34:06 does not crash if tx hash returns undefined (1076 ms) 13:34:06 should hit individual timeout if nothing is returned over the stream (3092 ms) 13:34:06 should hit collective timeout if nothing is returned over the stream from multiple peers (5238 ms) 13:34:06 should penalize peer if transaction validation fails (1091 ms) 13:34:06 Goodbye protocol 13:34:06 should send a goodbye message to a peer (1050 ms) 13:34:06 should not close stream when handling a goodbye message received from peer (1063 ms) 13:34:06 Block protocol 13:34:06 should handle block requests (1387 ms) 13:34:06 Batch requests 13:34:06 should send a batch request between many peers (1158 ms) 13:34:06 should send a batch request with a pinned peer (1267 ms) 13:34:06 should stop after max retry attempts (1148 ms) 13:34:06 13:34:06 ReqResp › should hit a rate limit if too many requests are made in quick succession 13:34:06 13:34:06 expect(received).toBeDefined() 13:34:06 13:34:06 Received: undefined 13:34:06 13:34:06 145 | // Check that one of the responses gets a rate limit response 13:34:06 146 | const rateLimitResponse = responses.find(response => response?.status === ReqRespStatus.RATE_LIMIT_EXCEEDED); 13:34:06 > 147 | expect(rateLimitResponse).toBeDefined(); 13:34:06 | ^ 13:34:06 148 | 13:34:06 149 | // Make sure the error message is logged 13:34:06 150 | const errorMessage = `Rate limit exceeded DeniedPeer for ${ 13:34:06 13:34:06 at Object.toBeDefined (services/reqresp/reqresp.test.ts:147:31) 13:34:06 13:34:06 ReqResp › Batch requests › should send a batch request between many peers 13:34:06 13:34:06 expect(jest.fn()).toHaveBeenCalledTimes(expected) 13:34:06 13:34:06 Expected number of calls: 9 13:34:06 Received number of calls: 11 13:34:06 13:34:06 474 | 13:34:06 475 | // Expect one request to have been sent to each peer 13:34:06 > 476 | expect(sendRequestToPeerSpy).toHaveBeenCalledTimes(batchSize); 13:34:06 | ^ 13:34:06 477 | expect(sendRequestToPeerSpy).toHaveBeenCalledWith( 13:34:06 478 | expect.objectContaining({ 13:34:06 479 | publicKey: nodes[1].p2p.peerId.publicKey, 13:34:06 13:34:06 at Object.toHaveBeenCalledTimes (services/reqresp/reqresp.test.ts:476:36) 13:34:06 13:34:06 ReqResp › Batch requests › should send a batch request with a pinned peer 13:34:06 13:34:06 expect(jest.fn()).toHaveBeenCalledWith(...expected) 13:34:06 13:34:06 Expected: ObjectContaining {"publicKey": [8, 1, 18, 32, 61, 141, 73, 44, 61, 32, …]}, "/aztec/req/ping/0.1.0", {"data": [112, 105, 110, 103, 51], "type": "Buffer"} 13:34:06 Received 13:34:06 1 13:34:06 "12D3KooWMoNxMVzcNKzaawjAvxxGoSQiMD7og9hRU86ec8tn1dC8", 13:34:06 "/aztec/req/ping/0.1.0", 13:34:06 @@ -2,9 +2,9 @@ 13:34:06 "data": Array [ 13:34:06 112, 13:34:06 105, 13:34:06 110, 13:34:06 103, 13:34:06 - 51, 13:34:06 + 48, 13:34:06 ], 13:34:06 "type": "Buffer", 13:34:06 }, 13:34:06 2 13:34:06 "12D3KooWPoz9jcXVzHYtv84vMNvs7wvnLkB1XU5P22VhHJAU9nNv", 13:34:06 "/aztec/req/ping/0.1.0", 13:34:06 @@ -2,9 +2,9 @@ 13:34:06 "data": Array [ 13:34:06 112, 13:34:06 105, 13:34:06 110, 13:34:06 103, 13:34:06 - 51, 13:34:06 + 49, 13:34:06 ], 13:34:06 "type": "Buffer", 13:34:06 }, 13:34:06 3 13:34:06 "12D3KooWDxdzWHEgQC8SqRGCztgGEYRg6ELWfBhY5HXfLukj9jmc", 13:34:06 "/aztec/req/ping/0.1.0", 13:34:06 @@ -2,9 +2,9 @@ 13:34:06 "data": Array [ 13:34:06 112, 13:34:06 105, 13:34:06 110, 13:34:06 103, 13:34:06 - 51, 13:34:06 + 48, 13:34:06 ], 13:34:06 "type": "Buffer", 13:34:06 }, 13:34:06 13:34:06 Number of calls: 14 13:34:06 13:34:06 516 | // Expect pinned peer to have received all requests 13:34:06 517 | for (let i = 0; i < batchSize; i++) { 13:34:06 > 518 | expect(sendRequestToPeerSpy).toHaveBeenCalledWith( 13:34:06 | ^ 13:34:06 519 | expect.objectContaining({ publicKey: nodes[1].p2p.peerId.publicKey }), 13:34:06 520 | ReqRespSubProtocol.PING, 13:34:06 521 | Buffer.from(`ping${i}`), 13:34:06 13:34:06 at Object.toHaveBeenCalledWith (services/reqresp/reqresp.test.ts:518:38) 13:34:06 13:34:06 ReqResp › Batch requests › should stop after max retry attempts 13:34:06 13:34:06 expect(received).toEqual(expected) // deep equality 13:34:06 13:34:06 - Expected - 11 13:34:06 + Received + 3 13:34:06 13:34:06 @@ -74,10 +74,11 @@ 13:34:06 103, 13:34:06 ], 13:34:06 "type": "Buffer", 13:34:06 }, 13:34:06 }, 13:34:06 + undefined, 13:34:06 RequestableBuffer { 13:34:06 "buffer": Object { 13:34:06 "data": Array [ 13:34:06 112, 13:34:06 111, 13:34:06 @@ -85,10 +86,11 @@ 13:34:06 103, 13:34:06 ], 13:34:06 "type": "Buffer", 13:34:06 }, 13:34:06 }, 13:34:06 + undefined, 13:34:06 RequestableBuffer { 13:34:06 "buffer": Object { 13:34:06 "data": Array [ 13:34:06 112, 13:34:06 111, 13:34:06 @@ -96,17 +98,7 @@ 13:34:06 103, 13:34:06 ], 13:34:06 "type": "Buffer", 13:34:06 }, 13:34:06 }, 13:34:06 - RequestableBuffer { 13:34:06 - "buffer": Object { 13:34:06 - "data": Array [ 13:34:06 - 112, 13:34:06 - 111, 13:34:06 - 110, 13:34:06 - 103, 13:34:06 - ], 13:34:06 - "type": "Buffer", 13:34:06 - }, 13:34:06 - }, 13:34:06 + undefined, 13:34:06 ] 13:34:06 13:34:06 555 | 13:34:06 556 | const res = await nodes[0].req.sendBatchRequest(ReqRespSubProtocol.PING, requests, undefined); 13:34:06 > 557 | expect(res).toEqual(expectResponses); 13:34:06 | ^ 13:34:06 558 | 13:34:06 559 | // Check that we did detect hitting a rate limit 13:34:06 560 | expect(requesterLoggerSpy).toHaveBeenCalledWith( 13:34:06 13:34:06 at Object.toEqual (services/reqresp/reqresp.test.ts:557:19) 13:34:06 13:34:06 Test Suites: 1 failed, 1 total 13:34:06 Tests: 4 failed, 12 passed, 16 total 13:34:06 Snapshots: 0 total 13:34:06 Time: 30.989 s 13:34:06 Ran all test suites matching /p2p\/src\/services\/reqresp\/reqresp.test.ts/i. 13:34:06 Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?