« part of build 11514  

Details for job b15d8ad2-10aa-46e2-b2d8-6c3d7ba8d206

failed

Name Linux x86_64 - system libs, clang
Success failed
Build Time 00:34:22
Git Head acc7bf694e26f004d2f652659167cf3b264dc460
PR 21995
Worker # 3
Base Image ubuntu1804_full_base

Pull request info

Pull# 21995
Title
Head
Mergable
Changes
Comments
User

Tasks time consumption

00:00:11 - GIT_CHECKOUT
00:01:06 - APT_INSTALL
00:00:01 - RESTORE_CACHE
00:00:32 - CONFIGURE
00:22:11 - COMPILE_AND_INSTALL
00:00:13 - UPDATE_CCACHE_CACHE
00:04:38 - RUN_UNIT_TESTS

Build log tail

                                         Traceback (most recent call last):
                                     File "/home/ubuntu/src/test/functional/test_framework/test_framework.py", line 128, in main
                                       self.run_test()
                                     File "/home/ubuntu/src/test/functional/p2p_timeouts.py", line 90, in run_test
                                       assert not no_send_node.is_connected
                                     File "/usr/lib/python3.6/contextlib.py", line 88, in __exit__
                                       next(self.gen)
                                     File "/home/ubuntu/src/test/functional/test_framework/test_node.py", line 400, in assert_debug_log
                                       self._raise_assertion_error('Expected messages "{}" does not partially match log:\n\n{}\n\n'.format(str(expected_msgs), print_log))
                                     File "/home/ubuntu/src/test/functional/test_framework/test_node.py", line 166, in _raise_assertion_error
                                       raise AssertionError(self._node_msg(msg))
                                   AssertionError: [node 0] Expected messages "['version handshake timeout peer=0', 'socket no message in first 3 seconds, 1 0 peer=1', 'socket no message in first 3 seconds, 0 0 peer=2']" does not partially match log:
                                    -
 test  2021-06-11T09:12:42.257000Z TestFramework (DEBUG): Closing down network thread 
 test  2021-06-11T09:12:42.307000Z TestFramework (INFO): Stopping nodes 
 test  2021-06-11T09:12:42.307000Z TestFramework.node0 (DEBUG): Stopping node 
 node0 2021-06-11T09:12:42.308491Z [http] [httpserver.cpp:237] [http_request_cb] Received a POST request for / from 127.0.0.1:40590 
 node0 2021-06-11T09:12:42.308724Z [httpworker.3] [rpc/request.cpp:174] [parse] ThreadRPCServer method=stop user=__cookie__ 
 node0 2021-06-11T09:12:42.308891Z [init] [httpserver.cpp:433] [InterruptHTTPServer] Interrupting HTTP server 
 node0 2021-06-11T09:12:42.309041Z [init] [httprpc.cpp:312] [InterruptHTTPRPC] Interrupting HTTP RPC server 
 node0 2021-06-11T09:12:42.309071Z [init] [rpc/server.cpp:302] [operator()] Interrupting RPC 
 node0 2021-06-11T09:12:42.309209Z [opencon] [util/thread.cpp:19] [TraceThread] opencon thread exit 
 node0 2021-06-11T09:12:42.309472Z [addcon] [util/thread.cpp:19] [TraceThread] addcon thread exit 
 node0 2021-06-11T09:12:42.309655Z [init] [init.cpp:180] [Shutdown] Shutdown: In progress... 
 node0 2021-06-11T09:12:42.309708Z [shutoff] [httprpc.cpp:317] [StopHTTPRPC] Stopping HTTP RPC server 
 node0 2021-06-11T09:12:42.309839Z [shutoff] [httpserver.cpp:648] [UnregisterHTTPHandler] Unregistering HTTP handler for / (exactmatch 1) 
 node0 2021-06-11T09:12:42.310130Z [shutoff] [httpserver.cpp:648] [UnregisterHTTPHandler] Unregistering HTTP handler for /wallet/ (exactmatch 0) 
 node0 2021-06-11T09:12:42.310428Z [shutoff] [rpc/server.cpp:314] [operator()] Stopping RPC 
 node0 2021-06-11T09:12:42.310627Z [net] [util/thread.cpp:19] [TraceThread] net thread exit 
 node0 2021-06-11T09:12:42.310660Z [shutoff] [init.cpp:347] [OnRPCStopped] RPC stopped. 
 node0 2021-06-11T09:12:42.310709Z [shutoff] [httpserver.cpp:444] [StopHTTPServer] Stopping HTTP server 
 node0 2021-06-11T09:12:42.310806Z [shutoff] [httpserver.cpp:446] [StopHTTPServer] Waiting for HTTP worker threads to exit 
 node0 2021-06-11T09:12:42.311542Z [shutoff] [httpserver.cpp:461] [StopHTTPServer] Waiting for HTTP event thread to exit 
 node0 2021-06-11T09:12:42.311588Z [http] [httpserver.cpp:285] [ThreadHTTP] Exited http event loop 
 node0 2021-06-11T09:12:42.311773Z [shutoff] [httpserver.cpp:472] [StopHTTPServer] Stopped HTTP server 
 node0 2021-06-11T09:12:42.374014Z [msghand] [util/thread.cpp:19] [TraceThread] msghand thread exit 
 node0 2021-06-11T09:12:42.596426Z [shutoff] [net.cpp:1707] [DumpAddresses] Flushed 0 addresses to peers.dat  222ms 
 node0 2021-06-11T09:12:42.596539Z [shutoff] [logging/timer.h:48] [Log] DumpAnchors: Flush 0 outbound block-relay-only peer addresses to anchors.dat started 
 node0 2021-06-11T09:12:42.613657Z [shutoff] [logging/timer.h:48] [Log] DumpAnchors: Flush 0 outbound block-relay-only peer addresses to anchors.dat completed (0.02s) 
 node0 2021-06-11T09:12:42.613840Z [scheduler] [util/thread.cpp:19] [TraceThread] scheduler thread exit 
 node0 2021-06-11T09:12:42.614748Z [shutoff] [validation.cpp:4628] [DumpMempool] Writing 0 unbroadcast transactions to disk. 
 node0 2021-06-11T09:12:42.652727Z [shutoff] [validation.cpp:4638] [DumpMempool] Dumped mempool: 2.9e-05s to copy, 0.037988s to dump 
 node0 2021-06-11T09:12:42.652819Z [shutoff] [policy/fees.cpp:971] [FlushUnconfirmed] Recorded 0 unconfirmed txs from mempool in 1.8e-05s 
 node0 2021-06-11T09:12:42.656159Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block and undo data to disk started 
 node0 2021-06-11T09:12:42.772999Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block and undo data to disk completed (116.73ms) 
 node0 2021-06-11T09:12:42.773076Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block index to disk started 
 node0 2021-06-11T09:12:42.803978Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block index to disk completed (30.67ms) 
 node0 2021-06-11T09:12:42.804082Z [shutoff] [logging/timer.h:48] [Log] FlushStateToDisk: write coins cache to disk (0 coins, 0kB) started 
 node0 2021-06-11T09:12:42.804257Z [shutoff] [txdb.cpp:138] [BatchWrite] Writing final batch of 0.00 MiB 
 node0 2021-06-11T09:12:42.804342Z [shutoff] [txdb.cpp:140] [BatchWrite] Committed 0 changed transaction outputs (out of 0) to coin database... 
 node0 2021-06-11T09:12:42.804393Z [shutoff] [logging/timer.h:48] [Log] FlushStateToDisk: write coins cache to disk (0 coins, 0kB) completed (0.00s) 
 node0 2021-06-11T09:12:42.804467Z [shutoff] [validationinterface.cpp:244] [ChainStateFlushed] Enqueuing ChainStateFlushed: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 
 node0 2021-06-11T09:12:42.804581Z [shutoff] [validationinterface.cpp:244] [operator()] ChainStateFlushed: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 
 node0 2021-06-11T09:12:42.804720Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block and undo data to disk started 
 node0 2021-06-11T09:12:42.865341Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block and undo data to disk completed (60.55ms) 
 node0 2021-06-11T09:12:42.865426Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block index to disk started 
 node0 2021-06-11T09:12:42.891775Z [shutoff] [logging/timer.h:50] [Log] FlushStateToDisk: write block index to disk completed (26.28ms) 
 node0 2021-06-11T09:12:42.891871Z [shutoff] [logging/timer.h:48] [Log] FlushStateToDisk: write coins cache to disk (0 coins, 0kB) started 
 node0 2021-06-11T09:12:42.892008Z [shutoff] [txdb.cpp:138] [BatchWrite] Writing final batch of 0.00 MiB 
 node0 2021-06-11T09:12:42.892091Z [shutoff] [txdb.cpp:140] [BatchWrite] Committed 0 changed transaction outputs (out of 0) to coin database... 
 node0 2021-06-11T09:12:42.892135Z [shutoff] [logging/timer.h:48] [Log] FlushStateToDisk: write coins cache to disk (0 coins, 0kB) completed (0.00s) 
 node0 2021-06-11T09:12:42.892193Z [shutoff] [validationinterface.cpp:244] [ChainStateFlushed] Enqueuing ChainStateFlushed: block hash=0f9188f13cb7b2c71f2a335e3a4fc328bf5beb436012afca590b1a11466e2206 
 node0 2021-06-11T09:12:42.893193Z [shutoff] [init.cpp:298] [Shutdown] Shutdown: done 
 test  2021-06-11T09:12:42.961000Z TestFramework.node0 (DEBUG): Node stopped 
 test  2021-06-11T09:12:42.962000Z TestFramework (WARNING): Not cleaning up dir /tmp/test_runner_₿_🏃_20210611_050805/p2p_timeouts_188 
 test  2021-06-11T09:12:42.962000Z TestFramework (ERROR): Test failed. Test logging available at /tmp/test_runner_₿_🏃_20210611_050805/p2p_timeouts_188/test_framework.log 
 test  2021-06-11T09:12:42.962000Z TestFramework (ERROR): 
 test  2021-06-11T09:12:42.963000Z TestFramework (ERROR): Hint: Call /home/ubuntu/src/test/functional/combine_logs.py '/tmp/test_runner_₿_🏃_20210611_050805/p2p_timeouts_188' to consolidate all logs 
 test  2021-06-11T09:12:42.963000Z TestFramework (ERROR): 
 test  2021-06-11T09:12:42.963000Z TestFramework (ERROR): If this failure happened unexpectedly or intermittently, please file a bug and provide a link or upload of the combined log. 
 test  2021-06-11T09:12:42.963000Z TestFramework (ERROR): https://github.com/bitcoin/bitcoin/issues 
 test  2021-06-11T09:12:42.963000Z TestFramework (ERROR): 


