search

maflcko / bitcoin-core

MIT License
26 stars 12 forks source link

s390x timeout #91

Closed maflcko closed 3 days ago

maflcko commented 1 month ago 

 node0 2024-10-27T20:33:46.239475Z [msghand] [src/net_processing.cpp:6260] [SendMessages] Timeout downloading block 18f9c9ae8651e9aeb776ec51943c7fb4b813b1dedae262459d1915f69c345f52 from peer=0, disconnecting 
 node0 2024-10-27T20:33:46.240419Z [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=1 
 node0 2024-10-27T20:33:46.240535Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=1 
 test  2024-10-27T20:33:46.339000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000000) 
 node0 2024-10-27T20:33:46.433441Z [net] [src/net.cpp:557] [CloseSocketDisconnect] [net] disconnecting peer=0 
 node0 2024-10-27T20:33:46.435286Z [net] [src/net_processing.cpp:1829] [FinalizeNode] [net] Cleared nodestate for peer=0 
 test  2024-10-27T20:33:46.440000Z TestFramework.p2p (DEBUG): Closed connection to: 0:0 
 node0 2024-10-27T20:33:46.534348Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending getheaders (709 bytes) peer=2 
 node0 2024-10-27T20:33:46.534911Z [msghand] [src/net_processing.cpp:5956] [SendMessages] [net] initial getheaders (1023) to peer=2 (startheight:-1) 
 node0 2024-10-27T20:33:46.535153Z [msghand] [src/net_processing.cpp:6330] [SendMessages] [net] Requesting block 18f9c9ae8651e9aeb776ec51943c7fb4b813b1dedae262459d1915f69c345f52 (1) peer=2 
 node0 2024-10-27T20:33:46.535254Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending getdata (37 bytes) peer=2 
 test  2024-10-27T20:33:46.641000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000002) 
 test  2024-10-27T20:33:47.050000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_getheaders(locator=CBlockLocator(vHave=[51028225979965589115881295727807611172333580580510573636467498638508850996547, 37346697185465419591271892594955379773421573672880910261031220352642097666271, 47497146063212786347821522065691681944014067115601124413323342786269280909619, 10155215406424420928512133715677395700252338193336708338193649843546379819750, 12596206149537312092722852210202627880578754014803501430438212157406146713615, 4988562031271065201841151199285356329364187965297931174338631... (msg truncated) 
 test  2024-10-27T20:33:47.146000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_getdata(inv=[CInv(type=WitnessBlock hash=18f9c9ae8651e9aeb776ec51943c7fb4b813b1dedae262459d1915f69c345f52)]) 
 node0 2024-10-27T20:33:47.148857Z [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=1 
 node0 2024-10-27T20:33:47.149026Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=1 
 test  2024-10-27T20:33:47.248000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000002) 
 test  2024-10-27T20:33:47.348000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000000) 
 node0 2024-10-27T20:33:47.350288Z [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=2 
 node0 2024-10-27T20:33:47.350456Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=2 
 test  2024-10-27T20:33:47.449000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000000) 
 test  2024-10-27T20:33:47.451000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000002) 
 node0 2024-10-27T20:33:47.452505Z [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=2 
 node0 2024-10-27T20:33:47.452673Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=2 
 test  2024-10-27T20:33:47.550000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000002) 
 test  2024-10-27T20:33:47.650000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000000) 
 node0 2024-10-27T20:33:47.658323Z [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=3 
 node0 2024-10-27T20:33:47.658500Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=3 
 test  2024-10-27T20:33:47.851000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000002) 
 test  2024-10-27T20:33:47.950000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000000) 
 node0 2024-10-27T20:33:47.957144Z [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=3 
 node0 2024-10-27T20:33:47.957337Z [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=3 
 test  2024-10-27T20:33:48.151000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000002) 
 node0 2024-10-27T20:33:48.254504Z [http] [src/httpserver.cpp:307] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:50332 
 node0 2024-10-27T20:33:48.255182Z [httpworker.3] [src/rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=setmocktime user=__cookie__ 
 test  2024-10-27T20:33:48.455000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000000) 
 node0 2024-10-27T20:33:48.457853Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=1 
 node0 2024-10-27T20:33:48.458306Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=1 
 test  2024-10-27T20:33:48.460000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000003) 
 test  2024-10-27T20:33:48.660000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000000) 
 node0 2024-10-27T20:33:48.662265Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=1 
 node0 2024-10-27T20:33:48.662491Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=1 
 test  2024-10-27T20:33:48.761000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000003) 
 test  2024-10-27T20:33:48.862000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000000) 
 node0 2024-10-27T20:33:49.064519Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=2 
 node0 2024-10-27T20:33:49.064742Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=2 
 test  2024-10-27T20:33:49.261000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000003) 
 test  2024-10-27T20:33:49.264000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000000) 
 node0 2024-10-27T20:33:49.362372Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=2 
 node0 2024-10-27T20:33:49.362599Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=2 
 test  2024-10-27T20:33:49.371000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000003) 
 test  2024-10-27T20:33:49.465000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000000) 
 test  2024-10-27T20:33:49.469000Z TestFramework.p2p (DEBUG): Send message to 0:0: msg_ping(nonce=00000003) 
 node0 2024-10-27T20:33:49.562511Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=3 
 node0 2024-10-27T20:33:49.562738Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=3 
 node0 2024-10-27T20:33:49.563400Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net_processing.cpp:3721] [ProcessMessage] [net] received: ping (8 bytes) peer=3 
 node0 2024-10-27T20:33:49.563524Z (mocktime: 2024-10-27T20:21:32Z) [msghand] [src/net.cpp:3807] [PushMessage] [net] sending pong (8 bytes) peer=3 
 test  2024-10-27T20:33:49.569000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000000) 
 test  2024-10-27T20:33:49.663000Z TestFramework.p2p (DEBUG): Received message from 0:0: msg_pong(nonce=00000003) 
 node0 2024-10-27T20:33:49.766495Z (mocktime: 2024-10-27T20:21:32Z) [http] [src/httpserver.cpp:307] [http_request_cb] [http] Received a POST request for / from 127.0.0.1:50332 
 node0 2024-10-27T20:33:49.767497Z (mocktime: 2024-10-27T20:21:32Z) [httpworker.2] [src/rpc/request.cpp:232] [parse] [rpc] ThreadRPCServer method=getpeerinfo user=__cookie__ 
 test  2024-10-27T20:33:49.776000Z TestFramework (ERROR): Assertion failed 
                                   Traceback (most recent call last):
                                     File "/ci_container_base/test/functional/test_framework/test_framework.py", line 132, in main
                                       self.run_test()
                                     File "/ci_container_base/ci/scratch/build-s390x-linux-gnu/test/functional/p2p_ibd_stalling.py", line 92, in run_test
                                       assert_equal(node.num_test_p2p_connections(), NUM_PEERS)
                                     File "/ci_container_base/test/functional/test_framework/util.py", line 77, in assert_equal
                                       raise AssertionError("not(%s)" % " == ".join(str(arg) for arg in (thing1, thing2) + args))
                                   AssertionError: not(3 == 4)