mirror of
https://github.com/logos-messaging/logos-messaging-interop-tests.git
synced 2026-05-27 21:09:29 +00:00
69 lines
13 KiB
Plaintext
69 lines
13 KiB
Plaintext
2026-04-22 19:39:26.968 DEBUG [tests.conftest] Running fixture setup: test_id
|
|
2026-04-22 19:39:26.969 DEBUG [tests.conftest] Running test: test_filter_subscribe_to_101_content_topics with id: 2026-04-22_19-39-26__06b07a16-336f-4269-a0a1-9ded2daebb2b
|
|
2026-04-22 19:39:26.969 DEBUG [src.steps.common] Running fixture setup: common_setup
|
|
2026-04-22 19:39:26.969 DEBUG [src.steps.filter] Running fixture setup: filter_setup
|
|
2026-04-22 19:39:26.970 DEBUG [src.steps.filter] Running fixture setup: setup_main_relay_node
|
|
2026-04-22 19:39:26.977 DEBUG [src.node.docker_mananger] Docker client initialized with image wakuorg/nwaku:latest
|
|
2026-04-22 19:39:26.977 DEBUG [src.node.waku_node] WakuNode instance initialized with log path ./log/docker/node1_2026-04-22_19-39-26__06b07a16-336f-4269-a0a1-9ded2daebb2b__wakuorg_nwaku:latest.log
|
|
2026-04-22 19:39:26.977 DEBUG [src.node.waku_node] Starting Node...
|
|
2026-04-22 19:39:26.977 DEBUG [src.node.docker_mananger] Attempting to create or retrieve network waku
|
|
2026-04-22 19:39:26.979 DEBUG [src.node.docker_mananger] Network waku already exists
|
|
2026-04-22 19:39:26.979 DEBUG [src.node.docker_mananger] Generated random external IP 172.18.4.228
|
|
2026-04-22 19:39:26.979 DEBUG [src.node.docker_mananger] Generated ports ['13835', '13836', '13837', '13838', '13839']
|
|
2026-04-22 19:39:26.979 DEBUG [src.node.waku_node] RLN credentials were not set
|
|
2026-04-22 19:39:26.979 INFO [src.node.waku_node] RLN credentials not set or credential store not available, starting without RLN
|
|
2026-04-22 19:39:26.979 DEBUG [src.node.waku_node] Using volumes []
|
|
2026-04-22 19:39:26.980 DEBUG [src.node.docker_mananger] docker run -i -t -p 13835:13835 -p 13836:13836 -p 13837:13837 -p 13838:13838 -p 13839:13839 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=13837 --rest-port=13835 --tcp-port=13836 --discv5-udp-port=13838 --rest-address=0.0.0.0 --nat=extip:172.18.4.228 --peer-exchange=true --discv5-discovery=true --cluster-id=198 --nodekey=a12d2934b2da293b526a3dfa5dda8ca555da34e9deaa4b5cd834dadc16cebddc --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=13839 --metrics-logging=true --relay=true --filter=true
|
|
2026-04-22 19:39:27.172 DEBUG [src.node.docker_mananger] docker network connect --ip 172.18.4.228 waku 536272b2fe83db84945554492835c384e352dfdbb8d30e932168fbd9b344fd59
|
|
2026-04-22 19:39:27.207 DEBUG [src.node.docker_mananger] Container started with ID 536272b2fe83. Setting up logs at ./log/docker/node1_2026-04-22_19-39-26__06b07a16-336f-4269-a0a1-9ded2daebb2b__wakuorg_nwaku:latest.log
|
|
2026-04-22 19:39:27.208 DEBUG [src.node.waku_node] Started container from image wakuorg/nwaku:latest. REST: 13835
|
|
2026-04-22 19:39:27.209 DEBUG [src.libs.common] Sleeping for 1 seconds
|
|
2026-04-22 19:39:27.343 ERROR [src.node.docker_mananger] Max retries reached for container 3def55677e78. Exiting log stream.
|
|
2026-04-22 19:39:27.767 ERROR [src.node.docker_mananger] Max retries reached for container f3e91da40252. Exiting log stream.
|
|
2026-04-22 19:39:28.209 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:13835/health" -H "Content-Type: application/json" -d 'None'
|
|
2026-04-22 19:39:28.212 INFO [src.node.api_clients.base_client] 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_READY","desc":"Relay is not ready, filter will not be able to sort out messages"},{"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"},{"Filter Client":"NOT_READY","desc":"No Filter service peer available yet"},{"Rln Relay":"NOT_MOUNTED"}]}'
|
|
2026-04-22 19:39:28.213 INFO [src.node.waku_node] Node protocols are initialized !!
|
|
2026-04-22 19:39:28.213 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:13835/debug/v1/info" -H "Content-Type: application/json" -d 'None'
|
|
2026-04-22 19:39:28.215 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.4.228/tcp/13836/p2p/16Uiu2HAkyXJjKE5CcdwyJTDRhMQNePif6pPdA2KcBoaSJoFEokRq","/ip4/172.18.4.228/tcp/13837/ws/p2p/16Uiu2HAkyXJjKE5CcdwyJTDRhMQNePif6pPdA2KcBoaSJoFEokRq"],"enrUri":"enr:-L24QB7GzXz_opMQchRJqnbZkCk2WNfrH3mSW-83OYQ0KZitDpg_JHiNEVBm0idUxGpZavNCqA33DQx9IKtti5zcabkCgmlkgnY0gmlwhKwSBOSKbXVsdGlhZGRyc5YACASsEgTkBjYMAAoErBIE5AY2Dd0DgnJzhQDGAQAAiXNlY3AyNTZrMaECPOA0nXtwGsYuCkE3anVWDkALQvYjwFp5_hmciR5Yw2yDdGNwgjYMg3VkcII2DoV3YWt1MgU"}'
|
|
2026-04-22 19:39:28.215 INFO [src.node.waku_node] REST service is ready !!
|
|
2026-04-22 19:39:28.216 DEBUG [src.steps.filter] Running fixture setup: setup_main_filter_node
|
|
2026-04-22 19:39:28.223 DEBUG [src.node.docker_mananger] Docker client initialized with image wakuorg/nwaku:latest
|
|
2026-04-22 19:39:28.223 DEBUG [src.node.waku_node] WakuNode instance initialized with log path ./log/docker/node2_2026-04-22_19-39-26__06b07a16-336f-4269-a0a1-9ded2daebb2b__wakuorg_nwaku:latest.log
|
|
2026-04-22 19:39:28.223 DEBUG [src.node.waku_node] Starting Node...
|
|
2026-04-22 19:39:28.223 DEBUG [src.node.docker_mananger] Attempting to create or retrieve network waku
|
|
2026-04-22 19:39:28.225 DEBUG [src.node.docker_mananger] Network waku already exists
|
|
2026-04-22 19:39:28.225 DEBUG [src.node.docker_mananger] Generated random external IP 172.18.31.87
|
|
2026-04-22 19:39:28.225 DEBUG [src.node.docker_mananger] Generated ports ['19527', '19528', '19529', '19530', '19531']
|
|
2026-04-22 19:39:28.225 DEBUG [src.node.waku_node] RLN credentials were not set
|
|
2026-04-22 19:39:28.225 INFO [src.node.waku_node] RLN credentials not set or credential store not available, starting without RLN
|
|
2026-04-22 19:39:28.225 DEBUG [src.node.waku_node] Using volumes []
|
|
2026-04-22 19:39:28.226 DEBUG [src.node.docker_mananger] docker run -i -t -p 19527:19527 -p 19528:19528 -p 19529:19529 -p 19530:19530 -p 19531:19531 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=19529 --rest-port=19527 --tcp-port=19528 --discv5-udp-port=19530 --rest-address=0.0.0.0 --nat=extip:172.18.31.87 --peer-exchange=true --discv5-discovery=true --cluster-id=198 --nodekey=e2bc2d7208f675447efb7bed4c1d29cbbb7aec23ddcc6c5eac3d10d9c00bdeae --shard=0 --metrics-server=true --metrics-server-address=0.0.0.0 --metrics-server-port=19531 --metrics-logging=true --relay=false --discv5-bootstrap-node=enr:-L24QB7GzXz_opMQchRJqnbZkCk2WNfrH3mSW-83OYQ0KZitDpg_JHiNEVBm0idUxGpZavNCqA33DQx9IKtti5zcabkCgmlkgnY0gmlwhKwSBOSKbXVsdGlhZGRyc5YACASsEgTkBjYMAAoErBIE5AY2Dd0DgnJzhQDGAQAAiXNlY3AyNTZrMaECPOA0nXtwGsYuCkE3anVWDkALQvYjwFp5_hmciR5Yw2yDdGNwgjYMg3VkcII2DoV3YWt1MgU --filternode=/ip4/172.18.4.228/tcp/13836/p2p/16Uiu2HAkyXJjKE5CcdwyJTDRhMQNePif6pPdA2KcBoaSJoFEokRq
|
|
2026-04-22 19:39:28.427 DEBUG [src.node.docker_mananger] docker network connect --ip 172.18.31.87 waku d59fc0499669f37465b91d0b096360d4727c2d1dffc5d2780a22c36864a9dcda
|
|
2026-04-22 19:39:28.459 DEBUG [src.node.docker_mananger] Container started with ID d59fc0499669. Setting up logs at ./log/docker/node2_2026-04-22_19-39-26__06b07a16-336f-4269-a0a1-9ded2daebb2b__wakuorg_nwaku:latest.log
|
|
2026-04-22 19:39:28.460 DEBUG [src.node.waku_node] Started container from image wakuorg/nwaku:latest. REST: 19527
|
|
2026-04-22 19:39:28.460 DEBUG [src.libs.common] Sleeping for 1 seconds
|
|
2026-04-22 19:39:29.460 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:19527/health" -H "Content-Type: application/json" -d 'None'
|
|
2026-04-22 19:39:29.463 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"nodeHealth":"READY","connectionStatus":"Disconnected","protocolsHealth":[{"Relay":"NOT_MOUNTED"},{"Lightpush":"NOT_MOUNTED"},{"Legacy Lightpush":"NOT_MOUNTED"},{"Filter":"NOT_MOUNTED"},{"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"},{"Filter Client":"NOT_READY","desc":"No Filter service peer available yet"},{"Rln Relay":"NOT_MOUNTED"}]}'
|
|
2026-04-22 19:39:29.464 INFO [src.node.waku_node] Node protocols are initialized !!
|
|
2026-04-22 19:39:29.464 INFO [src.node.api_clients.base_client] curl -v -X GET "http://127.0.0.1:19527/debug/v1/info" -H "Content-Type: application/json" -d 'None'
|
|
2026-04-22 19:39:29.466 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"listenAddresses":["/ip4/172.18.31.87/tcp/19528/p2p/16Uiu2HAkxMotPZHctgWJfa9wwK9iUH3JRXnCqWMnhJ31N7FE1sqK","/ip4/172.18.31.87/tcp/19529/ws/p2p/16Uiu2HAkxMotPZHctgWJfa9wwK9iUH3JRXnCqWMnhJ31N7FE1sqK"],"enrUri":"enr:-L24QFY3OpykDK6oOEpZXH_cSYWRJGT3ECb6wlegdGd_26oeIENuZbp7rYYoTvoiYRw13FGze4Dw_6A1p1gaf0FlHNkCgmlkgnY0gmlwhKwSH1eKbXVsdGlhZGRyc5YACASsEh9XBkxIAAoErBIfVwZMSd0DgnJzhQDGAQAAiXNlY3AyNTZrMaECK5WthfSwgQ4C5QaykhI6UNt39qkqK2Q9AlzurzTg3oqDdGNwgkxIg3VkcIJMSoV3YWt1MgA"}'
|
|
2026-04-22 19:39:29.466 INFO [src.node.waku_node] REST service is ready !!
|
|
2026-04-22 19:39:29.467 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:19527/admin/v1/peers" -H "Content-Type: application/json" -d '["/ip4/172.18.4.228/tcp/13836/p2p/16Uiu2HAkyXJjKE5CcdwyJTDRhMQNePif6pPdA2KcBoaSJoFEokRq"]'
|
|
2026-04-22 19:39:29.490 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
|
|
2026-04-22 19:39:29.492 DEBUG [src.steps.filter] Running fixture setup: subscribe_main_nodes
|
|
2026-04-22 19:39:29.493 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:13835/relay/v1/subscriptions" -H "Content-Type: application/json" -d '["/waku/2/rs/198/1"]'
|
|
2026-04-22 19:39:29.504 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'OK'
|
|
2026-04-22 19:39:29.504 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:19527/filter/v2/subscriptions" -H "Content-Type: application/json" -d '{"requestId": "1f80d204-8e07-4eb4-9856-09959ba9a4e2", "contentFilters": ["/test/1/waku-filter/proto"], "pubsubTopic": "/waku/2/rs/198/1"}'
|
|
2026-04-22 19:39:29.518 INFO [src.node.api_clients.base_client] Response status code: 200. Response content: b'{"requestId":"1f80d204-8e07-4eb4-9856-09959ba9a4e2","statusDesc":"OK"}'
|
|
2026-04-22 19:39:29.519 INFO [src.node.api_clients.base_client] curl -v -X POST "http://127.0.0.1:19527/filter/v2/subscriptions" -H "Content-Type: application/json" -d '{"requestId": "1", "contentFilters": ["0", "1", "2", "3", "4", "5", "6", "7", "8", "9", "10", "11", "12", "13", "14", "15", "16", "17", "18", "19", "20", "21", "22", "23", "24", "25", "26", "27", "28", "29", "30", "31", "32", "33", "34", "35", "36", "37", "38", "39", "40", "41", "42", "43", "44", "45", "46", "47", "48", "49", "50", "51", "52", "53", "54", "55", "56", "57", "58", "59", "60", "61", "62", "63", "64", "65", "66", "67", "68", "69", "70", "71", "72", "73", "74", "75", "76", "77", "78", "79", "80", "81", "82", "83", "84", "85", "86", "87", "88", "89", "90", "91", "92", "93", "94", "95", "96", "97", "98", "99", "100"], "pubsubTopic": "/waku/2/rs/198/1"}'
|
|
2026-04-22 19:39:29.528 ERROR [src.node.api_clients.base_client] HTTP error occurred: 400 Client Error: Bad Request for url: http://127.0.0.1:19527/filter/v2/subscriptions. Response content: b'{"requestId":"1","statusDesc":"BAD_REQUEST: exceeds maximum content topics: 100"}'
|
|
2026-04-22 19:39:29.532 DEBUG [tests.conftest] Running fixture teardown: test_setup
|
|
2026-04-22 19:39:29.533 DEBUG [tests.conftest] Running fixture teardown: close_open_nodes
|
|
2026-04-22 19:39:29.533 DEBUG [src.node.waku_node] Stopping container with id 536272b2fe83
|
|
2026-04-22 19:39:30.012 DEBUG [src.node.waku_node] Container stopped.
|
|
2026-04-22 19:39:30.014 DEBUG [src.node.waku_node] Stopping container with id d59fc0499669
|
|
2026-04-22 19:39:30.445 DEBUG [src.node.waku_node] Container stopped.
|
|
2026-04-22 19:39:30.448 DEBUG [tests.conftest] Running fixture teardown: check_waku_log_errors
|
|
2026-04-22 19:39:30.456 DEBUG [src.node.docker_mananger] No errors found in the waku logs.
|
|
2026-04-22 19:39:30.462 DEBUG [src.node.docker_mananger] No errors found in the waku logs.
|