Profile generation part.

python3.6-tests.log (text/x-log), 21.32 KB, created by Bug Bugs on 2017-11-01 08:27:43 UTC

Running code to generate profile data (this can take a while):
make run_profile_task
make[1]: Entering directory '/var/tmp/portage/dev-lang/python-3.6.3/work/Python-3.6.3'
: # FIXME: can't run for a cross build
LD_LIBRARY_PATH=/var/tmp/portage/dev-lang/python-3.6.3/work/Python-3.6.3 ./python -m test.regrtest --pgo || true
Run tests sequentially
0:00:00 load avg: 2.22 [  1/405] test_grammar
0:00:00 load avg: 2.36 [  2/405] test_opcodes
0:00:00 load avg: 2.36 [  3/405] test_dict
0:00:03 load avg: 2.36 [  4/405] test_builtin
0:00:04 load avg: 2.36 [  5/405] test_exceptions
0:00:04 load avg: 2.36 [  6/405] test_types
0:00:05 load avg: 2.25 [  7/405] test_unittest
0:00:15 load avg: 2.06 [  8/405] test_doctest
0:00:23 load avg: 1.98 [  9/405] test_doctest2
0:00:23 load avg: 1.98 [ 10/405] test_support
0:00:24 load avg: 1.98 [ 11/405] test___all__
0:00:33 load avg: 1.83 [ 12/405] test___future__
0:00:34 load avg: 1.83 [ 13/405] test__locale
0:00:34 load avg: 1.83 [ 14/405] test__opcode
0:00:35 load avg: 1.76 [ 15/405] test__osx_support
0:00:35 load avg: 1.76 [ 16/405] test_abc
0:00:36 load avg: 1.76 [ 17/405] test_abstract_numbers
0:00:36 load avg: 1.76 [ 18/405] test_aifc
0:00:37 load avg: 1.76 [ 19/405] test_argparse
0:00:50 load avg: 1.59 [ 20/405] test_array
0:01:01 load avg: 1.58 [ 21/405] test_asdl_parser
0:01:01 load avg: 1.58 [ 22/405] test_ast
0:01:15 load avg: 1.45 [ 23/405] test_asyncgen
0:01:16 load avg: 1.45 [ 24/405] test_asynchat
0:01:18 load avg: 1.45 [ 25/405] test_asyncio
Executing <Task finished coro=<CoroutineTests.test_async_def_wrapped.<locals>.start() done, defined at /var/tmp/portage/dev-lang/python-3.6.3/work/Python-3.6.3/Lib/test/test_asyncio/test_pep492.py:150> result=None created at /var/tmp/portage/dev-lang/python-3.6.3/work/Python-3.6.3/Lib/asyncio/base_events.py:446> took 0.326 seconds
0:05:55 load avg: 1.16 [ 26/405] test_asyncore -- test_asyncio failed in 4 min 37 sec
0:05:56 load avg: 1.16 [ 27/405] test_atexit -- test_asyncore skipped
0:05:57 load avg: 1.16 [ 28/405] test_audioop
0:05:57 load avg: 1.16 [ 29/405] test_augassign
0:05:58 load avg: 1.16 [ 30/405] test_base64
0:06:00 load avg: 1.14 [ 31/405] test_baseexception
0:06:00 load avg: 1.14 [ 32/405] test_bigaddrspace
0:06:01 load avg: 1.14 [ 33/405] test_bigmem
0:06:02 load avg: 1.14 [ 34/405] test_binascii
0:06:03 load avg: 1.14 [ 35/405] test_binhex
0:06:03 load avg: 1.14 [ 36/405] test_binop
0:06:04 load avg: 1.14 [ 37/405] test_bisect
0:06:04 load avg: 1.14 [ 38/405] test_bool
0:06:05 load avg: 1.13 [ 39/405] test_buffer
0:06:56 load avg: 1.06 [ 40/405] test_bufio -- test_buffer passed in 51 sec
0:06:58 load avg: 1.06 [ 41/405] test_bytes
0:07:11 load avg: 1.04 [ 42/405] test_bz2
0:07:20 load avg: 1.04 [ 43/405] test_calendar
0:07:36 load avg: 1.03 [ 44/405] test_call
0:07:37 load avg: 1.03 [ 45/405] test_capi
0:07:48 load avg: 0.94 [ 46/405] test_cgi
0:07:49 load avg: 0.94 [ 47/405] test_cgitb
0:07:51 load avg: 0.95 [ 48/405] test_charmapcodec
0:07:52 load avg: 0.95 [ 49/405] test_class
0:07:53 load avg: 0.95 [ 50/405] test_cmath
0:07:53 load avg: 0.95 [ 51/405] test_cmd
0:07:54 load avg: 0.95 [ 52/405] test_cmd_line
0:08:05 load avg: 0.96 [ 53/405] test_cmd_line_script
0:08:25 load avg: 0.97 [ 54/405] test_code
0:08:25 load avg: 0.97 [ 55/405] test_code_module
0:08:26 load avg: 0.97 [ 56/405] test_codeccallbacks
0:08:27 load avg: 0.97 [ 57/405] test_codecencodings_cn
0:08:29 load avg: 0.97 [ 58/405] test_codecencodings_hk
0:08:30 load avg: 1.05 [ 59/405] test_codecencodings_iso2022
0:08:32 load avg: 1.05 [ 60/405] test_codecencodings_jp
0:08:35 load avg: 1.05 [ 61/405] test_codecencodings_kr
0:08:37 load avg: 1.05 [ 62/405] test_codecencodings_tw
0:08:38 load avg: 1.05 [ 63/405] test_codecmaps_cn
0:08:38 load avg: 1.05 [ 64/405] test_codecmaps_hk
0:08:39 load avg: 1.05 [ 65/405] test_codecmaps_jp
0:08:39 load avg: 1.05 [ 66/405] test_codecmaps_kr
0:08:40 load avg: 1.05 [ 67/405] test_codecmaps_tw
0:08:41 load avg: 1.05 [ 68/405] test_codecs
0:08:49 load avg: 1.04 [ 69/405] test_codeop
0:08:50 load avg: 1.04 [ 70/405] test_collections
0:08:54 load avg: 1.04 [ 71/405] test_colorsys
0:08:55 load avg: 1.04 [ 72/405] test_compare
0:08:55 load avg: 1.04 [ 73/405] test_compile
0:08:57 load avg: 1.04 [ 74/405] test_compileall
0:09:17 load avg: 1.02 [ 75/405] test_complex
0:09:19 load avg: 1.02 [ 76/405] test_concurrent_futures
0:10:29 load avg: 0.56 [ 77/405] test_configparser -- test_concurrent_futures passed in 1 min 10 sec
0:10:32 load avg: 0.60 [ 78/405] test_contains
0:10:33 load avg: 0.60 [ 79/405] test_contextlib
0:10:33 load avg: 0.60 [ 80/405] test_copy
0:10:34 load avg: 0.60 [ 81/405] test_copyreg
0:10:35 load avg: 0.63 [ 82/405] test_coroutines
0:10:38 load avg: 0.63 [ 83/405] test_cprofile
0:10:39 load avg: 0.63 [ 84/405] test_crashers
0:10:40 load avg: 0.63 [ 85/405] test_crypt
0:10:40 load avg: 0.66 [ 86/405] test_csv
0:10:41 load avg: 0.66 [ 87/405] test_ctypes
0:10:47 load avg: 0.77 [ 88/405] test_curses
0:10:47 load avg: 0.77 [ 89/405] test_datetime -- test_curses skipped (resource denied)
0:11:09 load avg: 0.83 [ 90/405] test_dbm
0:11:10 load avg: 0.85 [ 91/405] test_dbm_dumb
0:11:11 load avg: 0.85 [ 92/405] test_dbm_gnu
0:11:13 load avg: 0.85 [ 93/405] test_dbm_ndbm
0:11:13 load avg: 0.85 [ 94/405] test_decimal
0:11:39 load avg: 0.90 [ 95/405] test_decorators
0:11:39 load avg: 0.90 [ 96/405] test_defaultdict
0:11:40 load avg: 0.91 [ 97/405] test_deque
0:12:00 load avg: 0.94 [ 98/405] test_descr
0:12:12 load avg: 0.95 [ 99/405] test_descrtut
0:12:13 load avg: 0.95 [100/405] test_devpoll
0:12:13 load avg: 0.95 [101/405] test_dict_version -- test_devpoll skipped
0:12:14 load avg: 0.95 [102/405] test_dictcomps
0:12:15 load avg: 0.95 [103/405] test_dictviews
0:12:15 load avg: 0.95 [104/405] test_difflib
0:12:22 load avg: 0.95 [105/405] test_dis
0:12:25 load avg: 0.95 [106/405] test_distutils
0:12:33 load avg: 0.96 [107/405] test_docxmlrpc
0:12:34 load avg: 0.96 [108/405] test_dtrace
0:12:35 load avg: 0.97 [109/405] test_dummy_thread
0:12:36 load avg: 0.97 [110/405] test_dummy_threading
0:12:37 load avg: 0.97 [111/405] test_dynamic
0:12:37 load avg: 0.97 [112/405] test_dynamicclassattribute
0:12:38 load avg: 0.97 [113/405] test_eintr
0:12:49 load avg: 0.82 [114/405] test_email
0:13:07 load avg: 0.87 [115/405] test_ensurepip
0:13:08 load avg: 0.87 [116/405] test_enum
0:13:13 load avg: 0.96 [117/405] test_enumerate
0:13:14 load avg: 0.96 [118/405] test_eof
0:13:15 load avg: 0.96 [119/405] test_epoll
0:13:18 load avg: 0.96 [120/405] test_errno
0:13:18 load avg: 0.96 [121/405] test_exception_hierarchy
0:13:19 load avg: 0.96 [122/405] test_exception_variations
0:13:20 load avg: 0.97 [123/405] test_extcall
0:13:21 load avg: 0.97 [124/405] test_faulthandler
0:13:46 load avg: 0.78 [125/405] test_fcntl
0:13:47 load avg: 0.78 [126/405] test_file
0:13:48 load avg: 0.78 [127/405] test_file_eintr
0:13:55 load avg: 0.81 [128/405] test_filecmp
0:13:56 load avg: 0.81 [129/405] test_fileinput
0:13:57 load avg: 0.81 [130/405] test_fileio
0:13:58 load avg: 0.81 [131/405] test_finalization
0:14:09 load avg: 0.84 [132/405] test_float
0:14:11 load avg: 0.86 [133/405] test_flufl
0:14:12 load avg: 0.86 [134/405] test_fnmatch
0:14:13 load avg: 0.86 [135/405] test_fork1
0:14:20 load avg: 0.80 [136/405] test_format
0:14:21 load avg: 0.80 [137/405] test_fractions
0:14:22 load avg: 0.80 [138/405] test_frame
0:14:24 load avg: 0.80 [139/405] test_fstring
0:14:27 load avg: 0.82 [140/405] test_ftplib
0:14:34 load avg: 0.83 [141/405] test_funcattrs
0:14:35 load avg: 0.85 [142/405] test_functools
0:14:37 load avg: 0.85 [143/405] test_future
0:14:38 load avg: 0.85 [144/405] test_future3
0:14:39 load avg: 0.85 [145/405] test_future4
0:14:39 load avg: 0.85 [146/405] test_future5
0:14:40 load avg: 0.86 [147/405] test_gc
0:15:01 load avg: 0.90 [148/405] test_gdb
0:15:02 load avg: 0.90 [149/405] test_generator_stop -- test_gdb skipped
0:15:02 load avg: 0.90 [150/405] test_generators
0:15:05 load avg: 0.91 [151/405] test_genericpath
0:15:06 load avg: 0.91 [152/405] test_genexps
0:15:07 load avg: 0.91 [153/405] test_getargs2
0:15:07 load avg: 0.91 [154/405] test_getopt
0:15:08 load avg: 0.91 [155/405] test_getpass
0:15:09 load avg: 0.91 [156/405] test_gettext
0:15:10 load avg: 0.92 [157/405] test_glob
0:15:11 load avg: 0.92 [158/405] test_global
0:15:12 load avg: 0.92 [159/405] test_grp
0:15:13 load avg: 0.92 [160/405] test_gzip
0:15:14 load avg: 0.92 [161/405] test_hash
0:15:21 load avg: 0.93 [162/405] test_hashlib
0:15:24 load avg: 0.93 [163/405] test_heapq
0:15:30 load avg: 0.94 [164/405] test_hmac
0:15:30 load avg: 0.94 [165/405] test_html
0:15:31 load avg: 0.94 [166/405] test_htmlparser
0:15:32 load avg: 0.94 [167/405] test_http_cookiejar
0:15:33 load avg: 0.94 [168/405] test_http_cookies
0:15:34 load avg: 0.94 [169/405] test_httplib
0:15:36 load avg: 0.95 [170/405] test_httpservers
0:15:41 load avg: 0.95 [171/405] test_idle
0:15:42 load avg: 0.95 [172/405] test_imaplib -- test_idle skipped
0:15:53 load avg: 0.88 [173/405] test_imghdr
0:15:54 load avg: 0.88 [174/405] test_imp
0:15:55 load avg: 0.89 [175/405] test_import
0:15:58 load avg: 0.89 [176/405] test_importlib
0:16:08 load avg: 0.91 [177/405] test_index
0:16:09 load avg: 0.91 [178/405] test_inspect
0:16:14 load avg: 0.92 [179/405] test_int
0:16:15 load avg: 0.92 [180/405] test_int_literal
0:16:16 load avg: 0.92 [181/405] test_io
0:17:42 load avg: 0.87 [182/405] test_ioctl -- test_io passed in 1 min 26 sec
0:17:43 load avg: 0.87 [183/405] test_ipaddress
0:17:45 load avg: 0.87 [184/405] test_isinstance
0:17:46 load avg: 0.96 [185/405] test_iter
0:17:47 load avg: 0.96 [186/405] test_iterlen
0:17:48 load avg: 0.96 [187/405] test_itertools
0:18:34 load avg: 1.26 [188/405] test_json -- test_itertools passed in 46 sec
0:18:47 load avg: 1.27 [189/405] test_keyword
0:18:50 load avg: 1.27 [190/405] test_keywordonlyarg
0:18:51 load avg: 1.57 [191/405] test_kqueue
0:18:52 load avg: 1.57 [192/405] test_largefile -- test_kqueue skipped
0:18:53 load avg: 1.57 [193/405] test_lib2to3
0:19:57 load avg: 1.48 [194/405] test_linecache -- test_lib2to3 passed in 1 min 4 sec
0:19:58 load avg: 1.48 [195/405] test_list
0:20:01 load avg: 1.44 [196/405] test_listcomps
0:20:02 load avg: 1.44 [197/405] test_locale
0:20:03 load avg: 1.44 [198/405] test_logging
0:20:26 load avg: 1.34 [199/405] test_long
0:20:48 load avg: 1.54 [200/405] test_longexp
0:20:50 load avg: 1.54 [201/405] test_lzma
0:20:55 load avg: 1.69 [202/405] test_macpath
0:20:56 load avg: 1.69 [203/405] test_macurl2path
0:20:57 load avg: 1.69 [204/405] test_mailbox
0:21:20 load avg: 1.87 [205/405] test_mailcap
0:21:21 load avg: 2.04 [206/405] test_marshal
0:21:22 load avg: 2.04 [207/405] test_math
0:21:33 load avg: 1.96 [208/405] test_memoryio
0:21:36 load avg: 2.20 [209/405] test_memoryview
0:21:45 load avg: 2.11 [210/405] test_metaclass
0:21:46 load avg: 2.02 [211/405] test_mimetypes
0:21:47 load avg: 2.02 [212/405] test_minidom
0:21:48 load avg: 2.02 [213/405] test_mmap
0:21:50 load avg: 1.94 [214/405] test_module
0:21:53 load avg: 1.94 [215/405] test_modulefinder
0:21:56 load avg: 1.86 [216/405] test_msilib
0:21:57 load avg: 1.86 [217/405] test_multibytecodec -- test_msilib skipped
0:22:08 load avg: 1.73 [218/405] test_multiprocessing_fork
0:22:09 load avg: 1.73 [219/405] test_multiprocessing_forkserver -- test_multiprocessing_fork skipped
0:22:10 load avg: 1.67 [220/405] test_multiprocessing_main_handling -- test_multiprocessing_forkserver skipped
0:22:11 load avg: 1.67 [221/405] test_multiprocessing_spawn -- test_multiprocessing_main_handling skipped
0:22:12 load avg: 1.67 [222/405] test_netrc -- test_multiprocessing_spawn skipped
0:22:13 load avg: 1.67 [223/405] test_nis
0:22:14 load avg: 1.67 [224/405] test_nntplib -- test_nis skipped
0:22:15 load avg: 1.62 [225/405] test_normalization
0:22:16 load avg: 1.62 [226/405] test_ntpath
0:22:18 load avg: 1.62 [227/405] test_numeric_tower
0:22:20 load avg: 1.62 [228/405] test_openpty
0:22:21 load avg: 1.57 [229/405] test_operator
0:22:22 load avg: 1.57 [230/405] test_optparse
0:22:23 load avg: 1.57 [231/405] test_ordered_dict
0:22:41 load avg: 1.48 [232/405] test_os
stty: 'standard input': Inappropriate ioctl for device
0:22:51 load avg: 1.49 [233/405] test_ossaudiodev
0:22:52 load avg: 1.49 [234/405] test_osx_env -- test_ossaudiodev skipped (resource denied)
0:22:53 load avg: 1.49 [235/405] test_parser
0:22:54 load avg: 1.49 [236/405] test_pathlib
0:22:56 load avg: 1.45 [237/405] test_pdb
0:23:00 load avg: 1.57 [238/405] test_peepholer
0:23:01 load avg: 1.57 [239/405] test_pickle
0:23:56 load avg: 1.51 [240/405] test_pickletools -- test_pickle passed in 54 sec
0:24:06 load avg: 1.59 [241/405] test_pipes
0:24:07 load avg: 1.59 [242/405] test_pkg
0:24:09 load avg: 1.59 [243/405] test_pkgimport
0:24:10 load avg: 1.59 [244/405] test_pkgutil
0:24:11 load avg: 1.55 [245/405] test_platform
0:24:13 load avg: 1.55 [246/405] test_plistlib
0:24:14 load avg: 1.55 [247/405] test_poll
0:24:26 load avg: 1.27 [248/405] test_popen
0:24:28 load avg: 1.27 [249/405] test_poplib
0:24:35 load avg: 1.17 [250/405] test_posix
0:24:37 load avg: 1.32 [251/405] test_posixpath
0:24:38 load avg: 1.32 [252/405] test_pow
0:24:40 load avg: 1.32 [253/405] test_pprint
0:24:41 load avg: 1.29 [254/405] test_print
0:24:42 load avg: 1.29 [255/405] test_profile
0:24:43 load avg: 1.29 [256/405] test_property
0:24:45 load avg: 1.29 [257/405] test_pstats
0:24:46 load avg: 1.27 [258/405] test_pty
0:24:47 load avg: 1.27 [259/405] test_pulldom
0:24:48 load avg: 1.27 [260/405] test_pwd
0:24:49 load avg: 1.27 [261/405] test_py_compile
0:24:50 load avg: 1.25 [262/405] test_pyclbr
0:25:02 load avg: 1.21 [263/405] test_pydoc
0:25:11 load avg: 1.25 [264/405] test_pyexpat
0:25:12 load avg: 1.25 [265/405] test_queue
0:25:17 load avg: 1.15 [266/405] test_quopri
0:25:19 load avg: 1.15 [267/405] test_raise
0:25:20 load avg: 1.14 [268/405] test_random
0:25:27 load avg: 1.13 [269/405] test_range
0:25:32 load avg: 1.36 [270/405] test_re
0:25:40 load avg: 1.30 [271/405] test_readline
0:25:42 load avg: 1.30 [272/405] test_regrtest
0:26:32 load avg: 1.92 [273/405] test_reprlib -- test_regrtest passed in 50 sec
0:26:33 load avg: 1.92 [274/405] test_resource
0:26:35 load avg: 1.92 [275/405] test_richcmp
0:26:36 load avg: 1.85 [276/405] test_rlcompleter
0:26:37 load avg: 1.85 [277/405] test_robotparser
0:26:38 load avg: 1.85 [278/405] test_runpy
0:26:45 load avg: 1.96 [279/405] test_sax
0:26:47 load avg: 1.96 [280/405] test_sched
0:26:48 load avg: 1.96 [281/405] test_scope
0:26:49 load avg: 1.96 [282/405] test_script_helper
0:26:51 load avg: 1.88 [283/405] test_secrets
0:26:52 load avg: 1.88 [284/405] test_select
0:27:05 load avg: 1.59 [285/405] test_selectors
0:27:21 load avg: 1.28 [286/405] test_set
0:27:36 load avg: 1.43 [287/405] test_setcomps
0:27:37 load avg: 1.43 [288/405] test_shelve
0:27:39 load avg: 1.43 [289/405] test_shlex
0:27:40 load avg: 1.48 [290/405] test_shutil
stty: 'standard input': Inappropriate ioctl for device
0:27:42 load avg: 1.48 [291/405] test_signal
0:28:12 load avg: 0.98 [292/405] test_site -- test_signal passed in 30 sec
0:28:15 load avg: 0.98 [293/405] test_slice
0:28:17 load avg: 0.98 [294/405] test_smtpd
0:28:18 load avg: 0.98 [295/405] test_smtplib
0:28:21 load avg: 0.98 [296/405] test_smtpnet
0:28:22 load avg: 0.98 [297/405] test_sndhdr -- test_smtpnet skipped (resource denied)
0:28:23 load avg: 0.98 [298/405] test_socket
0:28:54 load avg: 0.78 [299/405] test_socketserver -- test_socket passed in 30 sec
0:28:55 load avg: 0.80 [300/405] test_sort -- test_socketserver skipped (resource denied)
0:28:57 load avg: 0.80 [301/405] test_source_encoding
0:29:00 load avg: 0.80 [302/405] test_spwd
0:29:01 load avg: 0.82 [303/405] test_sqlite
0:29:02 load avg: 0.82 [304/405] test_ssl -- test_sqlite skipped
0:29:06 load avg: 0.91 [305/405] test_startfile
0:29:07 load avg: 0.91 [306/405] test_stat -- test_startfile skipped
0:29:09 load avg: 0.91 [307/405] test_statistics
0:29:14 load avg: 0.92 [308/405] test_strftime
0:29:17 load avg: 0.93 [309/405] test_string
0:29:18 load avg: 0.93 [310/405] test_string_literals
0:29:21 load avg: 0.93 [311/405] test_stringprep
0:29:23 load avg: 0.93 [312/405] test_strptime
0:29:24 load avg: 0.93 [313/405] test_strtod
0:29:30 load avg: 0.94 [314/405] test_struct
0:29:35 load avg: 0.94 [315/405] test_structmembers
0:29:36 load avg: 0.95 [316/405] test_structseq
0:29:37 load avg: 0.95 [317/405] test_subclassinit
0:29:38 load avg: 0.95 [318/405] test_subprocess
0:29:39 load avg: 0.95 [319/405] test_sunau -- test_subprocess skipped
0:29:40 load avg: 1.11 [320/405] test_sundry
0:29:42 load avg: 1.11 [321/405] test_super
0:29:43 load avg: 1.11 [322/405] test_symbol
0:29:44 load avg: 1.11 [323/405] test_symtable
0:29:45 load avg: 1.10 [324/405] test_syntax
0:29:47 load avg: 1.10 [325/405] test_sys
0:29:51 load avg: 1.10 [326/405] test_sys_setprofile
0:29:52 load avg: 1.10 [327/405] test_sys_settrace
0:29:54 load avg: 1.10 [328/405] test_sysconfig
0:29:56 load avg: 1.09 [329/405] test_syslog
0:29:57 load avg: 1.09 [330/405] test_tarfile
0:30:38 load avg: 2.19 [331/405] test_tcl -- test_tarfile passed in 41 sec
0:30:39 load avg: 2.19 [332/405] test_telnetlib -- test_tcl skipped
0:30:40 load avg: 2.34 [333/405] test_tempfile
0:30:45 load avg: 2.23 [334/405] test_textwrap
0:30:46 load avg: 2.23 [335/405] test_thread
0:30:48 load avg: 2.23 [336/405] test_threaded_import
0:30:52 load avg: 2.13 [337/405] test_threadedtempfile
0:30:53 load avg: 2.13 [338/405] test_threading
0:31:10 load avg: 2.69 [339/405] test_threading_local
0:31:16 load avg: 2.56 [340/405] test_threadsignals
0:31:22 load avg: 2.43 [341/405] test_time
0:31:25 load avg: 2.40 [342/405] test_timeit
0:31:27 load avg: 2.40 [343/405] test_timeout
0:31:28 load avg: 2.40 [344/405] test_tix -- test_timeout skipped (resource denied)
0:31:29 load avg: 2.40 [345/405] test_tk -- test_tix skipped
0:31:30 load avg: 3.17 [346/405] test_tokenize -- test_tk skipped
0:31:34 load avg: 3.17 [347/405] test_tools
0:31:47 load avg: 3.57 [348/405] test_trace
0:32:19 load avg: 3.99 [349/405] test_traceback -- test_trace passed in 32 sec
0:32:24 load avg: 3.83 [350/405] test_tracemalloc
0:32:29 load avg: 3.60 [351/405] test_ttk_guionly
0:32:30 load avg: 4.27 [352/405] test_ttk_textonly -- test_ttk_guionly skipped
0:32:31 load avg: 4.27 [353/405] test_tuple -- test_ttk_textonly skipped
0:33:15 load avg: 3.95 [354/405] test_turtle -- test_tuple passed in 44 sec
0:33:16 load avg: 3.71 [355/405] test_typechecks -- test_turtle skipped
0:33:17 load avg: 3.71 [356/405] test_typing
0:33:19 load avg: 3.71 [357/405] test_ucn
0:33:22 load avg: 3.57 [358/405] test_unary
0:33:23 load avg: 3.57 [359/405] test_unicode
0:33:33 load avg: 3.90 [360/405] test_unicode_file
0:33:34 load avg: 3.90 [361/405] test_unicode_file_functions -- test_unicode_file skipped
0:33:35 load avg: 3.67 [362/405] test_unicode_identifiers -- test_unicode_file_functions skipped
0:33:36 load avg: 3.67 [363/405] test_unicodedata
0:33:57 load avg: 3.18 [364/405] test_univnewlines
0:33:59 load avg: 3.18 [365/405] test_unpack
0:34:00 load avg: 3.18 [366/405] test_unpack_ex
0:34:01 load avg: 3.73 [367/405] test_urllib
0:34:02 load avg: 3.73 [368/405] test_urllib2
0:34:05 load avg: 3.73 [369/405] test_urllib2_localnet
0:34:08 load avg: 3.43 [370/405] test_urllib2net
0:34:09 load avg: 3.43 [371/405] test_urllib_response -- test_urllib2net skipped (resource denied)
0:34:10 load avg: 3.39 [372/405] test_urllibnet
0:34:11 load avg: 3.39 [373/405] test_urlparse -- test_urllibnet skipped (resource denied)
0:34:13 load avg: 3.39 [374/405] test_userdict
0:34:14 load avg: 3.39 [375/405] test_userlist
0:34:17 load avg: 3.20 [376/405] test_userstring
0:34:27 load avg: 3.01 [377/405] test_utf8source
0:34:28 load avg: 3.01 [378/405] test_uu
0:34:29 load avg: 3.01 [379/405] test_uuid
0:34:31 load avg: 3.41 [380/405] test_venv
0:35:11 load avg: 2.87 [381/405] test_wait3 -- test_venv passed in 40 sec
0:35:18 load avg: 2.64 [382/405] test_wait4
0:35:26 load avg: 2.40 [383/405] test_warnings
0:35:31 load avg: 2.93 [384/405] test_wave
0:35:32 load avg: 2.93 [385/405] test_weakref
0:44:17 load avg: 1.13 [386/405] test_weakset -- test_weakref passed in 8 min 45 sec
0:44:20 load avg: 1.12 [387/405] test_webbrowser
0:44:21 load avg: 1.12 [388/405] test_winconsoleio
0:44:22 load avg: 1.12 [389/405] test_winreg -- test_winconsoleio skipped
0:44:24 load avg: 1.12 [390/405] test_winsound -- test_winreg skipped
0:44:25 load avg: 1.12 [391/405] test_with -- test_winsound skipped (resource denied)
0:44:26 load avg: 1.11 [392/405] test_wsgiref
0:44:27 load avg: 1.11 [393/405] test_xdrlib
0:44:28 load avg: 1.11 [394/405] test_xml_dom_minicompat
0:44:29 load avg: 1.11 [395/405] test_xml_etree
0:44:36 load avg: 1.09 [396/405] test_xml_etree_c
0:44:45 load avg: 1.08 [397/405] test_xmlrpc
0:44:50 load avg: 1.15 [398/405] test_xmlrpc_net
0:44:51 load avg: 1.15 [399/405] test_yield_from -- test_xmlrpc_net skipped (resource denied)
0:44:53 load avg: 1.15 [400/405] test_zipapp
0:44:55 load avg: 1.15 [401/405] test_zipfile
0:45:31 load avg: 1.08 [402/405] test_zipfile64 -- test_zipfile passed in 36 sec
0:45:32 load avg: 1.08 [403/405] test_zipimport -- test_zipfile64 skipped (resource denied)
0:45:34 load avg: 1.08 [404/405] test_zipimport_support
0:45:38 load avg: 1.07 [405/405] test_zlib

Total duration: 45 min 42 sec
Tests result: FAILURE
make[1]: Leaving directory '/var/tmp/portage/dev-lang/python-3.6.3/work/Python-3.6.3'
make build_all_merge_profile
make[1]: Entering directory '/var/tmp/portage/dev-lang/python-3.6.3/work/Python-3.6.3'
true
make[1]: Leaving directory '/var/tmp/portage/dev-lang/python-3.6.3/work/Python-3.6.3'
Rebuilding with profile guided optimizations:
make clean