TEST                                               | STATUS    | DURATION

feature_block.py                                   | ✓ Passed  | 130 s
feature_maxuploadtarget.py                         | ✓ Passed  | 74 s
feature_segwit.py --legacy-wallet                  | ✓ Passed  | 76 s
mining_getblocktemplate_longpoll.py                | ✓ Passed  | 68 s
p2p_compactblocks.py                               | ✓ Passed  | 82 s
rpc_fundrawtransaction.py --descriptors            | ✓ Passed  | 43 s
wallet_backup.py --descriptors                     | ✓ Passed  | 44 s
wallet_backup.py --legacy-wallet                   | ✓ Passed  | 96 s
wallet_basic.py --descriptors                      | ✓ Passed  | 58 s
wallet_hd.py --descriptors                         | ✓ Passed  | 16 s
wallet_hd.py --legacy-wallet                       | ✓ Passed  | 30 s
wallet_labels.py --descriptors                     | ✓ Passed  | 6 s
wallet_labels.py --legacy-wallet                   | ✓ Passed  | 35 s
p2p_timeouts.py                                    | ✖ Failed  | 21 s

ALL                                                | ✖ Failed  | 779 s (accumulated) 
Runtime: 274 s


real    4m38.124s
user    4m26.710s
sys     0m34.508s
Build finished with exit code 1
#BUILD#b15d8ad2-10aa-46e2-b2d8-6c3d7ba8d206#: 1