187 lines
34 KiB
Plaintext

2025-12-18 04:16:20.332 DEBUG [tests.conftest] Running fixture setup: test_id
2025-12-18 04:16:20.332 DEBUG [tests.conftest] Running test: test_unsubscribe_from_all_pubsub_topics_one_by_one with id: 2025-12-18_04-16-20__5f6660ab-45ea-424a-a038-ce37e4cfc22a
2025-12-18 04:16:20.332 DEBUG [src.steps.common] Running fixture setup: common_setup
2025-12-18 04:16:20.332 DEBUG [src.steps.relay] Running fixture setup: relay_setup
2025-12-18 04:16:20.333 DEBUG [src.steps.sharding] Running fixture setup: sharding_setup
2025-12-18 04:16:20.339 DEBUG [src.node.docker_mananger] Docker client initialized with image wakuorg/nwaku:latest
2025-12-18 04:16:20.339 DEBUG [src.node.waku_node] WakuNode instance initialized with log path ./log/docker/node1_2025-12-18_04-16-20__5f6660ab-45ea-424a-a038-ce37e4cfc22a__wakuorg_nwaku:latest.log
2025-12-18 04:16:20.340 DEBUG [src.node.waku_node] Starting Node...
2025-12-18 04:16:20.340 DEBUG [src.node.docker_mananger] Attempting to create or retrieve network waku
2025-12-18 04:16:20.341 DEBUG [src.node.docker_mananger] Network waku already exists
2025-12-18 04:16:20.341 DEBUG [src.node.docker_mananger] Generated random external IP 172.18.246.197
2025-12-18 04:16:20.341 DEBUG [src.node.docker_mananger] Generated ports ['12399', '12400', '12401', '12402', '12403']
2025-12-18 04:16:20.341 DEBUG [src.node.waku_node] Removing pubsub-topic from nwaku args
2025-12-18 04:16:20.341 DEBUG [src.node.waku_node] RLN credentials were not set
2025-12-18 04:16:20.342 INFO [src.node.waku_node] RLN credentials not set or credential store not available, starting without RLN
2025-12-18 04:16:20.342 DEBUG [src.node.waku_node] Using volumes []
2025-12-18 04:16:20.342 DEBUG [src.node.docker_mananger] docker run -i -t -p 12399:12399 -p 12400:12400 -p 12401:12401 -p 12402:12402 -p 12403:12403 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=12401 --rest-port=12399 --tcp-port=12400 --discv5-udp-port=12402 --rest-address=0.0.0.0 --nat=extip:172.18.246.197 --peer-exchange=true --discv5-discovery=true --cluster-id=2 --nodekey=66eb007394cb6ba517e7ae2d8d8dfccf9f0272809ec1552d6a77ae46ae7eee1b --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=12403 --metrics-logging=true --relay=true --filter=true
2025-12-18 04:16:20.520 DEBUG [src.node.docker_mananger] docker network connect --ip 172.18.246.197 waku 59980f6a1ae971633c9f2f0008d1ac92d07b58151ec6ffc3fd977b0052b82a7a
2025-12-18 04:16:20.552 DEBUG [src.node.docker_mananger] Container started with ID 59980f6a1ae9. Setting up logs at ./log/docker/node1_2025-12-18_04-16-20__5f6660ab-45ea-424a-a038-ce37e4cfc22a__wakuorg_nwaku:latest.log
2025-12-18 04:16:20.553 DEBUG [src.node.waku_node] Started container from image wakuorg/nwaku:latest. REST: 12399
2025-12-18 04:16:20.555 DEBUG [src.libs.common] Sleeping for 1 seconds
2025-12-18 04:16:20.592 ERROR [src.node.docker_mananger] Max retries reached for container 7e6e6b373466. Exiting log stream.
2025-12-18 04:16:21.138 ERROR [src.node.docker_mananger] Max retries reached for container 2cbc06ec261a. Exiting log stream.
2025-12-18 04:16:21.556 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/health" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:21.559 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"nodeHealth":"READY","protocolsHealth":[{"Relay":"NOT_READY","desc":"No connected peers"},{"Rln Relay":"NOT_MOUNTED"},{"Lightpush":"NOT_MOUNTED"},{"Legacy Lightpush":"NOT_MOUNTED"},{"Filter":"NOT_READY","desc":"Relay is not ready, filter will not be able to sort out messages"},{"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"}]}'
2025-12-18 04:16:21.559 INFO [src.node.waku_node] Node protocols are initialized !!
2025-12-18 04:16:21.559 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/debug/v1/info" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:21.562 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.246.197/tcp/12400/p2p/16Uiu2HAm4GmGokJ6Pn6M6FvB4afdxwAAo7TGfFnewHEJci1wpym4","/ip4/172.18.246.197/tcp/12401/ws/p2p/16Uiu2HAm4GmGokJ6Pn6M6FvB4afdxwAAo7TGfFnewHEJci1wpym4"],"enrUri":"enr:-L24QNolZWNsfEm4c08KAdwUWJyRqeE8vDL3s5jGDM2PctdiWkNBuqXruaUonUXrxKjgEPBx7o9rotttuqhPY3YT7tICgmlkgnY0gmlwhKwS9sWKbXVsdGlhZGRyc5YACASsEvbFBjBwAAoErBL2xQYwcd0DgnJzhQACAQAAiXNlY3AyNTZrMaECg3Dws-wg0tny6rZAb6BqRDKH2aDk3nIjYQOYMcbKS1ODdGNwgjBwg3VkcIIwcoV3YWt1MgU"}'
2025-12-18 04:16:21.562 INFO [src.node.waku_node] REST service is ready !!
2025-12-18 04:16:21.569 DEBUG [src.node.docker_mananger] Docker client initialized with image wakuorg/nwaku:latest
2025-12-18 04:16:21.569 DEBUG [src.node.waku_node] WakuNode instance initialized with log path ./log/docker/node2_2025-12-18_04-16-20__5f6660ab-45ea-424a-a038-ce37e4cfc22a__wakuorg_nwaku:latest.log
2025-12-18 04:16:21.569 DEBUG [src.node.waku_node] Starting Node...
2025-12-18 04:16:21.569 DEBUG [src.node.docker_mananger] Attempting to create or retrieve network waku
2025-12-18 04:16:21.570 DEBUG [src.node.docker_mananger] Network waku already exists
2025-12-18 04:16:21.570 DEBUG [src.node.docker_mananger] Generated random external IP 172.18.81.79
2025-12-18 04:16:21.571 DEBUG [src.node.docker_mananger] Generated ports ['20217', '20218', '20219', '20220', '20221']
2025-12-18 04:16:21.571 DEBUG [src.node.waku_node] Removing pubsub-topic from nwaku args
2025-12-18 04:16:21.571 DEBUG [src.node.waku_node] RLN credentials were not set
2025-12-18 04:16:21.571 INFO [src.node.waku_node] RLN credentials not set or credential store not available, starting without RLN
2025-12-18 04:16:21.571 DEBUG [src.node.waku_node] Using volumes []
2025-12-18 04:16:21.571 DEBUG [src.node.docker_mananger] docker run -i -t -p 20217:20217 -p 20218:20218 -p 20219:20219 -p 20220:20220 -p 20221:20221 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=20219 --rest-port=20217 --tcp-port=20218 --discv5-udp-port=20220 --rest-address=0.0.0.0 --nat=extip:172.18.81.79 --peer-exchange=true --discv5-discovery=true --cluster-id=2 --nodekey=796add1b6b3eeb27d5c8caae25dbbd886e0fdeb45a8e9dbb0e8de29de56313b2 --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=20221 --metrics-logging=true --relay=true --discv5-bootstrap-node=enr:-L24QNolZWNsfEm4c08KAdwUWJyRqeE8vDL3s5jGDM2PctdiWkNBuqXruaUonUXrxKjgEPBx7o9rotttuqhPY3YT7tICgmlkgnY0gmlwhKwS9sWKbXVsdGlhZGRyc5YACASsEvbFBjBwAAoErBL2xQYwcd0DgnJzhQACAQAAiXNlY3AyNTZrMaECg3Dws-wg0tny6rZAb6BqRDKH2aDk3nIjYQOYMcbKS1ODdGNwgjBwg3VkcIIwcoV3YWt1MgU
2025-12-18 04:16:21.751 DEBUG [src.node.docker_mananger] docker network connect --ip 172.18.81.79 waku 8789751e8e291f8701fadc44501cab8554e101b652200c354f5fbd3794866753
2025-12-18 04:16:21.783 DEBUG [src.node.docker_mananger] Container started with ID 8789751e8e29. Setting up logs at ./log/docker/node2_2025-12-18_04-16-20__5f6660ab-45ea-424a-a038-ce37e4cfc22a__wakuorg_nwaku:latest.log
2025-12-18 04:16:21.783 DEBUG [src.node.waku_node] Started container from image wakuorg/nwaku:latest. REST: 20217
2025-12-18 04:16:21.784 DEBUG [src.libs.common] Sleeping for 1 seconds
2025-12-18 04:16:22.784 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/health" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:22.796 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"nodeHealth":"READY","protocolsHealth":[{"Relay":"NOT_READY","desc":"No connected peers"},{"Rln Relay":"NOT_MOUNTED"},{"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":"READY"}]}'
2025-12-18 04:16:22.797 INFO [src.node.waku_node] Node protocols are initialized !!
2025-12-18 04:16:22.797 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/debug/v1/info" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:22.802 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.81.79/tcp/20218/p2p/16Uiu2HAmFuLYAi6jtB6f6Jatzh8fFYbFJdvxLD8v33yqgVrJbqjZ","/ip4/172.18.81.79/tcp/20219/ws/p2p/16Uiu2HAmFuLYAi6jtB6f6Jatzh8fFYbFJdvxLD8v33yqgVrJbqjZ"],"enrUri":"enr:-L24QL_AmKXBd2ogiLkROFdCOAdyC27b-CrICzAaz7V4efftaOebCC9x95p3Jq7Q0fOKauTI9IClKiMKrTr_sDZiE98CgmlkgnY0gmlwhKwSUU-KbXVsdGlhZGRyc5YACASsElFPBk76AAoErBJRTwZO-90DgnJzhQACAQAAiXNlY3AyNTZrMaEDMEAErAj9fhc1LHIwSIXksepb1VoA8aX_pi5PSS7WS-SDdGNwgk76g3VkcIJO_IV3YWt1MgE"}'
2025-12-18 04:16:22.803 INFO [src.node.waku_node] REST service is ready !!
2025-12-18 04:16:22.804 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:20217/admin/v1/peers" -H "Content-Type: application/json" -d '["/ip4/172.18.246.197/tcp/12400/p2p/16Uiu2HAm4GmGokJ6Pn6M6FvB4afdxwAAo7TGfFnewHEJci1wpym4"]'
2025-12-18 04:16:22.807 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:22.807 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/0", "/waku/2/rs/2/1", "/waku/2/rs/2/2", "/waku/2/rs/2/3", "/waku/2/rs/2/4", "/waku/2/rs/2/5", "/waku/2/rs/2/6", "/waku/2/rs/2/7"]'
2025-12-18 04:16:22.814 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:22.816 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/0", "/waku/2/rs/2/1", "/waku/2/rs/2/2", "/waku/2/rs/2/3", "/waku/2/rs/2/4", "/waku/2/rs/2/5", "/waku/2/rs/2/6", "/waku/2/rs/2/7"]'
2025-12-18 04:16:22.826 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:22.826 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F0" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:22.836 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:22.836 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:22.937 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:22.937 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F0" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:22.939 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031382826643368,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:22.941 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:22.941 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F0" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:22.943 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031382826643368,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:22.945 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F1" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:22.949 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:22.950 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:23.050 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.050 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F1" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.053 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031382945009574,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.054 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.054 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F1" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.056 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031382945009574,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.058 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F2" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.063 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.063 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:23.163 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.163 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F2" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.166 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383058223763,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.167 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.167 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F2" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.169 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383058223763,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.171 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F3" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.175 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.175 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:23.275 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.276 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F3" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.278 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383171151767,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.279 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.279 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F3" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.282 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383171151767,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.283 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F4" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.288 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.288 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:23.389 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.389 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F4" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.391 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383283652461,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.392 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.393 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F4" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.395 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383283652461,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.396 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F5" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.400 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.400 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:23.501 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.501 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F5" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.503 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383396589737,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.505 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.505 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F5" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.507 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383396589737,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.508 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F6" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.512 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.513 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:23.613 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.613 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F6" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.616 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383508754883,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.617 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.617 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F6" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.619 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383508754883,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.621 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F7" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.625 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.625 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2025-12-18 04:16:23.725 DEBUG [src.steps.sharding] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.726 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F7" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.728 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383621072358,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.730 DEBUG [src.steps.sharding] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2025-12-18 04:16:23.730 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:20217/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F7" -H "Content-Type: application/json" -d 'None'
2025-12-18 04:16:23.732 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"U2hhcmRpbmcgd29ya3MhIQ==","contentTopic":"/myapp/1/latest/proto","version":0,"timestamp":1766031383621072358,"ephemeral":false,"proof":""}]'
2025-12-18 04:16:23.733 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/0"]'
2025-12-18 04:16:23.739 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.739 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/0"]'
2025-12-18 04:16:23.743 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.743 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/1"]'
2025-12-18 04:16:23.746 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.747 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/1"]'
2025-12-18 04:16:23.751 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.752 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/2"]'
2025-12-18 04:16:23.756 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.757 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/2"]'
2025-12-18 04:16:23.762 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.763 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/3"]'
2025-12-18 04:16:23.767 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.767 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/3"]'
2025-12-18 04:16:23.772 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.772 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/4"]'
2025-12-18 04:16:23.776 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.777 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/4"]'
2025-12-18 04:16:23.781 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.781 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/5"]'
2025-12-18 04:16:23.785 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.785 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/5"]'
2025-12-18 04:16:23.790 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.790 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/6"]'
2025-12-18 04:16:23.795 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.795 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/6"]'
2025-12-18 04:16:23.799 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.800 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:12399/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/7"]'
2025-12-18 04:16:23.805 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.805 INFO [src.node.api_clients.base_client] curl -v -X DELETE "http://127.0.0.1:20217/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/2/7"]'
2025-12-18 04:16:23.808 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2025-12-18 04:16:23.809 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F0" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.812 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F0. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/0'
2025-12-18 04:16:23.813 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F1" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.815 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F1. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/1'
2025-12-18 04:16:23.817 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F2" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.819 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F2. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/2'
2025-12-18 04:16:23.821 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F3" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.823 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F3. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/3'
2025-12-18 04:16:23.825 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F4" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.827 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F4. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/4'
2025-12-18 04:16:23.828 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F5" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.830 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F5. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/5'
2025-12-18 04:16:23.832 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F6" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.834 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F6. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/6'
2025-12-18 04:16:23.835 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F7" -H "Content-Type: application/json" -d '{"payload": "U2hhcmRpbmcgd29ya3MhIQ==", "contentTopic": "/myapp/1/latest/proto", "timestamp": '$(date +%s%N)'}'
2025-12-18 04:16:23.837 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:12399/relay/v1/messages/%2Fwaku%2F2%2Frs%2F2%2F7. Response content: b'Failed to publish: Node not subscribed to topic: /waku/2/rs/2/7'
2025-12-18 04:16:23.840 DEBUG [tests.conftest] Running fixture teardown: test_setup
2025-12-18 04:16:23.841 DEBUG [tests.conftest] Running fixture teardown: close_open_nodes
2025-12-18 04:16:23.841 DEBUG [src.node.waku_node] Stopping container with id 59980f6a1ae9
2025-12-18 04:16:24.361 DEBUG [src.node.waku_node] Container stopped.
2025-12-18 04:16:24.361 DEBUG [src.node.waku_node] Stopping container with id 8789751e8e29
2025-12-18 04:16:24.869 DEBUG [src.node.waku_node] Container stopped.
2025-12-18 04:16:24.871 DEBUG [tests.conftest] Running fixture teardown: check_waku_log_errors
2025-12-18 04:16:24.885 DEBUG [src.node.docker_mananger] No errors found in the waku logs.
2025-12-18 04:16:24.896 DEBUG [src.node.docker_mananger] No errors found in the waku logs.