Parent Log:
http://ci.aztec-labs.com/0db17e39956a953c
Command: 10d7fb032f39caf8:ISOLATE=1:NAME=p2p/src/testbench/port_change.test.ts:CPUS=10:MEM=16g yarn-project/scripts/run_test.sh p2p/src/testbench/port_change.test.ts
Commit:
https://github.com/AztecProtocol/aztec-packages/commit/616adae6f5fc7458fdce6efe723c19d199f96d27
Env: REF_NAME=gh-readonly-queue/next/pr-14543-9a8e5a0577ac74d5769f63ef2bc6a5d6b3ef2723 CURRENT_VERSION=0.87.3 CI_FULL=1
Date: Wed May 28 11:38:35 UTC 2025
System: ARCH=amd64 CPUS=128 MEM=493Gi HOSTNAME=gh-readonly-queue_next_pr-14543-9a8e5a0577ac74d576_amd64_x1-full
Resources: CPU_LIST=0-127 CPUS=10 MEM=16g TIMEOUT=600s
History:
http://ci.aztec-labs.com/list/9b8c9f29fec539b7
11:38:35 +++ id -u
11:38:35 +++ id -g
11:38:35 ++ docker run -d --name p2p_src_testbench_port_change.test.ts --net=none --cpuset-cpus=0-127 --cpus=10 --memory=16g --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/testbench/port_change.test.ts'\'''
11:38:36 + cid=1edb79b5733eb600994732e48f3dce29a8fbcf2dfeed403aa6c5e44386e09d0d
11:38:36 + set +x
11:38:39 [11:38:39.805]
INFO:
testbench-ports Starting test setup
11:38:39 [11:38:39.813]
INFO:
testbench-ports Loading config from /home/aztec-dev/aztec-packages/yarn-project/p2p/testbench/configurations/normal-degree-5-nodes.json
11:38:39 [11:38:39.816]
INFO:
testbench-ports Creating 5 clients
11:38:39 [11:38:39.967]
INFO:
testbench-ports Creating client 0
11:38:39 [11:38:39.979]
INFO:
testbench-ports Creating client 1
11:38:39 [11:38:39.989]
INFO:
testbench-ports Creating client 2
11:38:40 [11:38:40.004]
INFO:
testbench-ports Creating client 3
11:38:40 [11:38:40.015]
INFO:
testbench-ports Creating client 4
11:38:47 {"level":30,"time":1748432327953,"pid":47,"hostname":"1edb79b5733e","module":"kv-store:lmdb-v2:test-3","msg":"Starting data store with maxReaders 16"}
11:38:47 {"level":30,"time":1748432327981,"pid":47,"hostname":"1edb79b5733e","module":"p2p-archive:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:47 {"level":30,"time":1748432327983,"pid":47,"hostname":"1edb79b5733e","module":"p2p-peer:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328125,"pid":55,"hostname":"1edb79b5733e","module":"kv-store:lmdb-v2:test-4","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328142,"pid":55,"hostname":"1edb79b5733e","module":"p2p-archive:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328146,"pid":55,"hostname":"1edb79b5733e","module":"p2p-peer:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328160,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:libp2p_service","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328163,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328173,"pid":34,"hostname":"1edb79b5733e","module":"kv-store:lmdb-v2:test-1","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328183,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:discv5_service","nodeId":"4fa6da3d42f079af7e52f3438efcdd90bf97c98badc25248188601d2fb616d94","peerId":"16Uiu2HAmM7fdbU7RjCwPNY5MNsU1Ftv75pGXxuCkJD2WQzGE2a71","enrUdp":"/ip4/127.0.0.1/udp/40009/p2p/16Uiu2HAmM7fdbU7RjCwPNY5MNsU1Ftv75pGXxuCkJD2WQzGE2a71","enrTcp":"/ip4/127.0.0.1/tcp/40009/p2p/16Uiu2HAmM7fdbU7RjCwPNY5MNsU1Ftv75pGXxuCkJD2WQzGE2a71","versions":{"l1ChainId":31337,"l1RollupAddress":"0x2b91f1358f14bd001a47f28c21c47efdb3e58944","rollupVersion":1,"l2ProtocolContractsTreeRoot":"0x1b2a4a4ec8bae4ea0ca779e8f02c8d46d20f3b0a1d866a2f7d9fab76222f7a3d","l2CircuitsVkTreeRoot":"0x14d3fff1f379a093f37ec20306c562b138fb10fc992ac31f007fe8df494d92a1"},"msg":"DiscV5 service started"}
11:38:48 {"level":30,"time":1748432328201,"pid":34,"hostname":"1edb79b5733e","module":"p2p-archive:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328204,"pid":34,"hostname":"1edb79b5733e","module":"p2p-peer:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328186,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:discv5_service","msg":"Adding 3 bootstrap nodes ENRs: enr:-Le4QB7yU8yM6ZNvVtqZk22xXg5OZT-JGUqapemneDcK2iHNGx3jiR2wJUKmcWnc1BcRufCJOMHAJtIELBEkaTQ3N8UGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAx73ezRWOOkep5YkLHWReQEyHX5IgrmzFCo14xH2RHQJg3RjcIKOeYN1ZHCCjnk, enr:-Le4QKDFyKx8B5hgHUgxw3poDc0dyRsHVvgSUZwvZJs4wk5nZ1kTjMyO14l7Wzs00jg5RrekiWmiofxyjamFAKS6M48GhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAgH1W_nH-VOlkQKqz8KR4P8PcRxw027oAeXLtTYr3ykng3RjcIKMI4N1ZHCCjCM, enr:-Le4QPi3bO6ntlGF6NHzH1z0ULTNen6hnw6qJqQ2tBVCNMBIERO1gS_Hqi0qEZtoPvSKYj6Nu0aORVKUOQ7Rj8RYFsMGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhA2bLs76yz8BYArhJhWCX-edQCJ2Z1cvRlfkGFA2ZHZWvg3RjcIK0i4N1ZHCCtIs"}
11:38:48 {"level":30,"time":1748432328215,"pid":33,"hostname":"1edb79b5733e","module":"kv-store:lmdb-v2:test-0","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328224,"pid":33,"hostname":"1edb79b5733e","module":"p2p-archive:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328225,"pid":33,"hostname":"1edb79b5733e","module":"p2p-peer:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328345,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:libp2p_service","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328348,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328355,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3","listen":"127.0.0.1","port":40009,"announce":"/ip4/127.0.0.1/tcp/40009","peerId":"16Uiu2HAmM7fdbU7RjCwPNY5MNsU1Ftv75pGXxuCkJD2WQzGE2a71","msg":"Started P2P service"}
11:38:48 {"level":30,"time":1748432328356,"pid":47,"hostname":"1edb79b5733e","module":"p2p","syncedLatestBlock":1,"syncedProvenBlock":1,"syncedFinalizedBlock":1,"msg":"Starting P2P client synced to 1"}
11:38:48 {"level":30,"time":1748432328363,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:discv5_service","nodeId":"5cecc8df2ac8adbc50291c82d285f8418180bf0ab970b306bf75ff1f99bf059a","peerId":"16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6","enrUdp":"/ip4/127.0.0.1/udp/41193/p2p/16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6","enrTcp":"/ip4/127.0.0.1/tcp/41193/p2p/16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6","versions":{"l1ChainId":31337,"l1RollupAddress":"0x2b91f1358f14bd001a47f28c21c47efdb3e58944","rollupVersion":1,"l2ProtocolContractsTreeRoot":"0x1b2a4a4ec8bae4ea0ca779e8f02c8d46d20f3b0a1d866a2f7d9fab76222f7a3d","l2CircuitsVkTreeRoot":"0x14d3fff1f379a093f37ec20306c562b138fb10fc992ac31f007fe8df494d92a1"},"msg":"DiscV5 service started"}
11:38:48 {"level":30,"time":1748432328370,"pid":45,"hostname":"1edb79b5733e","module":"kv-store:lmdb-v2:test-2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328377,"pid":45,"hostname":"1edb79b5733e","module":"p2p-archive:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328379,"pid":45,"hostname":"1edb79b5733e","module":"p2p-peer:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:38:48 {"level":30,"time":1748432328392,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:libp2p_service","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328397,"pid":33,"hostname":"1edb79b5733e","module":"p2p:0:libp2p_service","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328400,"pid":33,"hostname":"1edb79b5733e","module":"p2p:0","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328401,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328411,"pid":33,"hostname":"1edb79b5733e","module":"p2p:0:discv5_service","nodeId":"d8ed614d4336d9b52be4827a046b8e48dcbbbbcaa54a7c14b2ca0b6ed8b5481d","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","enrUdp":"/ip4/127.0.0.1/udp/36473/p2p/16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","enrTcp":"/ip4/127.0.0.1/tcp/36473/p2p/16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","versions":{"l1ChainId":31337,"l1RollupAddress":"0x2b91f1358f14bd001a47f28c21c47efdb3e58944","rollupVersion":1,"l2ProtocolContractsTreeRoot":"0x1b2a4a4ec8bae4ea0ca779e8f02c8d46d20f3b0a1d866a2f7d9fab76222f7a3d","l2CircuitsVkTreeRoot":"0x14d3fff1f379a093f37ec20306c562b138fb10fc992ac31f007fe8df494d92a1"},"msg":"DiscV5 service started"}
11:38:48 {"level":30,"time":1748432328413,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:discv5_service","nodeId":"fb43aef794d76854b87687fc1a34b6fb42c53fe05a370f27c57a41267877e88b","peerId":"16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe","enrUdp":"/ip4/127.0.0.1/udp/35875/p2p/16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe","enrTcp":"/ip4/127.0.0.1/tcp/35875/p2p/16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe","versions":{"l1ChainId":31337,"l1RollupAddress":"0x2b91f1358f14bd001a47f28c21c47efdb3e58944","rollupVersion":1,"l2ProtocolContractsTreeRoot":"0x1b2a4a4ec8bae4ea0ca779e8f02c8d46d20f3b0a1d866a2f7d9fab76222f7a3d","l2CircuitsVkTreeRoot":"0x14d3fff1f379a093f37ec20306c562b138fb10fc992ac31f007fe8df494d92a1"},"msg":"DiscV5 service started"}
11:38:48 {"level":30,"time":1748432328367,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:discv5_service","msg":"Adding 4 bootstrap nodes ENRs: enr:-Le4QB7yU8yM6ZNvVtqZk22xXg5OZT-JGUqapemneDcK2iHNGx3jiR2wJUKmcWnc1BcRufCJOMHAJtIELBEkaTQ3N8UGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAx73ezRWOOkep5YkLHWReQEyHX5IgrmzFCo14xH2RHQJg3RjcIKOeYN1ZHCCjnk, enr:-Le4QKDFyKx8B5hgHUgxw3poDc0dyRsHVvgSUZwvZJs4wk5nZ1kTjMyO14l7Wzs00jg5RrekiWmiofxyjamFAKS6M48GhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAgH1W_nH-VOlkQKqz8KR4P8PcRxw027oAeXLtTYr3ykng3RjcIKMI4N1ZHCCjCM, enr:-Le4QPi3bO6ntlGF6NHzH1z0ULTNen6hnw6qJqQ2tBVCNMBIERO1gS_Hqi0qEZtoPvSKYj6Nu0aORVKUOQ7Rj8RYFsMGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhA2bLs76yz8BYArhJhWCX-edQCJ2Z1cvRlfkGFA2ZHZWvg3RjcIK0i4N1ZHCCtIs, enr:-Le4QDpQeBXeELamfZOAqqVCGkGJVU71v_1B8xxjEAckRah3S8SwMSp1qBYSfopgU1dFV3keDoYgWquJc72zl6WaFxIGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhA32zAwJpfCC6pbnWwYbbPLJq-F77SVyV8PYhhTBntZAYg3RjcIKcSYN1ZHCCnEk"}
11:38:48 {"level":30,"time":1748432328415,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:discv5_service","msg":"Adding 1 bootstrap nodes ENRs: enr:-Le4QB7yU8yM6ZNvVtqZk22xXg5OZT-JGUqapemneDcK2iHNGx3jiR2wJUKmcWnc1BcRufCJOMHAJtIELBEkaTQ3N8UGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAx73ezRWOOkep5YkLHWReQEyHX5IgrmzFCo14xH2RHQJg3RjcIKOeYN1ZHCCjnk"}
11:38:48 {"level":30,"time":1748432328557,"pid":33,"hostname":"1edb79b5733e","module":"p2p:0","listen":"127.0.0.1","port":36473,"announce":"/ip4/127.0.0.1/tcp/36473","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","msg":"Started P2P service"}
11:38:48 {"level":30,"time":1748432328560,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2:libp2p_service","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328565,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1","listen":"127.0.0.1","port":35875,"announce":"/ip4/127.0.0.1/tcp/35875","peerId":"16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe","msg":"Started P2P service"}
11:38:48 {"level":30,"time":1748432328566,"pid":34,"hostname":"1edb79b5733e","module":"p2p","syncedLatestBlock":1,"syncedProvenBlock":1,"syncedFinalizedBlock":1,"msg":"Starting P2P client synced to 1"}
11:38:48 {"level":30,"time":1748432328558,"pid":33,"hostname":"1edb79b5733e","module":"p2p","syncedLatestBlock":1,"syncedProvenBlock":1,"syncedFinalizedBlock":1,"msg":"Starting P2P client synced to 1"}
11:38:48 {"level":30,"time":1748432328563,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:38:48 {"level":30,"time":1748432328586,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2:discv5_service","nodeId":"06a519619697440b7f3ef469527f4bf2b10729efac7d4bcc568f8033b00a9474","peerId":"16Uiu2HAmKaG6EMqzcH7ehQguNgFWaYoJbqir8oJj8i6PhLvjEN1t","enrUdp":"/ip4/127.0.0.1/udp/46219/p2p/16Uiu2HAmKaG6EMqzcH7ehQguNgFWaYoJbqir8oJj8i6PhLvjEN1t","enrTcp":"/ip4/127.0.0.1/tcp/46219/p2p/16Uiu2HAmKaG6EMqzcH7ehQguNgFWaYoJbqir8oJj8i6PhLvjEN1t","versions":{"l1ChainId":31337,"l1RollupAddress":"0x2b91f1358f14bd001a47f28c21c47efdb3e58944","rollupVersion":1,"l2ProtocolContractsTreeRoot":"0x1b2a4a4ec8bae4ea0ca779e8f02c8d46d20f3b0a1d866a2f7d9fab76222f7a3d","l2CircuitsVkTreeRoot":"0x14d3fff1f379a093f37ec20306c562b138fb10fc992ac31f007fe8df494d92a1"},"msg":"DiscV5 service started"}
11:38:48 {"level":30,"time":1748432328587,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2:discv5_service","msg":"Adding 2 bootstrap nodes ENRs: enr:-Le4QB7yU8yM6ZNvVtqZk22xXg5OZT-JGUqapemneDcK2iHNGx3jiR2wJUKmcWnc1BcRufCJOMHAJtIELBEkaTQ3N8UGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAx73ezRWOOkep5YkLHWReQEyHX5IgrmzFCo14xH2RHQJg3RjcIKOeYN1ZHCCjnk, enr:-Le4QKDFyKx8B5hgHUgxw3poDc0dyRsHVvgSUZwvZJs4wk5nZ1kTjMyO14l7Wzs00jg5RrekiWmiofxyjamFAKS6M48GhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAgH1W_nH-VOlkQKqz8KR4P8PcRxw027oAeXLtTYr3ykng3RjcIKMI4N1ZHCCjCM"}
11:38:48 {"level":30,"time":1748432328760,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4","listen":"127.0.0.1","port":41193,"announce":"/ip4/127.0.0.1/tcp/41193","peerId":"16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6","msg":"Started P2P service"}
11:38:48 {"level":30,"time":1748432328761,"pid":55,"hostname":"1edb79b5733e","module":"p2p","syncedLatestBlock":1,"syncedProvenBlock":1,"syncedFinalizedBlock":1,"msg":"Starting P2P client synced to 1"}
11:38:48 {"level":30,"time":1748432328795,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2","listen":"127.0.0.1","port":46219,"announce":"/ip4/127.0.0.1/tcp/46219","peerId":"16Uiu2HAmKaG6EMqzcH7ehQguNgFWaYoJbqir8oJj8i6PhLvjEN1t","msg":"Started P2P service"}
11:38:48 {"level":30,"time":1748432328795,"pid":45,"hostname":"1edb79b5733e","module":"p2p","syncedLatestBlock":1,"syncedProvenBlock":1,"syncedFinalizedBlock":1,"msg":"Starting P2P client synced to 1"}
11:38:48 {"level":40,"time":1748432328834,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe failed to respond"}
11:38:48 {"level":40,"time":1748432328838,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe failed to respond"}
11:38:48 {"level":40,"time":1748432328839,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe sent invalid status message"}
11:38:48 {"level":40,"time":1748432328841,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe sent invalid status message"}
11:38:48 {"level":40,"time":1748432328845,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:peer_manager","msg":"Peer 16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6 failed to respond"}
11:38:48 {"level":40,"time":1748432328847,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:peer_manager","msg":"Peer 16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6 sent invalid status message"}
11:39:00 [11:39:00.036]
INFO:
testbench-ports Workers Ready
11:39:00 [11:39:00.324]
INFO:
testbench-ports Transaction sent from client 2
11:39:00 {"level":50,"time":1748432340785,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4","msg":"Error handling gossipsub message: Error: Attempted to read beyond buffer length. Start index: 0, Num bytes to read: 1, Buffer length: 0"}
11:39:00 {"level":50,"time":1748432340788,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1","msg":"Error handling gossipsub message: Error: Attempted to read beyond buffer length. Start index: 0, Num bytes to read: 1, Buffer length: 0"}
11:39:00 {"level":50,"time":1748432340792,"pid":33,"hostname":"1edb79b5733e","module":"p2p:0","msg":"Error handling gossipsub message: Error: Attempted to read beyond buffer length. Start index: 0, Num bytes to read: 1, Buffer length: 0"}
11:39:00 {"level":50,"time":1748432340795,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3","msg":"Error handling gossipsub message: Error: Attempted to read beyond buffer length. Start index: 0, Num bytes to read: 1, Buffer length: 0"}
11:39:10 [11:39:10.326]
INFO:
testbench-ports Checking message propagation results
11:39:10 [11:39:10.329]
INFO:
testbench-ports Number of clients that received message: 4
11:39:10 [11:39:10.331]
INFO:
testbench-ports All clients received message
11:39:10 [11:39:10.332]
INFO:
testbench-ports Iteration 1 done
11:39:10 [11:39:10.332]
INFO:
testbench-ports Changing port for client 0
11:39:10 {"level":30,"time":1748432350433,"pid":33,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Stopping connection sampler"}
11:39:10 {"level":30,"time":1748432350434,"pid":33,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Connection sampler stopped"}
11:39:10 {"level":30,"time":1748432350455,"pid":33,"hostname":"1edb79b5733e","module":"p2p","msg":"P2P client stopped."}
11:39:10 {"level":30,"time":1748432350454,"pid":33,"hostname":"1edb79b5733e","module":"p2p:0","msg":"LibP2P service stopped"}
11:39:10 [11:39:10.687]
WARN:
testbench-ports Worker 0 exited unexpectedly with code null and signal SIGSEGV
11:39:20 [11:39:20.334]
INFO:
testbench-ports Changing port for client 0 to 43815
11:39:20 [11:39:20.346]
INFO:
testbench-ports Changing port for client 0 to 43815 with other nodes
{"0":"enr:-Le4QKDFyKx8B5hgHUgxw3poDc0dyRsHVvgSUZwvZJs4wk5nZ1kTjMyO14l7Wzs00jg5RrekiWmiofxyjamFAKS6M48GhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAgH1W_nH-VOlkQKqz8KR4P8PcRxw027oAeXLtTYr3ykng3RjcIKMI4N1ZHCCjCM","1":"enr:-Le4QPi3bO6ntlGF6NHzH1z0ULTNen6hnw6qJqQ2tBVCNMBIERO1gS_Hqi0qEZtoPvSKYj6Nu0aORVKUOQ7Rj8RYFsMGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhA2bLs76yz8BYArhJhWCX-edQCJ2Z1cvRlfkGFA2ZHZWvg3RjcIK0i4N1ZHCCtIs","2":"enr:-Le4QDpQeBXeELamfZOAqqVCGkGJVU71v_1B8xxjEAckRah3S8SwMSp1qBYSfopgU1dFV3keDoYgWquJc72zl6WaFxIGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhA32zAwJpfCC6pbnWwYbbPLJq-F77SVyV8PYhhTBntZAYg3RjcIKcSYN1ZHCCnEk","3":"enr:-Le4QBDSkRMTXl1XUpsc_wcrzo3CGK4MeDAxq00evswQV9mpdz-nDICGSxhpPfdgpnjhDH72c1qPMHc4sbtENVyaSbgGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAtjVAfkA9IBELvJ_ijaSxFcCN1rIF0qM6FvTguAUUvcng3RjcIKg6YN1ZHCCoOk"}
11:39:27 {"level":30,"time":1748432367015,"pid":97,"hostname":"1edb79b5733e","module":"kv-store:lmdb-v2:test-0","msg":"Starting data store with maxReaders 16"}
11:39:27 {"level":30,"time":1748432367023,"pid":97,"hostname":"1edb79b5733e","module":"p2p-archive:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:39:27 {"level":30,"time":1748432367025,"pid":97,"hostname":"1edb79b5733e","module":"p2p-peer:lmdb-v2","msg":"Starting data store with maxReaders 16"}
11:39:27 {"level":30,"time":1748432367227,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:libp2p_service","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:39:27 {"level":30,"time":1748432367257,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0","msg":"Started libp2p service with protocol version 00-31337-2b91f135-1-1b2a4a4e-14d3fff1"}
11:39:27 {"level":30,"time":1748432367299,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:discv5_service","nodeId":"d8ed614d4336d9b52be4827a046b8e48dcbbbbcaa54a7c14b2ca0b6ed8b5481d","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","enrUdp":"/ip4/127.0.0.1/udp/43815/p2p/16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","enrTcp":"/ip4/127.0.0.1/tcp/43815/p2p/16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","versions":{"l1ChainId":31337,"l1RollupAddress":"0x2b91f1358f14bd001a47f28c21c47efdb3e58944","rollupVersion":1,"l2ProtocolContractsTreeRoot":"0x1b2a4a4ec8bae4ea0ca779e8f02c8d46d20f3b0a1d866a2f7d9fab76222f7a3d","l2CircuitsVkTreeRoot":"0x14d3fff1f379a093f37ec20306c562b138fb10fc992ac31f007fe8df494d92a1"},"msg":"DiscV5 service started"}
11:39:27 {"level":30,"time":1748432367306,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:discv5_service","msg":"Adding 4 bootstrap nodes ENRs: enr:-Le4QKDFyKx8B5hgHUgxw3poDc0dyRsHVvgSUZwvZJs4wk5nZ1kTjMyO14l7Wzs00jg5RrekiWmiofxyjamFAKS6M48GhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAgH1W_nH-VOlkQKqz8KR4P8PcRxw027oAeXLtTYr3ykng3RjcIKMI4N1ZHCCjCM, enr:-Le4QPi3bO6ntlGF6NHzH1z0ULTNen6hnw6qJqQ2tBVCNMBIERO1gS_Hqi0qEZtoPvSKYj6Nu0aORVKUOQ7Rj8RYFsMGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhA2bLs76yz8BYArhJhWCX-edQCJ2Z1cvRlfkGFA2ZHZWvg3RjcIK0i4N1ZHCCtIs, enr:-Le4QDpQeBXeELamfZOAqqVCGkGJVU71v_1B8xxjEAckRah3S8SwMSp1qBYSfopgU1dFV3keDoYgWquJc72zl6WaFxIGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhA32zAwJpfCC6pbnWwYbbPLJq-F77SVyV8PYhhTBntZAYg3RjcIKcSYN1ZHCCnEk, enr:-Le4QBDSkRMTXl1XUpsc_wcrzo3CGK4MeDAxq00evswQV9mpdz-nDICGSxhpPfdgpnjhDH72c1qPMHc4sbtENVyaSbgGhWF6dGVjpTAwLTMxMzM3LTJiOTFmMTM1LTEtMWIyYTRhNGUtMTRkM2ZmZjGCaWSCdjSCaXCEfwAAAYlzZWNwMjU2azGhAtjVAfkA9IBELvJ_ijaSxFcCN1rIF0qM6FvTguAUUvcng3RjcIKg6YN1ZHCCoOk"}
11:39:27 {"level":50,"time":1748432367559,"pid":34,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:27 {"level":40,"time":1748432367560,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:27 {"level":50,"time":1748432367561,"pid":34,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:27 {"level":40,"time":1748432367561,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:27 {"level":40,"time":1748432367562,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn sent invalid status message"}
11:39:27 {"level":40,"time":1748432367564,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn sent invalid status message"}
11:39:27 {"level":50,"time":1748432367592,"pid":45,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:27 {"level":40,"time":1748432367593,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:27 {"level":50,"time":1748432367594,"pid":45,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:27 {"level":40,"time":1748432367594,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:27 {"level":40,"time":1748432367594,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn sent invalid status message"}
11:39:27 {"level":40,"time":1748432367596,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn sent invalid status message"}
11:39:27 {"level":40,"time":1748432367669,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe failed to respond"}
11:39:27 {"level":50,"time":1748432367678,"pid":47,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:27 {"level":40,"time":1748432367678,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:27 {"level":50,"time":1748432367680,"pid":47,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:27 {"level":40,"time":1748432367680,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:27 {"level":40,"time":1748432367681,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn sent invalid status message"}
11:39:27 {"level":40,"time":1748432367688,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn sent invalid status message"}
11:39:27 {"level":40,"time":1748432367670,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe sent invalid status message"}
11:39:27 {"level":40,"time":1748432367677,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe failed to respond"}
11:39:27 {"level":40,"time":1748432367677,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe sent invalid status message"}
11:39:27 {"level":30,"time":1748432367937,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0","listen":"127.0.0.1","port":43815,"announce":"/ip4/127.0.0.1/tcp/43815","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","msg":"Started P2P service"}
11:39:27 {"level":30,"time":1748432367937,"pid":97,"hostname":"1edb79b5733e","module":"p2p","syncedLatestBlock":1,"syncedProvenBlock":1,"syncedFinalizedBlock":1,"msg":"Starting P2P client synced to 1"}
11:39:31 [11:39:31.967]
INFO:
testbench-ports Transaction sent from client 1
11:39:32 {"level":50,"time":1748432372309,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3","msg":"Error handling gossipsub message: Error: Attempted to read beyond buffer length. Start index: 0, Num bytes to read: 1, Buffer length: 0"}
11:39:32 {"level":50,"time":1748432372317,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2","msg":"Error handling gossipsub message: Error: Attempted to read beyond buffer length. Start index: 0, Num bytes to read: 1, Buffer length: 0"}
11:39:32 {"level":50,"time":1748432372736,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0","msg":"Error handling gossipsub message: Error: Attempted to read beyond buffer length. Start index: 0, Num bytes to read: 1, Buffer length: 0"}
11:39:41 [11:39:41.968]
INFO:
testbench-ports Checking message propagation results
11:39:41 [11:39:41.968]
INFO:
testbench-ports Number of clients that received message: 3
11:39:41 [11:39:41.972]
INFO:
testbench-ports Cleaning up
11:39:41 [11:39:41.973]
INFO:
testbench-ports Cleaning up 5 worker processes
11:39:42 {"level":30,"time":1748432382040,"pid":34,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Stopping connection sampler"}
11:39:42 {"level":30,"time":1748432382040,"pid":34,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Connection sampler stopped"}
11:39:42 {"level":30,"time":1748432382057,"pid":45,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Stopping connection sampler"}
11:39:42 {"level":30,"time":1748432382058,"pid":97,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Stopping connection sampler"}
11:39:42 {"level":30,"time":1748432382057,"pid":45,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Connection sampler stopped"}
11:39:42 {"level":50,"time":1748432382068,"pid":47,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:42 {"level":50,"time":1748432382069,"pid":55,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: protocol selection failed\n at Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:95:11)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNSUPPORTED_PROTOCOL',\n props: {}\n}"}
11:39:42 {"level":40,"time":1748432382068,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe failed to respond"}
11:39:42 {"level":40,"time":1748432382070,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe sent invalid status message"}
11:39:42 {"level":30,"time":1748432382058,"pid":97,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Connection sampler stopped"}
11:39:42 {"level":50,"time":1748432382062,"pid":97,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: unexpected end of input\n at Object.read (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/it-byte-stream/dist/src/index.js:86:31)\n at async Object.read (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/it-length-prefixed-stream/dist/src/index.js:51:37)\n at async read (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/multistream.js:22:17)\n at async Module.readString (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/multistream.js:33:17)\n at async Module.select (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/@libp2p/multistream-select/dist/src/select.js:72:20)\n at async ConnectionImpl.newStream [as _newStream] (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/upgrader.js:330:50)\n at async ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:94:24)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_UNEXPECTED_EOF'\n}"}
11:39:42 {"level":40,"time":1748432382062,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6 failed to respond"}
11:39:42 {"level":40,"time":1748432382063,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmA26RmQz9XdqM47mDKrZkPADbcjgDdLufnfJVbMYuhdn6 sent invalid status message"}
11:39:42 {"level":40,"time":1748432382069,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:libp2p_service:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:42 {"level":50,"time":1748432382071,"pid":55,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: CodeError: the connection is being closed\n at ConnectionImpl.newStream (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/connection/index.js:83:19)\n at Libp2pNode.dialProtocol (file:///home/aztec-dev/aztec-packages/yarn-project/node_modules/libp2p/dist/src/libp2p.js:231:27)\n at process.processTicksAndRejections (node:internal/process/task_queues:105:5)\n at async file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/serial_queue.js:56:33\n at async FifoMemoryQueue.process (file:///home/aztec-dev/aztec-packages/yarn-project/foundation/dest/queue/base_memory_queue.js:110:17) {\n code: 'ERR_CONNECTION_BEING_CLOSED',\n props: {}\n}"}
11:39:42 {"level":40,"time":1748432382071,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn failed to respond"}
11:39:42 {"level":40,"time":1748432382071,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4:peer_manager","msg":"Peer 16Uiu2HAmEjsTMi4hkZsF75DnRoUNvDXUytaf2eSYGPpTQjt2eHTn sent invalid status message"}
11:39:42 {"level":30,"time":1748432382074,"pid":45,"hostname":"1edb79b5733e","module":"p2p:2","msg":"LibP2P service stopped"}
11:39:42 {"level":30,"time":1748432382074,"pid":45,"hostname":"1edb79b5733e","module":"p2p","msg":"P2P client stopped."}
11:39:42 {"level":30,"time":1748432382077,"pid":34,"hostname":"1edb79b5733e","module":"p2p:1","msg":"LibP2P service stopped"}
11:39:42 {"level":30,"time":1748432382078,"pid":34,"hostname":"1edb79b5733e","module":"p2p","msg":"P2P client stopped."}
11:39:42 {"level":30,"time":1748432382085,"pid":55,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Stopping connection sampler"}
11:39:42 {"level":30,"time":1748432382086,"pid":97,"hostname":"1edb79b5733e","module":"p2p:0","msg":"LibP2P service stopped"}
11:39:42 {"level":30,"time":1748432382086,"pid":97,"hostname":"1edb79b5733e","module":"p2p","msg":"P2P client stopped."}
11:39:42 {"level":30,"time":1748432382085,"pid":55,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Connection sampler stopped"}
11:39:42 {"level":30,"time":1748432382088,"pid":47,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Stopping connection sampler"}
11:39:42 {"level":50,"time":1748432382090,"pid":47,"hostname":"1edb79b5733e","module":"p2p:reqresp","peerId":"16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe","subProtocol":"/aztec/req/status/0.1.0","msg":"Unexpected error sending request to peer: DOMException [AbortError]: This operation was aborted\n at new DOMException (node:internal/per_context/domexception:53:5)\n at AbortController.abort (node:internal/abort_controller:465:18)\n at ConnectionSampler.stop (file:///home/aztec-dev/aztec-packages/yarn-project/p2p/dest/services/reqresp/connection-sampler/connection_sampler.js:44:21)\n at ReqResp.stop (file:///home/aztec-dev/aztec-packages/yarn-project/p2p/dest/services/reqresp/reqresp.js:82:38)\n at async TestLibP2PService.stop (file:///home/aztec-dev/aztec-packages/yarn-project/p2p/dest/services/libp2p/libp2p_service.js:290:9)\n at async P2PClient.stop (file:///home/aztec-dev/aztec-packages/yarn-project/p2p/dest/client/p2p_client.js:230:9)\n at async process.<anonymous> (file:///home/aztec-dev/aztec-packages/yarn-project/p2p/dest/testbench/p2p_client_testbench_worker.js:166:25)"}
11:39:42 {"level":40,"time":1748432382090,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe failed to respond"}
11:39:42 {"level":30,"time":1748432382090,"pid":47,"hostname":"1edb79b5733e","module":"p2p:reqresp:connection-sampler","msg":"Connection sampler stopped"}
11:39:42 {"level":40,"time":1748432382090,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3:peer_manager","msg":"Peer 16Uiu2HAkuZKPGMJpCiAVoy3KiTXYQ8U4sjn9U8tw7JB1eCmVXnCe sent invalid status message"}
11:39:42 {"level":30,"time":1748432382099,"pid":55,"hostname":"1edb79b5733e","module":"p2p:4","msg":"LibP2P service stopped"}
11:39:42 {"level":30,"time":1748432382099,"pid":55,"hostname":"1edb79b5733e","module":"p2p","msg":"P2P client stopped."}
11:39:42 {"level":30,"time":1748432382102,"pid":47,"hostname":"1edb79b5733e","module":"p2p:3","msg":"LibP2P service stopped"}
11:39:42 {"level":30,"time":1748432382102,"pid":47,"hostname":"1edb79b5733e","module":"p2p","msg":"P2P client stopped."}
11:39:42 [11:39:42.288]
WARN:
testbench-ports Worker 4 exited unexpectedly with code null and signal SIGSEGV
11:39:42 [11:39:42.306]
WARN:
testbench-ports Worker 3 exited unexpectedly with code null and signal SIGSEGV
11:39:42 [11:39:42.338]
WARN:
testbench-ports Worker 0 exited unexpectedly with code null and signal SIGSEGV
11:39:42 [11:39:42.812]
WARN:
testbench-ports Worker 1 exited unexpectedly with code null and signal SIGSEGV
11:39:43 [11:39:43.245]
WARN:
testbench-ports Worker 2 exited unexpectedly with code null and signal SIGSEGV
11:39:43 [11:39:43.246]
INFO:
testbench-ports All worker processes cleaned up
11:39:43
FAIL src/testbench/port_change.test.ts (
65.214 s)
11:39:43 Port Change
11:39:43
✕ should change port and propagate the gossip message correctly (63444 ms)
11:39:43
11:39:43
● Port Change › should change port and propagate the gossip message correctly
11:39:43
11:39:43
expect(received).toBe
(expected) // Object.is equality
11:39:43
11:39:43 Expected:
4
11:39:43 Received:
3
11:39:43
11:39:43
75 | logger
.info(
`Number of clients that received message: ${numberOfClientsThatReceivedMessage}`)
;
11:39:43
76 |
11:39:43
> 77 | expect(numberOfClientsThatReceivedMessage).toBe(numberOfClients - 1);
11:39:43
| ^
11:39:43
78 | logger.info('All clients received message');
11:39:43
79 |
11:39:43
80 | workerClientManager.purgeMessageReceivedByClient();
11:39:43
11:39:43
at Object.toBe (testbench/port_change.test.ts:77:52)
11:39:43
11:39:43
Test Suites: 1 failed, 1 total
11:39:43
Tests: 1 failed, 1 total
11:39:43
Snapshots: 0 total
11:39:43
Time: 65.298 s
11:39:43
Ran all test suites matching /p2p\/src\/testbench\/port_change.test.ts/i
.
11:39:43
Force exiting Jest: Have you considered using `--detectOpenHandles` to detect async operations that kept running after all tests finished?