logos-messaging/logos-messaging-interop-tests
1
0
Fork 0
mirror of https://github.com/logos-messaging/logos-messaging-interop-tests.git synced 2026-02-19 05:13:13 +00:00
Code Issues Packages Projects Releases Wiki Activity
logos-messaging-interop-tests/nim/1069/data/attachments/3473e5024fbbbd0c.txt
AYAHASSAN287 2a800d3230 deploy: bbba1bd28795eb6afc962fd404062c8bcf3f2bdb
2026-02-04 17:29:28 +00:00

107 lines
18 KiB
Plaintext
Raw Blame History

2026-02-04 17:11:10.464 DEBUG [tests.conftest] Running fixture setup: test_id
2026-02-04 17:11:10.464 DEBUG [tests.conftest] Running test: test_publish_after_node_pauses_and_pauses with id: 2026-02-04_17-11-10__ecb8ac1e-8b4e-420a-afef-937c48904424
2026-02-04 17:11:10.464 DEBUG [src.steps.common] Running fixture setup: common_setup
2026-02-04 17:11:10.464 DEBUG [src.steps.relay] Running fixture setup: relay_setup
2026-02-04 17:11:10.465 DEBUG [src.steps.relay] Running fixture setup: setup_main_relay_nodes
2026-02-04 17:11:10.471 DEBUG [src.node.docker_mananger] Docker client initialized with image wakuorg/nwaku:latest
2026-02-04 17:11:10.471 DEBUG [src.node.waku_node] WakuNode instance initialized with log path ./log/docker/node1_2026-02-04_17-11-10__ecb8ac1e-8b4e-420a-afef-937c48904424__wakuorg_nwaku:latest.log
2026-02-04 17:11:10.472 DEBUG [src.node.waku_node] Starting Node...
2026-02-04 17:11:10.472 DEBUG [src.node.docker_mananger] Attempting to create or retrieve network waku
2026-02-04 17:11:10.473 DEBUG [src.node.docker_mananger] Network waku already exists
2026-02-04 17:11:10.473 DEBUG [src.node.docker_mananger] Generated random external IP 172.18.40.47
2026-02-04 17:11:10.473 DEBUG [src.node.docker_mananger] Generated ports ['56163', '56164', '56165', '56166', '56167']
2026-02-04 17:11:10.474 DEBUG [src.node.waku_node] RLN credentials were not set
2026-02-04 17:11:10.474 INFO [src.node.waku_node] RLN credentials not set or credential store not available, starting without RLN
2026-02-04 17:11:10.474 DEBUG [src.node.waku_node] Using volumes []
2026-02-04 17:11:10.474 DEBUG [src.node.docker_mananger] docker run -i -t -p 56163:56163 -p 56164:56164 -p 56165:56165 -p 56166:56166 -p 56167:56167 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=56165 --rest-port=56163 --tcp-port=56164 --discv5-udp-port=56166 --rest-address=0.0.0.0 --nat=extip:172.18.40.47 --peer-exchange=true --discv5-discovery=true --cluster-id=3 --nodekey=5cad1dfaa04249d0ef85f9f07daefcdcff7d1ea40ccce0cfb19edcf4b13bcb93 --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=56167 --metrics-logging=true --relay=true
2026-02-04 17:11:10.661 DEBUG [src.node.docker_mananger] docker network connect --ip 172.18.40.47 waku 6f2fbdf5e56b692425cc98c66f11ef9f1b5058642c6a99776d39fd33881ea96f
2026-02-04 17:11:10.695 DEBUG [src.node.docker_mananger] Container started with ID 6f2fbdf5e56b. Setting up logs at ./log/docker/node1_2026-02-04_17-11-10__ecb8ac1e-8b4e-420a-afef-937c48904424__wakuorg_nwaku:latest.log
2026-02-04 17:11:10.696 DEBUG [src.node.waku_node] Started container from image wakuorg/nwaku:latest. REST: 56163
2026-02-04 17:11:10.696 DEBUG [src.libs.common] Sleeping for 1 seconds
2026-02-04 17:11:10.748 ERROR [src.node.docker_mananger] Max retries reached for container 77f826b5a7f5. Exiting log stream.
2026-02-04 17:11:11.272 ERROR [src.node.docker_mananger] Max retries reached for container 776c577e77a6. Exiting log stream.
2026-02-04 17:11:11.696 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:56163/health" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:11.700 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":"NOT_READY","desc":"No Filter service peer available yet"}]}'
2026-02-04 17:11:11.700 INFO [src.node.waku_node] Node protocols are initialized !!
2026-02-04 17:11:11.700 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:56163/debug/v1/info" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:11.702 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.40.47/tcp/56164/p2p/16Uiu2HAmTkXkQSTEfWtYHNbrXA5GzbHSMJXic1WmPyS5UGAH3cf4","/ip4/172.18.40.47/tcp/56165/ws/p2p/16Uiu2HAmTkXkQSTEfWtYHNbrXA5GzbHSMJXic1WmPyS5UGAH3cf4"],"enrUri":"enr:-L24QErUUgJGwGsNeI7jmQ1-ahqZ1nTbdF-TMduataGNd8qpYM_oAvMeTjOsXsmSDo0EENmbjFfZmE4jLZTzQBX39X4CgmlkgnY0gmlwhKwSKC-KbXVsdGlhZGRyc5YACASsEigvBttkAAoErBIoLwbbZd0DgnJzhQADAQAAiXNlY3AyNTZrMaED4Eq121PGsJViR2WOoE0njBmL6mWIyZlBGHLcQBAP07uDdGNwgttkg3VkcILbZoV3YWt1MgE"}'
2026-02-04 17:11:11.702 INFO [src.node.waku_node] REST service is ready !!
2026-02-04 17:11:11.709 DEBUG [src.node.docker_mananger] Docker client initialized with image wakuorg/nwaku:latest
2026-02-04 17:11:11.709 DEBUG [src.node.waku_node] WakuNode instance initialized with log path ./log/docker/node2_2026-02-04_17-11-10__ecb8ac1e-8b4e-420a-afef-937c48904424__wakuorg_nwaku:latest.log
2026-02-04 17:11:11.709 DEBUG [src.node.waku_node] Starting Node...
2026-02-04 17:11:11.710 DEBUG [src.node.docker_mananger] Attempting to create or retrieve network waku
2026-02-04 17:11:11.711 DEBUG [src.node.docker_mananger] Network waku already exists
2026-02-04 17:11:11.711 DEBUG [src.node.docker_mananger] Generated random external IP 172.18.163.191
2026-02-04 17:11:11.711 DEBUG [src.node.docker_mananger] Generated ports ['14129', '14130', '14131', '14132', '14133']
2026-02-04 17:11:11.711 DEBUG [src.node.waku_node] RLN credentials were not set
2026-02-04 17:11:11.712 INFO [src.node.waku_node] RLN credentials not set or credential store not available, starting without RLN
2026-02-04 17:11:11.712 DEBUG [src.node.waku_node] Using volumes []
2026-02-04 17:11:11.712 DEBUG [src.node.docker_mananger] docker run -i -t -p 14129:14129 -p 14130:14130 -p 14131:14131 -p 14132:14132 -p 14133:14133 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=14131 --rest-port=14129 --tcp-port=14130 --discv5-udp-port=14132 --rest-address=0.0.0.0 --nat=extip:172.18.163.191 --peer-exchange=true --discv5-discovery=true --cluster-id=3 --nodekey=5baae4d2a839d64d1c172bae5ed6c9dbb9c5fef62bde034a83b4f988bfbcceeb --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=14133 --metrics-logging=true --relay=true --discv5-bootstrap-node=enr:-L24QErUUgJGwGsNeI7jmQ1-ahqZ1nTbdF-TMduataGNd8qpYM_oAvMeTjOsXsmSDo0EENmbjFfZmE4jLZTzQBX39X4CgmlkgnY0gmlwhKwSKC-KbXVsdGlhZGRyc5YACASsEigvBttkAAoErBIoLwbbZd0DgnJzhQADAQAAiXNlY3AyNTZrMaED4Eq121PGsJViR2WOoE0njBmL6mWIyZlBGHLcQBAP07uDdGNwgttkg3VkcILbZoV3YWt1MgE
2026-02-04 17:11:11.901 DEBUG [src.node.docker_mananger] docker network connect --ip 172.18.163.191 waku 72c1c7a64dbff8d0ac042bb830f8622654655fe831f0037b50817dc7fa6077be
2026-02-04 17:11:11.934 DEBUG [src.node.docker_mananger] Container started with ID 72c1c7a64dbf. Setting up logs at ./log/docker/node2_2026-02-04_17-11-10__ecb8ac1e-8b4e-420a-afef-937c48904424__wakuorg_nwaku:latest.log
2026-02-04 17:11:11.935 DEBUG [src.node.waku_node] Started container from image wakuorg/nwaku:latest. REST: 14129
2026-02-04 17:11:11.936 DEBUG [src.libs.common] Sleeping for 1 seconds
2026-02-04 17:11:12.936 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:14129/health" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:12.948 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":"NOT_READY","desc":"No Filter service peer available yet"}]}'
2026-02-04 17:11:12.950 INFO [src.node.waku_node] Node protocols are initialized !!
2026-02-04 17:11:12.951 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:14129/debug/v1/info" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:12.955 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.163.191/tcp/14130/p2p/16Uiu2HAmHYqBDfa8KVtboC2YxEe8G66Hbh5LH6mFupJ6CV6aeZTX","/ip4/172.18.163.191/tcp/14131/ws/p2p/16Uiu2HAmHYqBDfa8KVtboC2YxEe8G66Hbh5LH6mFupJ6CV6aeZTX"],"enrUri":"enr:-L24QOgSiYo411cREpxbsfT3Sk7AG-DRSbRLNzPzhEitUVEPL4TD11Zu9FRE1wMcS6NAPwZ1VvZ5zYjqGinsAJ2YuZsCgmlkgnY0gmlwhKwSo7-KbXVsdGlhZGRyc5YACASsEqO_BjcyAAoErBKjvwY3M90DgnJzhQADAQAAiXNlY3AyNTZrMaEDSLaTvfztlBFGwfWqydCez_mh9Blp8OAOnWYgfhJyyvqDdGNwgjcyg3VkcII3NIV3YWt1MgE"}'
2026-02-04 17:11:12.955 INFO [src.node.waku_node] REST service is ready !!
2026-02-04 17:11:12.956 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:14129/admin/v1/peers" -H "Content-Type: application/json" -d '["/ip4/172.18.40.47/tcp/56164/p2p/16Uiu2HAmTkXkQSTEfWtYHNbrXA5GzbHSMJXic1WmPyS5UGAH3cf4"]'
2026-02-04 17:11:12.961 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2026-02-04 17:11:12.961 DEBUG [src.steps.relay] Running fixture setup: subscribe_main_relay_nodes
2026-02-04 17:11:12.962 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:56163/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/3/1"]'
2026-02-04 17:11:12.966 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2026-02-04 17:11:12.966 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:14129/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/3/1"]'
2026-02-04 17:11:12.971 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2026-02-04 17:11:12.972 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:56163/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)'}'
2026-02-04 17:11:12.977 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2026-02-04 17:11:12.977 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2026-02-04 17:11:13.077 DEBUG [src.steps.relay] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.078 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:56163/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.081 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"UmVsYXkgd29ya3MhIQ==","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225072972559360,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.082 DEBUG [src.steps.relay] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.082 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:14129/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.085 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"UmVsYXkgd29ya3MhIQ==","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225072972559360,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.086 INFO [src.steps.relay] WARM UP successful!!
2026-02-04 17:11:13.087 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:56163/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)'}'
2026-02-04 17:11:13.091 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2026-02-04 17:11:13.092 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2026-02-04 17:11:13.192 DEBUG [src.steps.relay] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.192 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:56163/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.195 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"UmVsYXkgd29ya3MhIQ==","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225073087271162,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.196 DEBUG [src.steps.relay] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.197 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:14129/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.199 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"UmVsYXkgd29ya3MhIQ==","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225073087271162,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.200 DEBUG [src.node.waku_node] Pausing container with id 6f2fbdf5e56b
2026-02-04 17:11:13.209 DEBUG [src.node.waku_node] Unpause container with id 6f2fbdf5e56b
2026-02-04 17:11:13.218 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:56163/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d '{"payload": "TTE=", "contentTopic": "/test/1/waku-relay/proto", "timestamp": '$(date +%s%N)'}'
2026-02-04 17:11:13.222 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2026-02-04 17:11:13.222 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2026-02-04 17:11:13.322 DEBUG [src.steps.relay] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.323 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:56163/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.325 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"TTE=","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225073217900788,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.327 DEBUG [src.steps.relay] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.327 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:14129/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.329 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"TTE=","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225073217900788,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.330 DEBUG [src.node.waku_node] Pausing container with id 72c1c7a64dbf
2026-02-04 17:11:13.339 DEBUG [src.node.waku_node] Unpause container with id 72c1c7a64dbf
2026-02-04 17:11:13.348 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:56163/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d '{"payload": "TTI=", "contentTopic": "/test/1/waku-relay/proto", "timestamp": '$(date +%s%N)'}'
2026-02-04 17:11:13.353 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
2026-02-04 17:11:13.353 DEBUG [src.libs.common] Sleeping for 0.1 seconds
2026-02-04 17:11:13.454 DEBUG [src.steps.relay] Checking that peer NODE_1:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.454 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:56163/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.456 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"TTI=","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225073348375457,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.458 DEBUG [src.steps.relay] Checking that peer NODE_2:wakuorg/nwaku:latest can find the published message
2026-02-04 17:11:13.458 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:14129/relay/v1/messages/%2Fwaku%2F2%2Frs%2F3%2F1" -H "Content-Type: application/json" -d 'None'
2026-02-04 17:11:13.460 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'[{"payload":"TTI=","contentTopic":"/test/1/waku-relay/proto","version":0,"timestamp":1770225073348375457,"ephemeral":false,"proof":""}]'
2026-02-04 17:11:13.464 DEBUG [tests.conftest] Running fixture teardown: test_setup
2026-02-04 17:11:13.464 DEBUG [tests.conftest] Running fixture teardown: close_open_nodes
2026-02-04 17:11:13.465 DEBUG [src.node.waku_node] Stopping container with id 6f2fbdf5e56b
2026-02-04 17:11:13.981 DEBUG [src.node.waku_node] Container stopped.
2026-02-04 17:11:13.982 DEBUG [src.node.waku_node] Stopping container with id 72c1c7a64dbf
2026-02-04 17:11:14.513 DEBUG [src.node.waku_node] Container stopped.
2026-02-04 17:11:14.513 DEBUG [tests.conftest] Running fixture teardown: check_waku_log_errors
2026-02-04 17:11:14.519 DEBUG [src.node.docker_mananger] No errors found in the waku logs.
2026-02-04 17:11:14.526 DEBUG [src.node.docker_mananger] No errors found in the waku logs.
Reference in New Issue View Git Blame Copy Permalink