logos-messaging-interop-tests/nim/1084/data/attachments/3fa40c9d16052d5c.txt

[35mDEBUG   [0m tests.conftest:conftest.py:51 Running fixture setup: test_id
[35mDEBUG   [0m tests.conftest:conftest.py:57 Running test: test_relay_no_subscription with id: 2026-02-19_04-41-01__d08dcc4f-cac9-491c-91c8-e8b5698a0720
[35mDEBUG   [0m src.steps.common:common.py:19 Running fixture setup: common_setup
[35mDEBUG   [0m src.steps.relay:relay.py:28 Running fixture setup: relay_setup
[35mDEBUG   [0m src.steps.relay:relay.py:34 Running fixture setup: setup_main_relay_nodes
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:19 Docker client initialized with image wakuorg/nwaku:latest
[35mDEBUG   [0m src.node.waku_node:waku_node.py:86 WakuNode instance initialized with log path ./log/docker/node1_2026-02-19_04-41-01__d08dcc4f-cac9-491c-91c8-e8b5698a0720__wakuorg_nwaku:latest.log
[35mDEBUG   [0m src.node.waku_node:waku_node.py:90 Starting Node...
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:22 Attempting to create or retrieve network waku
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:25 Network waku already exists
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:108 Generated random external IP 172.18.242.41
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:101 Generated ports ['15835', '15836', '15837', '15838', '15839']
[35mDEBUG   [0m src.node.waku_node:waku_node.py:439 RLN credentials were not set
[32mINFO    [0m src.node.waku_node:waku_node.py:176 RLN credentials not set or credential store not available, starting without RLN
[35mDEBUG   [0m src.node.waku_node:waku_node.py:178 Using volumes []
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:49 docker run -i -t -p 15835:15835 -p 15836:15836 -p 15837:15837 -p 15838:15838 -p 15839:15839 wakuorg/nwaku:latest --listen-address=0.0.0.0 --rest=true --rest-admin=true --websocket-support=true --log-level=TRACE --rest-relay-cache-capacity=100 --websocket-port=15837 --rest-port=15835 --tcp-port=15836 --discv5-udp-port=15838 --rest-address=0.0.0.0 --nat=extip:172.18.242.41 --peer-exchange=true --discv5-discovery=true --cluster-id=3 --nodekey=ca8a047f8b64b269eed5c6cf32a66f3fbb3bd0fa21a62b195faa53334b5f8a5d --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=15839 --metrics-logging=true --relay=true
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:55 docker network connect --ip 172.18.242.41 waku d3445ea73ae7bd6194551ede2e8ddd25a698494a941949a3635da3dee6410cd2
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:58 Container started with ID d3445ea73ae7. Setting up logs at ./log/docker/node1_2026-02-19_04-41-01__d08dcc4f-cac9-491c-91c8-e8b5698a0720__wakuorg_nwaku:latest.log
[35mDEBUG   [0m src.node.waku_node:waku_node.py:190 Started container from image wakuorg/nwaku:latest. REST: 15835
[35mDEBUG   [0m src.libs.common:common.py:47 Sleeping for 1 seconds
[31m[1mERROR   [0m src.node.docker_mananger:docker_mananger.py:89 Max retries reached for container b9ca17b4b530. Exiting log stream.
[31m[1mERROR   [0m src.node.docker_mananger:docker_mananger.py:89 Max retries reached for container 57b2c2ee2ba6. Exiting log stream.
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:37 curl -v -X GET "http://127.0.0.1:15835/health" -H "Content-Type: application/json" -d 'None'
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:22 Response status code: 200. Response content: b'{"nodeHealth":"READY","connectionStatus":"Disconnected","protocolsHealth":[{"Relay":"NOT_READY","desc":"No connected peers"},{"Lightpush":"NOT_MOUNTED"},{"Legacy Lightpush":"NOT_MOUNTED"},{"Filter":"NOT_MOUNTED"},{"Store":"NOT_MOUNTED"},{"Legacy Store":"NOT_MOUNTED"},{"Peer Exchange":"READY"},{"Rendezvous":"NOT_READY","desc":"No Rendezvous peers are available yet"},{"Mix":"NOT_MOUNTED"},{"Lightpush Client":"NOT_READY","desc":"No Lightpush service peer available yet"},{"Legacy Lightpush Client":"NOT_READY","desc":"No Lightpush service peer available yet"},{"Store Client":"NOT_READY","desc":"No Store service peer available yet, neither Store service set up for the node"},{"Legacy Store Client":"NOT_READY","desc":"No Legacy Store service peers are available yet, neither Store service set up for the node"},{"Filter Client":"NOT_READY","desc":"No Filter service peer available yet"},{"Rln Relay":"NOT_MOUNTED"}]}'
[32mINFO    [0m src.node.waku_node:waku_node.py:287 Node protocols are initialized !!
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:37 curl -v -X GET "http://127.0.0.1:15835/debug/v1/info" -H "Content-Type: application/json" -d 'None'
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:22 Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.242.41/tcp/15836/p2p/16Uiu2HAm1wYjGTCUPe9Pf7BFAsuGN7RcZzcMJ7JLuRNTwxiNS5Zs","/ip4/172.18.242.41/tcp/15837/ws/p2p/16Uiu2HAm1wYjGTCUPe9Pf7BFAsuGN7RcZzcMJ7JLuRNTwxiNS5Zs"],"enrUri":"enr:-L24QL1PbXfTTtDeeMcg0X3Slrqih6K0IUBlrgLKlf7l0IitbWlgrlZSPqQYz7pZekz96nYyIG_jTe8r_edbqYulx3YCgmlkgnY0gmlwhKwS8imKbXVsdGlhZGRyc5YACASsEvIpBj3cAAoErBLyKQY93d0DgnJzhQADAQAAiXNlY3AyNTZrMaECYM1ZA_WfpZcBI7pP9tNoqNQnTy1CsQfE0GC-EgGQTZqDdGNwgj3cg3VkcII93oV3YWt1MgE"}'
[32mINFO    [0m src.node.waku_node:waku_node.py:292 REST service is ready !!
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:19 Docker client initialized with image wakuorg/nwaku:latest
[35mDEBUG   [0m src.node.waku_node:waku_node.py:86 WakuNode instance initialized with log path ./log/docker/node2_2026-02-19_04-41-01__d08dcc4f-cac9-491c-91c8-e8b5698a0720__wakuorg_nwaku:latest.log
[35mDEBUG   [0m src.node.waku_node:waku_node.py:90 Starting Node...
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:22 Attempting to create or retrieve network waku
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:25 Network waku already exists
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:108 Generated random external IP 172.18.90.100
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:101 Generated ports ['36071', '36072', '36073', '36074', '36075']
[35mDEBUG   [0m src.node.waku_node:waku_node.py:439 RLN credentials were not set
[32mINFO    [0m src.node.waku_node:waku_node.py:176 RLN credentials not set or credential store not available, starting without RLN
[35mDEBUG   [0m src.node.waku_node:waku_node.py:178 Using volumes []
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:49 docker run -i -t -p 36071:36071 -p 36072:36072 -p 36073:36073 -p 36074:36074 -p 36075:36075 wakuorg/nwaku:latest --listen-address=0.0.0.0 --rest=true --rest-admin=true --websocket-support=true --log-level=TRACE --rest-relay-cache-capacity=100 --websocket-port=36073 --rest-port=36071 --tcp-port=36072 --discv5-udp-port=36074 --rest-address=0.0.0.0 --nat=extip:172.18.90.100 --peer-exchange=true --discv5-discovery=true --cluster-id=3 --nodekey=7a7a0e0b091e2fe5590f9c0ebaf3a74ff17f4ea18983bbf5dd38cbb6e0c2baa2 --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=36075 --metrics-logging=true --relay=true --discv5-bootstrap-node=enr:-L24QL1PbXfTTtDeeMcg0X3Slrqih6K0IUBlrgLKlf7l0IitbWlgrlZSPqQYz7pZekz96nYyIG_jTe8r_edbqYulx3YCgmlkgnY0gmlwhKwS8imKbXVsdGlhZGRyc5YACASsEvIpBj3cAAoErBLyKQY93d0DgnJzhQADAQAAiXNlY3AyNTZrMaECYM1ZA_WfpZcBI7pP9tNoqNQnTy1CsQfE0GC-EgGQTZqDdGNwgj3cg3VkcII93oV3YWt1MgE
[35mDEBUG   [0m src.node.waku_node:waku_node.py:90 Starting Node...
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:22 Attempting to create or retrieve network waku
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:25 Network waku already exists
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:108 Generated random external IP 172.18.240.178
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:101 Generated ports ['7594', '7595', '7596', '7597', '7598']
[35mDEBUG   [0m src.node.waku_node:waku_node.py:439 RLN credentials were not set
[32mINFO    [0m src.node.waku_node:waku_node.py:176 RLN credentials not set or credential store not available, starting without RLN
[35mDEBUG   [0m src.node.waku_node:waku_node.py:178 Using volumes []
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:49 docker run -i -t -p 7594:7594 -p 7595:7595 -p 7596:7596 -p 7597:7597 -p 7598:7598 wakuorg/nwaku:latest --listen-address=0.0.0.0 --rest=true --rest-admin=true --websocket-support=true --log-level=TRACE --rest-relay-cache-capacity=100 --websocket-port=7596 --rest-port=7594 --tcp-port=7595 --discv5-udp-port=7597 --rest-address=0.0.0.0 --nat=extip:172.18.240.178 --peer-exchange=true --discv5-discovery=true --cluster-id=3 --nodekey=abe5c67ecb7ddf46eb5db4a66c441a0b3fdba3e1cb7ffabdf7eba5b450bbbde7 --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=7598 --metrics-logging=true --relay=true --discv5-bootstrap-node=enr:-L24QL1PbXfTTtDeeMcg0X3Slrqih6K0IUBlrgLKlf7l0IitbWlgrlZSPqQYz7pZekz96nYyIG_jTe8r_edbqYulx3YCgmlkgnY0gmlwhKwS8imKbXVsdGlhZGRyc5YACASsEvIpBj3cAAoErBLyKQY93d0DgnJzhQADAQAAiXNlY3AyNTZrMaECYM1ZA_WfpZcBI7pP9tNoqNQnTy1CsQfE0GC-EgGQTZqDdGNwgj3cg3VkcII93oV3YWt1MgE
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:55 docker network connect --ip 172.18.240.178 waku b887ac0a95717ca7f06e57dee20156393abc0f8bff3134c8dd1636b0f68ead85
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:58 Container started with ID b887ac0a9571. Setting up logs at ./log/docker/node2_2026-02-19_04-41-01__d08dcc4f-cac9-491c-91c8-e8b5698a0720__wakuorg_nwaku:latest.log
[35mDEBUG   [0m src.node.waku_node:waku_node.py:190 Started container from image wakuorg/nwaku:latest. REST: 7594
[35mDEBUG   [0m src.libs.common:common.py:47 Sleeping for 1 seconds
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:37 curl -v -X GET "http://127.0.0.1:7594/health" -H "Content-Type: application/json" -d 'None'
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:22 Response status code: 200. Response content: b'{"nodeHealth":"READY","connectionStatus":"Disconnected","protocolsHealth":[{"Relay":"NOT_READY","desc":"No connected peers"},{"Lightpush":"NOT_MOUNTED"},{"Legacy Lightpush":"NOT_MOUNTED"},{"Filter":"NOT_MOUNTED"},{"Store":"NOT_MOUNTED"},{"Legacy Store":"NOT_MOUNTED"},{"Peer Exchange":"READY"},{"Rendezvous":"NOT_READY","desc":"No Rendezvous peers are available yet"},{"Mix":"NOT_MOUNTED"},{"Lightpush Client":"NOT_READY","desc":"No Lightpush service peer available yet"},{"Legacy Lightpush Client":"NOT_READY","desc":"No Lightpush service peer available yet"},{"Store Client":"NOT_READY","desc":"No Store service peer available yet, neither Store service set up for the node"},{"Legacy Store Client":"NOT_READY","desc":"No Legacy Store service peers are available yet, neither Store service set up for the node"},{"Filter Client":"NOT_READY","desc":"No Filter service peer available yet"},{"Rln Relay":"NOT_MOUNTED"}]}'
[32mINFO    [0m src.node.waku_node:waku_node.py:287 Node protocols are initialized !!
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:37 curl -v -X GET "http://127.0.0.1:7594/debug/v1/info" -H "Content-Type: application/json" -d 'None'
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:22 Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.240.178/tcp/7595/p2p/16Uiu2HAkwdYir69np2rY7DddQk6LHYSdzQaSNwacLLFa914TRxrQ","/ip4/172.18.240.178/tcp/7596/ws/p2p/16Uiu2HAkwdYir69np2rY7DddQk6LHYSdzQaSNwacLLFa914TRxrQ"],"enrUri":"enr:-L24QPhucWf7wujH-qnRdunfDQfpUlNYim__5qwuRh0b8JSpBRAh7kjkjjecE4ezbjp0WqHJMKsdj59oWzk65Odd5RMCgmlkgnY0gmlwhKwS8LKKbXVsdGlhZGRyc5YACASsEvCyBh2rAAoErBLwsgYdrN0DgnJzhQADAQAAiXNlY3AyNTZrMaECIMIjI2ljqzJvPWYqJlR-SuXwWOVQCh6-2qlRpY6TOy2DdGNwgh2rg3VkcIIdrYV3YWt1MgE"}'
[32mINFO    [0m src.node.waku_node:waku_node.py:292 REST service is ready !!
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:37 curl -v -X POST "http://127.0.0.1:7594/admin/v1/peers" -H "Content-Type: application/json" -d '["/ip4/172.18.242.41/tcp/15836/p2p/16Uiu2HAm1wYjGTCUPe9Pf7BFAsuGN7RcZzcMJ7JLuRNTwxiNS5Zs"]'
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:22 Response status code: 200. Response content: b'OK'
[32mINFO    [0m src.node.api_clients.base_client:base_client.py:37 curl -v -X POST "http://127.0.0.1:15835/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d '{"payload": "UmVsYXkgd29ya3MhIQ==", "contentTopic": "/test/1/waku-relay/proto", "timestamp": '$(date +%s%N)'}'
[31m[1mERROR   [0m src.node.api_clients.base_client:base_client.py:16 HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:15835/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/3/1'
[35mDEBUG   [0m tests.conftest:conftest.py:59 Running fixture teardown: test_setup
[35mDEBUG   [0m tests.conftest:conftest.py:83 Running fixture teardown: close_open_nodes
[35mDEBUG   [0m src.node.waku_node:waku_node.py:234 Stopping container with id d3445ea73ae7
[35mDEBUG   [0m src.node.waku_node:waku_node.py:241 Container stopped.
[35mDEBUG   [0m src.node.waku_node:waku_node.py:234 Stopping container with id b887ac0a9571
[35mDEBUG   [0m src.node.waku_node:waku_node.py:241 Container stopped.
[35mDEBUG   [0m tests.conftest:conftest.py:98 Running fixture teardown: check_waku_log_errors
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:144 No errors found in the waku logs.
[35mDEBUG   [0m src.node.docker_mananger:docker_mananger.py:144 No errors found in the waku logs.