builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-005 starttime: 1507401073.78 results: success (0) revision: 9802ea8f6220173617b75cb0ab740f1e1f88f8ad ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:13.780920) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:13.784982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:13.785312) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:13.844353) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:13.844689) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-07 11:31:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 67.7M=0s 2017-10-07 11:31:14 (67.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.363069 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:14.226409) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:14.226777) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014936 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:14.276730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:14.277176) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9802ea8f6220173617b75cb0ab740f1e1f88f8ad --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9802ea8f6220173617b75cb0ab740f1e1f88f8ad --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-07 11:31:14,333 truncating revision to first 12 chars 2017-10-07 11:31:14,333 Setting DEBUG logging. 2017-10-07 11:31:14,333 attempt 1/10 2017-10-07 11:31:14,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9802ea8f6220?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-07 11:31:14,743 unpacking tar archive at: mozilla-beta-9802ea8f6220/testing/mozharness/ program finished with exit code 0 elapsedTime=0.752623 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:15.047302) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:15.047658) ========= script_repo_revision: 9802ea8f6220173617b75cb0ab740f1e1f88f8ad ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:15.048098) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:15.048406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-07 11:31:15.063233) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-07 11:31:15.063595) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:15 INFO - MultiFileLogger online at 20171007 11:31:15 in /builds/slave/test 11:31:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta-Non-PGO 11:31:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:15 INFO - {'append_to_log': False, 11:31:15 INFO - 'base_work_dir': '/builds/slave/test', 11:31:15 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 11:31:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:15 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 11:31:15 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:15 INFO - 'code_coverage': False, 11:31:15 INFO - 'config_files': ('talos/linux_config.py',), 11:31:15 INFO - 'default_actions': ('clobber', 11:31:15 INFO - 'read-buildbot-config', 11:31:15 INFO - 'download-and-extract', 11:31:15 INFO - 'populate-webroot', 11:31:15 INFO - 'create-virtualenv', 11:31:15 INFO - 'install', 11:31:15 INFO - 'setup-mitmproxy', 11:31:15 INFO - 'run-tests'), 11:31:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:15 INFO - 'disable_ccov_upload': False, 11:31:15 INFO - 'disable_stylo': False, 11:31:15 INFO - 'download_minidump_stackwalk': True, 11:31:15 INFO - 'download_symbols': 'ondemand', 11:31:15 INFO - 'enable_stylo': False, 11:31:15 INFO - 'enable_webrender': False, 11:31:15 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 11:31:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:15 INFO - 'gecko_profile': False, 11:31:15 INFO - 'gecko_profile_interval': 0, 11:31:15 INFO - 'installer_path': 'installer.exe', 11:31:15 INFO - 'log_level': 'info', 11:31:15 INFO - 'log_name': 'talos', 11:31:15 INFO - 'log_to_console': True, 11:31:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:15 INFO - 'opt_config_files': (), 11:31:15 INFO - 'pip_index': False, 11:31:15 INFO - 'suite': 'dromaeojs-e10s', 11:31:15 INFO - 'system_bits': '32', 11:31:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:15 INFO - 'title': 'talos-linux64-ix-005', 11:31:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:15 INFO - 'use_talos_json': True, 11:31:15 INFO - 'verify': 'False', 11:31:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:15 INFO - 'work_dir': 'build'} 11:31:15 INFO - [mozharness: 2017-10-07 18:31:15.260884Z] Running clobber step. 11:31:15 INFO - Running pre-action listener: _resource_record_pre_action 11:31:15 INFO - Running main action method: clobber 11:31:15 INFO - rmtree: /builds/slave/test/build 11:31:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:16 INFO - Running post-action listener: _resource_record_post_action 11:31:16 INFO - [mozharness: 2017-10-07 18:31:16.776326Z] Finished clobber step (success) 11:31:16 INFO - [mozharness: 2017-10-07 18:31:16.776423Z] Running read-buildbot-config step. 11:31:16 INFO - Running pre-action listener: _resource_record_pre_action 11:31:16 INFO - Running main action method: read_buildbot_config 11:31:16 INFO - Using buildbot properties: 11:31:16 INFO - { 11:31:16 INFO - "project": "", 11:31:16 INFO - "product": "firefox", 11:31:16 INFO - "who": "ryanvm@gmail.com", 11:31:16 INFO - "installer_path": "public/build/target.tar.bz2", 11:31:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 11:31:16 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 11:31:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 11:31:16 INFO - "stage_platform": "linux64", 11:31:16 INFO - "basedir": "/builds/slave/test", 11:31:16 INFO - "buildnumber": 127, 11:31:16 INFO - "platform": "ubuntu64_hw", 11:31:16 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:31:16 INFO - "slavebuilddir": "test", 11:31:16 INFO - "taskId": "d_KJ1w4pTVuK2IeSCudfrA", 11:31:16 INFO - "branch": "mozilla-beta", 11:31:16 INFO - "script_repo_revision": "production", 11:31:16 INFO - "revision": "9802ea8f6220173617b75cb0ab740f1e1f88f8ad", 11:31:16 INFO - "slavename": "talos-linux64-ix-005", 11:31:16 INFO - "repo_path": "releases/mozilla-beta" 11:31:16 INFO - } 11:31:16 INFO - Finding installer, test and symbols from parent task. 11:31:16 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_KJ1w4pTVuK2IeSCudfrA'}, attempt #1 11:31:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d_KJ1w4pTVuK2IeSCudfrA'}, attempt #1 11:31:17 INFO - Task dependencies: SEHjNn5WRO26WkzdmSigsQ 11:31:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ'}, attempt #1 11:31:18 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2 11:31:18 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.test_packages.json 11:31:18 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.crashreporter-symbols.zip 11:31:18 INFO - Running post-action listener: _resource_record_post_action 11:31:18 INFO - [mozharness: 2017-10-07 18:31:18.107784Z] Finished read-buildbot-config step (success) 11:31:18 INFO - [mozharness: 2017-10-07 18:31:18.108003Z] Running download-and-extract step. 11:31:18 INFO - Running pre-action listener: _resource_record_pre_action 11:31:18 INFO - Running main action method: download_and_extract 11:31:18 INFO - mkdir: /builds/slave/test/build/tests 11:31:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:18 INFO - trying https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.test_packages.json 11:31:18 INFO - Downloading https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:31:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:31:19 INFO - Downloaded 989 bytes. 11:31:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:31:19 INFO - Using the following test package requirements: 11:31:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:31:19 INFO - u'common': [u'target.common.tests.zip'], 11:31:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:31:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:31:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:31:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:31:19 INFO - u'mozbase': [u'target.common.tests.zip'], 11:31:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:31:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:31:19 INFO - u'web-platform': [u'target.common.tests.zip', 11:31:19 INFO - u'target.web-platform.tests.tar.gz'], 11:31:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:31:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 11:31:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.common.tests.zip 11:31:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:31:19 INFO - Fetch https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.common.tests.zip into memory 11:31:20 INFO - Content-Length response header: 55181349 11:31:20 INFO - Bytes received: 55181349 11:31:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.talos.tests.zip 11:31:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:31:31 INFO - Fetch https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.talos.tests.zip into memory 11:31:31 INFO - Content-Length response header: 14509224 11:31:31 INFO - Bytes received: 14509224 11:31:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:32 INFO - trying https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2 11:31:32 INFO - Downloading https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:31:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:31:33 INFO - Downloaded 53619905 bytes. 11:31:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2 11:31:33 INFO - mkdir: /builds/slave/test/properties 11:31:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:33 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:33 INFO - Contents: 11:31:33 INFO - build_url:https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2 11:31:33 INFO - Running post-action listener: _resource_record_post_action 11:31:33 INFO - Running post-action listener: find_tests_for_verification 11:31:33 INFO - Running post-action listener: set_extra_try_arguments 11:31:33 INFO - [mozharness: 2017-10-07 18:31:33.163294Z] Finished download-and-extract step (success) 11:31:33 INFO - [mozharness: 2017-10-07 18:31:33.163394Z] Running populate-webroot step. 11:31:33 INFO - Running pre-action listener: _resource_record_pre_action 11:31:33 INFO - Running main action method: populate_webroot 11:31:33 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:31:33 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['tresize', 11:31:33 INFO - 'tcanvasmark']}, 11:31:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:31:33 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['dromaeo_css', 11:31:33 INFO - 'kraken']}, 11:31:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:33 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'tests': ['damp', 'tps']}, 11:31:33 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['damp', 'tps']}, 11:31:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:33 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['dromaeo_dom']}, 11:31:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:31:33 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['basic_compositor_video', 11:31:33 INFO - 'glvideo']}, 11:31:33 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:31:33 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['ts_paint_webext', 11:31:33 INFO - 'tp5o_webext']}, 11:31:33 INFO - 'other-e10s': {'tests': ['a11yr', 11:31:33 INFO - 'ts_paint', 11:31:33 INFO - 'tpaint', 11:31:33 INFO - 'sessionrestore', 11:31:33 INFO - 'sessionrestore_many_windows', 11:31:33 INFO - 'sessionrestore_no_auto_restore', 11:31:33 INFO - 'tabpaint']}, 11:31:33 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['a11yr', 11:31:33 INFO - 'ts_paint', 11:31:33 INFO - 'tpaint', 11:31:33 INFO - 'sessionrestore', 11:31:33 INFO - 'sessionrestore_many_windows', 11:31:33 INFO - 'sessionrestore_no_auto_restore', 11:31:33 INFO - 'tabpaint']}, 11:31:33 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 11:31:33 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 11:31:33 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['perf_reftest_singletons']}, 11:31:33 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['bloom_basic']}, 11:31:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:31:33 INFO - 'tsvgr_opacity', 11:31:33 INFO - 'tart', 11:31:33 INFO - 'tscrollx', 11:31:33 INFO - 'tsvg_static']}, 11:31:33 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['tsvgx', 11:31:33 INFO - 'tsvgr_opacity', 11:31:33 INFO - 'tart', 11:31:33 INFO - 'tscrollx', 11:31:33 INFO - 'tsvg_static']}, 11:31:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:31:33 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'talos_options': ['--disable-stylo'], 11:31:33 INFO - 'tests': ['tp5o']}, 11:31:33 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:33 INFO - 'talos_options': ['--mitmproxy', 11:31:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:33 INFO - '--firstNonBlankPaint'], 11:31:33 INFO - 'tests': ['tp6_google', 11:31:33 INFO - 'tp6_youtube', 11:31:33 INFO - 'tp6_amazon', 11:31:33 INFO - 'tp6_facebook']}, 11:31:33 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:33 INFO - 'talos_options': ['--disable-stylo', 11:31:33 INFO - '--mitmproxy', 11:31:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:33 INFO - '--firstNonBlankPaint'], 11:31:33 INFO - 'tests': ['tp6_google', 11:31:33 INFO - 'tp6_youtube', 11:31:33 INFO - 'tp6_amazon', 11:31:33 INFO - 'tp6_facebook']}, 11:31:33 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 11:31:33 INFO - 'talos_options': ['--stylo-threads=1', 11:31:33 INFO - '--mitmproxy', 11:31:33 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 11:31:33 INFO - '--firstNonBlankPaint'], 11:31:33 INFO - 'tests': ['tp6_google', 11:31:33 INFO - 'tp6_youtube', 11:31:33 INFO - 'tp6_amazon', 11:31:33 INFO - 'tp6_facebook']}, 11:31:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'talos_options': ['--xperf_path', 11:31:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:33 INFO - 'tests': ['tp5n']}, 11:31:33 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 11:31:33 INFO - 'talos_options': ['--disable-stylo', 11:31:33 INFO - '--xperf_path', 11:31:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:33 INFO - 'tests': ['tp5n']}}} 11:31:33 INFO - Running post-action listener: _resource_record_post_action 11:31:33 INFO - [mozharness: 2017-10-07 18:31:33.178362Z] Finished populate-webroot step (success) 11:31:33 INFO - [mozharness: 2017-10-07 18:31:33.178466Z] Running create-virtualenv step. 11:31:33 INFO - Running pre-action listener: _resource_record_pre_action 11:31:33 INFO - Running main action method: create_virtualenv 11:31:33 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:33 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 11:31:33 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 11:31:33 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:31:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:33 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:34 INFO - Installing pip...............done. 11:31:34 INFO - Return code: 0 11:31:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:31:34 INFO - Reading from file tmpfile_stdout 11:31:34 INFO - Output received: 11:31:34 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 11:31:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:31:34 INFO - Using env: {'DISPLAY': ':0', 11:31:34 INFO - 'HOME': '/home/cltbld', 11:31:34 INFO - 'LANG': 'en_US.UTF-8', 11:31:34 INFO - 'LANGUAGE': 'en_US:en', 11:31:34 INFO - 'LOGNAME': 'cltbld', 11:31:34 INFO - 'MAIL': '/var/mail/cltbld', 11:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:34 INFO - 'MOZ_NO_REMOTE': '1', 11:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:34 INFO - 'NO_EM_RESTART': '1', 11:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:34 INFO - 'PWD': '/builds/slave/test', 11:31:34 INFO - 'SHELL': '/bin/bash', 11:31:34 INFO - 'SHLVL': '1', 11:31:34 INFO - 'TERM': 'linux', 11:31:34 INFO - 'TMOUT': '86400', 11:31:34 INFO - 'USER': 'cltbld', 11:31:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:34 INFO - '_': '/tools/buildbot/bin/python'} 11:31:35 INFO - Ignoring indexes: http://pypi.python.org/simple/ 11:31:35 INFO - Downloading/unpacking pip>=1.5 11:31:35 INFO - Running setup.py egg_info for package pip 11:31:35 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:35 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:35 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:35 INFO - Installing collected packages: pip 11:31:35 INFO - Found existing installation: pip 1.1 11:31:35 INFO - Uninstalling pip: 11:31:35 INFO - Successfully uninstalled pip 11:31:35 INFO - Running setup.py install for pip 11:31:35 INFO - warning: no files found matching 'pip/cacert.pem' 11:31:35 INFO - warning: no files found matching '*.html' under directory 'docs' 11:31:35 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 11:31:35 INFO - no previously-included directories found matching 'docs/_build/_sources' 11:31:35 INFO - Installing pip script to /builds/slave/test/build/venv/bin 11:31:35 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 11:31:35 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 11:31:35 INFO - Successfully installed pip 11:31:35 INFO - Cleaning up... 11:31:35 INFO - Return code: 0 11:31:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 11:31:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 11:31:35 INFO - Using env: {'DISPLAY': ':0', 11:31:35 INFO - 'HOME': '/home/cltbld', 11:31:35 INFO - 'LANG': 'en_US.UTF-8', 11:31:35 INFO - 'LANGUAGE': 'en_US:en', 11:31:35 INFO - 'LOGNAME': 'cltbld', 11:31:35 INFO - 'MAIL': '/var/mail/cltbld', 11:31:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:35 INFO - 'MOZ_NO_REMOTE': '1', 11:31:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:35 INFO - 'NO_EM_RESTART': '1', 11:31:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:35 INFO - 'PWD': '/builds/slave/test', 11:31:35 INFO - 'SHELL': '/bin/bash', 11:31:35 INFO - 'SHLVL': '1', 11:31:35 INFO - 'TERM': 'linux', 11:31:35 INFO - 'TMOUT': '86400', 11:31:35 INFO - 'USER': 'cltbld', 11:31:35 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:35 INFO - '_': '/tools/buildbot/bin/python'} 11:31:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:35 INFO - Downloading/unpacking psutil>=3.1.1 11:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:37 INFO - Installing collected packages: psutil 11:31:37 INFO - Running setup.py install for psutil 11:31:37 INFO - building 'psutil._psutil_linux' extension 11:31:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 11:31:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 11:31:37 INFO - building 'psutil._psutil_posix' extension 11:31:37 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 11:31:37 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 11:31:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:37 INFO - Successfully installed psutil 11:31:37 INFO - Cleaning up... 11:31:37 INFO - Return code: 0 11:31:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:31:37 INFO - Using env: {'DISPLAY': ':0', 11:31:37 INFO - 'HOME': '/home/cltbld', 11:31:37 INFO - 'LANG': 'en_US.UTF-8', 11:31:37 INFO - 'LANGUAGE': 'en_US:en', 11:31:37 INFO - 'LOGNAME': 'cltbld', 11:31:37 INFO - 'MAIL': '/var/mail/cltbld', 11:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:37 INFO - 'MOZ_NO_REMOTE': '1', 11:31:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:37 INFO - 'NO_EM_RESTART': '1', 11:31:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:37 INFO - 'PWD': '/builds/slave/test', 11:31:37 INFO - 'SHELL': '/bin/bash', 11:31:37 INFO - 'SHLVL': '1', 11:31:37 INFO - 'TERM': 'linux', 11:31:37 INFO - 'TMOUT': '86400', 11:31:37 INFO - 'USER': 'cltbld', 11:31:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:37 INFO - '_': '/tools/buildbot/bin/python'} 11:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:31:39 INFO - Installing collected packages: mozsystemmonitor 11:31:39 INFO - Running setup.py install for mozsystemmonitor 11:31:39 INFO - Successfully installed mozsystemmonitor 11:31:39 INFO - Cleaning up... 11:31:40 INFO - Return code: 0 11:31:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 11:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 11:31:40 INFO - Using env: {'DISPLAY': ':0', 11:31:40 INFO - 'HOME': '/home/cltbld', 11:31:40 INFO - 'LANG': 'en_US.UTF-8', 11:31:40 INFO - 'LANGUAGE': 'en_US:en', 11:31:40 INFO - 'LOGNAME': 'cltbld', 11:31:40 INFO - 'MAIL': '/var/mail/cltbld', 11:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:40 INFO - 'MOZ_NO_REMOTE': '1', 11:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:40 INFO - 'NO_EM_RESTART': '1', 11:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:40 INFO - 'PWD': '/builds/slave/test', 11:31:40 INFO - 'SHELL': '/bin/bash', 11:31:40 INFO - 'SHLVL': '1', 11:31:40 INFO - 'TERM': 'linux', 11:31:40 INFO - 'TMOUT': '86400', 11:31:40 INFO - 'USER': 'cltbld', 11:31:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:40 INFO - '_': '/tools/buildbot/bin/python'} 11:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:40 INFO - Downloading/unpacking jsonschema==2.5.1 11:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:31:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:41 INFO - Downloading functools32-3.2.3-2.tar.gz 11:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:31:41 INFO - warning: no files found matching '*.txt' 11:31:41 INFO - no previously-included directories found matching 'build' 11:31:41 INFO - no previously-included directories found matching 'dist' 11:31:41 INFO - no previously-included directories found matching '.git*' 11:31:41 INFO - Installing collected packages: jsonschema, functools32 11:31:41 INFO - Running setup.py install for functools32 11:31:41 INFO - warning: no files found matching '*.txt' 11:31:41 INFO - no previously-included directories found matching 'build' 11:31:41 INFO - no previously-included directories found matching 'dist' 11:31:41 INFO - no previously-included directories found matching '.git*' 11:31:42 INFO - Successfully installed jsonschema functools32 11:31:42 INFO - Cleaning up... 11:31:42 INFO - Return code: 0 11:31:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:31:42 INFO - Using env: {'DISPLAY': ':0', 11:31:42 INFO - 'HOME': '/home/cltbld', 11:31:42 INFO - 'LANG': 'en_US.UTF-8', 11:31:42 INFO - 'LANGUAGE': 'en_US:en', 11:31:42 INFO - 'LOGNAME': 'cltbld', 11:31:42 INFO - 'MAIL': '/var/mail/cltbld', 11:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:42 INFO - 'MOZ_NO_REMOTE': '1', 11:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:42 INFO - 'NO_EM_RESTART': '1', 11:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:42 INFO - 'PWD': '/builds/slave/test', 11:31:42 INFO - 'SHELL': '/bin/bash', 11:31:42 INFO - 'SHLVL': '1', 11:31:42 INFO - 'TERM': 'linux', 11:31:42 INFO - 'TMOUT': '86400', 11:31:42 INFO - 'USER': 'cltbld', 11:31:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:42 INFO - '_': '/tools/buildbot/bin/python'} 11:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:31:42 INFO - Cleaning up... 11:31:42 INFO - Return code: 0 11:31:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:31:42 INFO - Using env: {'DISPLAY': ':0', 11:31:42 INFO - 'HOME': '/home/cltbld', 11:31:42 INFO - 'LANG': 'en_US.UTF-8', 11:31:42 INFO - 'LANGUAGE': 'en_US:en', 11:31:42 INFO - 'LOGNAME': 'cltbld', 11:31:42 INFO - 'MAIL': '/var/mail/cltbld', 11:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:42 INFO - 'MOZ_NO_REMOTE': '1', 11:31:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:42 INFO - 'NO_EM_RESTART': '1', 11:31:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:42 INFO - 'PWD': '/builds/slave/test', 11:31:42 INFO - 'SHELL': '/bin/bash', 11:31:42 INFO - 'SHLVL': '1', 11:31:42 INFO - 'TERM': 'linux', 11:31:42 INFO - 'TMOUT': '86400', 11:31:42 INFO - 'USER': 'cltbld', 11:31:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:42 INFO - '_': '/tools/buildbot/bin/python'} 11:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:42 INFO - Downloading/unpacking blobuploader==1.2.4 11:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:44 INFO - Downloading docopt-0.6.1.tar.gz 11:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:44 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:44 INFO - Running setup.py install for blobuploader 11:31:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:44 INFO - Running setup.py install for requests 11:31:44 INFO - Running setup.py install for docopt 11:31:44 INFO - Successfully installed blobuploader requests docopt 11:31:44 INFO - Cleaning up... 11:31:44 INFO - Return code: 0 11:31:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:44 INFO - Using env: {'DISPLAY': ':0', 11:31:44 INFO - 'HOME': '/home/cltbld', 11:31:44 INFO - 'LANG': 'en_US.UTF-8', 11:31:44 INFO - 'LANGUAGE': 'en_US:en', 11:31:44 INFO - 'LOGNAME': 'cltbld', 11:31:44 INFO - 'MAIL': '/var/mail/cltbld', 11:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:44 INFO - 'MOZ_NO_REMOTE': '1', 11:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:44 INFO - 'NO_EM_RESTART': '1', 11:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:44 INFO - 'PWD': '/builds/slave/test', 11:31:44 INFO - 'SHELL': '/bin/bash', 11:31:44 INFO - 'SHLVL': '1', 11:31:44 INFO - 'TERM': 'linux', 11:31:44 INFO - 'TMOUT': '86400', 11:31:44 INFO - 'USER': 'cltbld', 11:31:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:44 INFO - '_': '/tools/buildbot/bin/python'} 11:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:45 INFO - Running setup.py (path:/tmp/pip-3ickjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:45 INFO - Running setup.py (path:/tmp/pip-OrF1IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:45 INFO - Running setup.py (path:/tmp/pip-ZNufrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:45 INFO - Running setup.py (path:/tmp/pip-6wNplB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:45 INFO - Running setup.py (path:/tmp/pip-uEElGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:45 INFO - Running setup.py (path:/tmp/pip-YsRJE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:45 INFO - Running setup.py (path:/tmp/pip-rczqj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:45 INFO - Running setup.py (path:/tmp/pip-kZHCBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:45 INFO - Running setup.py (path:/tmp/pip-pIzkAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:45 INFO - Running setup.py (path:/tmp/pip-Nw2Q7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:45 INFO - Running setup.py (path:/tmp/pip-pp1v3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:45 INFO - Running setup.py (path:/tmp/pip-qgGDm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:45 INFO - Running setup.py (path:/tmp/pip-5VRyfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:45 INFO - Running setup.py (path:/tmp/pip-5KTxan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:46 INFO - Running setup.py (path:/tmp/pip-eZTT9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:46 INFO - Running setup.py (path:/tmp/pip-uSTbTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:46 INFO - Running setup.py (path:/tmp/pip-ULnFsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:31:46 INFO - Running setup.py install for manifestparser 11:31:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozcrash 11:31:46 INFO - Running setup.py install for mozdebug 11:31:46 INFO - Running setup.py install for mozdevice 11:31:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozfile 11:31:46 INFO - Running setup.py install for mozhttpd 11:31:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozinfo 11:31:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Running setup.py install for mozInstall 11:31:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:31:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for mozleak 11:31:47 INFO - Running setup.py install for mozlog 11:31:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for moznetwork 11:31:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for mozprocess 11:31:47 INFO - Running setup.py install for mozprofile 11:31:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for mozrunner 11:31:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Running setup.py install for mozscreenshot 11:31:47 INFO - Running setup.py install for moztest 11:31:47 INFO - Running setup.py install for mozversion 11:31:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:31:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:31:47 INFO - Cleaning up... 11:31:47 INFO - Return code: 0 11:31:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:47 INFO - Using env: {'DISPLAY': ':0', 11:31:47 INFO - 'HOME': '/home/cltbld', 11:31:47 INFO - 'LANG': 'en_US.UTF-8', 11:31:47 INFO - 'LANGUAGE': 'en_US:en', 11:31:47 INFO - 'LOGNAME': 'cltbld', 11:31:47 INFO - 'MAIL': '/var/mail/cltbld', 11:31:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:47 INFO - 'MOZ_NO_REMOTE': '1', 11:31:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:47 INFO - 'NO_EM_RESTART': '1', 11:31:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:47 INFO - 'PWD': '/builds/slave/test', 11:31:47 INFO - 'SHELL': '/bin/bash', 11:31:47 INFO - 'SHLVL': '1', 11:31:47 INFO - 'TERM': 'linux', 11:31:47 INFO - 'TMOUT': '86400', 11:31:47 INFO - 'USER': 'cltbld', 11:31:47 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:47 INFO - '_': '/tools/buildbot/bin/python'} 11:31:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:48 INFO - Running setup.py (path:/tmp/pip-OJ34hZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:48 INFO - Running setup.py (path:/tmp/pip-pBF2HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:48 INFO - Running setup.py (path:/tmp/pip-aUXfma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:48 INFO - Running setup.py (path:/tmp/pip-YPxM22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:48 INFO - Running setup.py (path:/tmp/pip-DQTCzC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:48 INFO - Running setup.py (path:/tmp/pip-JNJGRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:48 INFO - Running setup.py (path:/tmp/pip-x4gpgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:48 INFO - Running setup.py (path:/tmp/pip-sCqNFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:48 INFO - Running setup.py (path:/tmp/pip-qhDB77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:48 INFO - Running setup.py (path:/tmp/pip-1IpShH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:31:48 INFO - Running setup.py (path:/tmp/pip-OsVDPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:31:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 11:31:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:31:48 INFO - Running setup.py (path:/tmp/pip-OXEVOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:31:49 INFO - Running setup.py (path:/tmp/pip-bSWB9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:31:49 INFO - Running setup.py (path:/tmp/pip-dV8oPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:49 INFO - Running setup.py (path:/tmp/pip-JoYpa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:31:49 INFO - Running setup.py (path:/tmp/pip-NVDyZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 11:31:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:31:49 INFO - Running setup.py (path:/tmp/pip-lCI9UJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 11:31:49 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:31:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:50 INFO - Downloading blessings-1.6.tar.gz 11:31:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:31:50 INFO - Installing collected packages: blessings 11:31:50 INFO - Running setup.py install for blessings 11:31:50 INFO - Successfully installed blessings 11:31:50 INFO - Cleaning up... 11:31:50 INFO - Return code: 0 11:31:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:50 INFO - Reading from file tmpfile_stdout 11:31:50 INFO - Current package versions: 11:31:50 INFO - argparse == 1.2.1 11:31:50 INFO - blessings == 1.6 11:31:50 INFO - blobuploader == 1.2.4 11:31:50 INFO - docopt == 0.6.1 11:31:50 INFO - functools32 == 3.2.3-2 11:31:50 INFO - jsonschema == 2.5.1 11:31:50 INFO - manifestparser == 1.1 11:31:50 INFO - mozInstall == 1.13 11:31:50 INFO - mozcrash == 1.0 11:31:50 INFO - mozdebug == 0.1 11:31:50 INFO - mozdevice == 0.51 11:31:50 INFO - mozfile == 1.2 11:31:50 INFO - mozhttpd == 0.7 11:31:50 INFO - mozinfo == 0.10 11:31:50 INFO - mozleak == 0.1 11:31:50 INFO - mozlog == 3.5 11:31:50 INFO - moznetwork == 0.27 11:31:50 INFO - mozprocess == 0.25 11:31:50 INFO - mozprofile == 0.28 11:31:50 INFO - mozrunner == 6.13 11:31:50 INFO - mozscreenshot == 0.1 11:31:50 INFO - mozsystemmonitor == 0.3 11:31:50 INFO - moztest == 0.8 11:31:50 INFO - mozversion == 1.4 11:31:50 INFO - psutil == 3.1.1 11:31:50 INFO - requests == 1.2.3 11:31:50 INFO - wsgiref == 0.1.2 11:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:50 INFO - Using env: {'DISPLAY': ':0', 11:31:50 INFO - 'HOME': '/home/cltbld', 11:31:50 INFO - 'LANG': 'en_US.UTF-8', 11:31:50 INFO - 'LANGUAGE': 'en_US:en', 11:31:50 INFO - 'LOGNAME': 'cltbld', 11:31:50 INFO - 'MAIL': '/var/mail/cltbld', 11:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:50 INFO - 'MOZ_NO_REMOTE': '1', 11:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:50 INFO - 'NO_EM_RESTART': '1', 11:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:50 INFO - 'PWD': '/builds/slave/test', 11:31:50 INFO - 'SHELL': '/bin/bash', 11:31:50 INFO - 'SHLVL': '1', 11:31:50 INFO - 'TERM': 'linux', 11:31:50 INFO - 'TMOUT': '86400', 11:31:50 INFO - 'USER': 'cltbld', 11:31:50 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:50 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 11:31:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 11:31:51 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 11:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 11:31:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 11:31:52 INFO - Installing collected packages: simplejson 11:31:52 INFO - Running setup.py install for simplejson 11:31:52 INFO - building 'simplejson._speedups' extension 11:31:52 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 11:31:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 11:31:53 INFO - Successfully installed simplejson 11:31:53 INFO - Cleaning up... 11:31:53 INFO - Return code: 0 11:31:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28f91f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ac1a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c64a60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 11:31:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:31:53 INFO - Using env: {'DISPLAY': ':0', 11:31:53 INFO - 'HOME': '/home/cltbld', 11:31:53 INFO - 'LANG': 'en_US.UTF-8', 11:31:53 INFO - 'LANGUAGE': 'en_US:en', 11:31:53 INFO - 'LOGNAME': 'cltbld', 11:31:53 INFO - 'MAIL': '/var/mail/cltbld', 11:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:53 INFO - 'MOZ_NO_REMOTE': '1', 11:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:53 INFO - 'NO_EM_RESTART': '1', 11:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:53 INFO - 'PWD': '/builds/slave/test', 11:31:53 INFO - 'SHELL': '/bin/bash', 11:31:53 INFO - 'SHLVL': '1', 11:31:53 INFO - 'TERM': 'linux', 11:31:53 INFO - 'TMOUT': '86400', 11:31:53 INFO - 'USER': 'cltbld', 11:31:53 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:53 INFO - '_': '/tools/buildbot/bin/python'} 11:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:31:53 INFO - Cleaning up... 11:31:53 INFO - Return code: 0 11:31:53 INFO - Running post-action listener: _resource_record_post_action 11:31:53 INFO - Running post-action listener: _start_resource_monitoring 11:31:53 INFO - Starting resource monitoring. 11:31:53 INFO - [mozharness: 2017-10-07 18:31:53.707624Z] Finished create-virtualenv step (success) 11:31:53 INFO - [mozharness: 2017-10-07 18:31:53.708145Z] Running install step. 11:31:53 INFO - Running pre-action listener: _resource_record_pre_action 11:31:53 INFO - Running main action method: install 11:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:31:53 INFO - Reading from file tmpfile_stdout 11:31:53 INFO - Detecting whether we're running mozinstall >=1.0... 11:31:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:31:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:31:54 INFO - Reading from file tmpfile_stdout 11:31:54 INFO - Output received: 11:31:54 INFO - Usage: mozinstall [options] installer 11:31:54 INFO - Options: 11:31:54 INFO - -h, --help show this help message and exit 11:31:54 INFO - -d DEST, --destination=DEST 11:31:54 INFO - Directory to install application into. [default: 11:31:54 INFO - "/builds/slave/test"] 11:31:54 INFO - --app=APP Application being installed. [default: firefox] 11:31:54 INFO - mkdir: /builds/slave/test/build/application 11:31:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:32:08 INFO - Reading from file tmpfile_stdout 11:32:08 INFO - Output received: 11:32:08 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:08 INFO - Running post-action listener: _resource_record_post_action 11:32:08 INFO - [mozharness: 2017-10-07 18:32:08.673479Z] Finished install step (success) 11:32:08 INFO - [mozharness: 2017-10-07 18:32:08.673732Z] Running setup-mitmproxy step. 11:32:08 INFO - Running pre-action listener: _resource_record_pre_action 11:32:08 INFO - Running main action method: setup_mitmproxy 11:32:08 INFO - Skipping: mitmproxy is not required 11:32:08 INFO - Running post-action listener: _resource_record_post_action 11:32:08 INFO - [mozharness: 2017-10-07 18:32:08.674956Z] Finished setup-mitmproxy step (success) 11:32:08 INFO - [mozharness: 2017-10-07 18:32:08.675178Z] Running run-tests step. 11:32:08 INFO - Running pre-action listener: _resource_record_pre_action 11:32:08 INFO - Running pre-action listener: _set_gcov_prefix 11:32:08 INFO - Running main action method: run_tests 11:32:08 WARNING - Try message not found. 11:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:08 INFO - Python 2.7.3 11:32:08 INFO - Return code: 0 11:32:08 INFO - grabbing minidump binary from tooltool 11:32:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:32:08 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68090>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c68d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c62f90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:08 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:32:08 INFO - Copy/paste: /tools/tooltool.py --url https://tooltool.mozilla-releng.net/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:32:08 INFO - Calling ['/tools/tooltool.py', '--url', 'https://tooltool.mozilla-releng.net/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:32:08 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:08 INFO - Return code: 0 11:32:08 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:08 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:08 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:08 INFO - ENV: RUST_BACKTRACE is now full 11:32:08 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:08 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 11:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 11:32:08 INFO - Using env: {'DISPLAY': ':0', 11:32:08 INFO - 'HOME': '/home/cltbld', 11:32:08 INFO - 'LANG': 'en_US.UTF-8', 11:32:08 INFO - 'LANGUAGE': 'en_US:en', 11:32:08 INFO - 'LOGNAME': 'cltbld', 11:32:08 INFO - 'MAIL': '/var/mail/cltbld', 11:32:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:08 INFO - 'MOZ_NO_REMOTE': '1', 11:32:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:08 INFO - 'NO_EM_RESTART': '1', 11:32:08 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:08 INFO - 'PWD': '/builds/slave/test', 11:32:08 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:08 INFO - 'RUST_BACKTRACE': 'full', 11:32:08 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:08 INFO - 'SHELL': '/bin/bash', 11:32:08 INFO - 'SHLVL': '1', 11:32:08 INFO - 'TERM': 'linux', 11:32:08 INFO - 'TMOUT': '86400', 11:32:08 INFO - 'USER': 'cltbld', 11:32:08 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:08 INFO - '_': '/tools/buildbot/bin/python'} 11:32:08 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 11:32:09 INFO - mozversion application_buildid: 20171007170957 11:32:09 INFO - mozversion application_changeset: 9802ea8f6220173617b75cb0ab740f1e1f88f8ad 11:32:09 INFO - mozversion application_display_name: Firefox 11:32:09 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:09 INFO - mozversion application_name: Firefox 11:32:09 INFO - mozversion application_remotingname: firefox 11:32:09 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 11:32:09 INFO - mozversion application_vendor: Mozilla 11:32:09 INFO - mozversion application_version: 57.0 11:32:09 INFO - mozversion platform_buildid: 20171007170957 11:32:09 INFO - mozversion platform_changeset: 9802ea8f6220173617b75cb0ab740f1e1f88f8ad 11:32:09 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 11:32:09 INFO - mozversion platform_version: 57.0 11:32:09 INFO - using testdate: 1507401129 11:32:09 INFO - actual date: 1507401129 11:32:09 INFO - starting webserver on 'localhost:55287' 11:32:09 INFO - SUITE-START | Running 2 tests 11:32:09 INFO - TEST-START | dromaeo_css 11:32:09 INFO - Initialising browser for dromaeo_css test... 11:32:09 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55287/getInfo.html -profile /tmp/tmpJOv5lQ/profile 11:32:09 INFO - TEST-INFO | started process 24126 (/builds/slave/test/build/application/firefox/firefox http://localhost:55287/getInfo.html) 11:32:14 INFO - TEST-INFO | 24126: exit 0 11:32:14 INFO - Browser initialized. 11:32:14 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:14 INFO - Using env: {'DISPLAY': ':0', 11:32:14 INFO - 'HOME': '/home/cltbld', 11:32:14 INFO - 'JSGC_DISABLE_POISONING': '1', 11:32:14 INFO - 'LANG': 'en_US.UTF-8', 11:32:14 INFO - 'LANGUAGE': 'en_US:en', 11:32:14 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:32:14 INFO - 'LOGNAME': 'cltbld', 11:32:14 INFO - 'MAIL': '/var/mail/cltbld', 11:32:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:14 INFO - 'MOZ_CRASHREPORTER': '1', 11:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:14 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:32:14 INFO - 'MOZ_NO_REMOTE': '1', 11:32:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:14 INFO - 'NO_EM_RESTART': '1', 11:32:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:14 INFO - 'PWD': '/builds/slave/test', 11:32:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:14 INFO - 'RUST_BACKTRACE': 'full', 11:32:14 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:32:14 INFO - 'SHELL': '/bin/bash', 11:32:14 INFO - 'SHLVL': '1', 11:32:14 INFO - 'TERM': 'linux', 11:32:14 INFO - 'TMOUT': '86400', 11:32:14 INFO - 'USER': 'cltbld', 11:32:14 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:14 INFO - '_': '/tools/buildbot/bin/python'} 11:32:14 INFO - TEST-INFO | started process 24365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJOv5lQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:15 INFO - PID 24365 | 11:32:15 INFO - PID 24365 | (/builds/slave/test/build/application/firefox/firefox:24415): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:32:15 INFO - PID 24365 | 11:32:25 INFO - PID 24365 | RSS: Main: 141205504 11:32:25 INFO - PID 24365 | 11:35:22 INFO - PID 24365 | Cycle 1(1): loaded http://localhost:55287/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55287/tests/dromaeo/cssquery-ext.html) 11:35:23 INFO - PID 24365 | RSS: Main: 145670144 11:35:23 INFO - PID 24365 | 11:38:25 INFO - PID 24365 | Cycle 1(1): loaded http://localhost:55287/tests/dromaeo/cssquery-ext.html (next: http://localhost:55287/tests/dromaeo/cssquery-jquery.html) 11:38:25 INFO - PID 24365 | RSS: Main: 144601088 11:38:25 INFO - PID 24365 | 11:41:27 INFO - PID 24365 | Cycle 1(1): loaded http://localhost:55287/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55287/tests/dromaeo/cssquery-mootools.html) 11:41:27 INFO - PID 24365 | RSS: Main: 145199104 11:41:27 INFO - PID 24365 | 11:44:29 INFO - PID 24365 | Cycle 1(1): loaded http://localhost:55287/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55287/tests/dromaeo/cssquery-prototype.html) 11:44:30 INFO - PID 24365 | RSS: Main: 145154048 11:44:30 INFO - PID 24365 | 11:47:32 INFO - PID 24365 | Cycle 1(1): loaded http://localhost:55287/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55287/tests/dromaeo/cssquery-yui.html) 11:47:33 INFO - PID 24365 | RSS: Main: 146501632 11:47:33 INFO - PID 24365 | 11:50:34 INFO - PID 24365 | Cycle 1(1): loaded http://localhost:55287/tests/dromaeo/cssquery-yui.html (next: http://localhost:55287/tests/dromaeo/cssquery-dojo.html) 11:50:35 INFO - PID 24365 | RSS: Main: 149012480 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | __start_tp_report 11:50:35 INFO - PID 24365 | _x_x_mozilla_page_load 11:50:35 INFO - PID 24365 | _x_x_mozilla_page_load_details 11:50:35 INFO - PID 24365 | |i|pagename|runs| 11:50:35 INFO - PID 24365 | |0;dojo.html;4030.8186131624075;4039.050823056581;4059.675225981922;4071.8371265149376;4072.1448495815866;6502.902456463151;6582.835429114274;6631.635260060701;6632.2704502504685;6674.733010679573;6561.114249576306;6573.868522629545;6597.142371491711;6653.634050127241;6670.433013193872;5832.475077243047;5854.824355269348;5883.82024265644;5885.264341957255;5901.675407852566;5871.618344807595;5899.941000590004;5922.58541902067;5976;5982.97008514959;5914.585978981473;5975.223220981266;6013.639181649115;6017.338092809788;6025.728842202111;5836.795712150097;5928.6739229342365;5945.881082378328;6016.939830601682;6026.337102918676;5759.769609215668;5795.2176456178295;5801.883962320772;5819.127130930352;5855.4144585541535;6535.836604084889;6540.771073012469;6554.70503827329;6617.636030018395;6619.040239165294;7169.24722904098;7188.856222875565;7258.165310989251;7282.089738782653;7292.416606671453;7074.752383666547;7234.927650723478;7236.782896513113;7266.091738532684;7338.046054012998;6644.169478815148;6718.563293385963;6723.663816809189;6735.4948378871295;6752.83117922046;7297.89053164203;7365.3739432147795;7446.73936412223;7472.962635186789;7490.176080631126;7125.714971401086;7161.140663120459;7225.060742103598;7230.0239467672245;7264.491485595958;7153.642317884085;7222.855542889113;7257;7271.163816161104;7286.927130728624;7194.100737407824;7206.891896621555;7232.349088582053;7266.091738532684;7281.963590182015;7183.42532597391;7185.281471852877;7189.784306470814;7312.341889229995;7312.561246325131;5263.052650522943;5339.11904535755;5344.812931547377;5377.327834020747;5453.672779633234;4913.852584422473;4957.380327459067;4969.0310389474425;4985.576226020757;5039.949600504021;6745.426638735665;6760.898586521206;6835.965820170967;6837.965810170917;6839.487038472134;7007.579545227302;7081.433485321162;7096.574205547684;7215.855682886313;7291.70833166678;6756.628385438848;6758.3917447428985;6766.6278354689985;6782.796516104525;6817.659117044128;6135.141080248769;6147.262328520606;6224.688765561795;6229.345918678474;6231.158793562901;7297.1608265049135;7341.596212208273;7372.96313518429;7388;7463.14173870001;7152.8211794706585;7153.6423178839805;7187.640617969185;7210.675519601526;7225.494215405081;7353.522021068614;7409.222031686595;7458.776236712907;7462.738804141829;7463.776086717407;7102.325279098477;7183.281671832775;7183.958326042799;7189.2810718927685;7204.783856484314;7171.748988785367;7212.963935180291;7267.236940121423;7281.599512026889;7292.489525733148;6867.656617169221;6933.89599156003;6961.060256865461;6984.231734509099;7070.575765454089;6979.371856532936;6982.860342793014;6997.8250543734775;7004.824879377852;7026.191987921455;6856.657167141722;6861.382475577222;6959.547629404073;6970.198427180939;6978.511504194657;6860.828479288058;6973.267806880204;6978.720851165896;7045.964770176116;7068.5758854468895;6801.727930882709;6876.037354770437;6878.55289406187;6880.449564034765;6883.931160688329 11:50:35 INFO - PID 24365 | |1;ext.html;974.6004138303297;976.1995163965543;1006.3307900246336;1032.7160030991472;1032.7831155457357;44541.77729111354;45259.32111018333;45274.547254527446;45408.77295613517;45521;41955.37066943998;42267.78866105673;42272.365914511305;42313.15373692524;42313.15373692524;8073.71741989029;8157.388195885303;8178.223068808454;8185.7135000275;8202.220789025034;8052.19478052196;8170.1829817018415;8186.140455252202;8188.836223275531;8195.79510512236;8160.795980100485;8199.590020498952;8203.95898020512;8710.128987101303;8855.822883542325;8803.735887923373;8819.559022048905;8862.423942443786;8869.95565022174;8870.37907346486;8602.827943441158;8628.697995570188;8634.784130396727;8695.869561956513;8702.608382622797;42841.35737963933;43135.56864431347;43164.784176078916;43214.13571728548;43402;3894.2990261752875;3942.349512330462;3947.1513624570857;3952.7825969571663;3954.8418063277436;34893.12767180816;35160.82419587886;35181.824090879636;35189.29621407583;35198;5520.91718624221;5703.971480142573;5735;5748.396418376052;5782.421757824184;241093;241690;242176.78911605506;242512;243131;53304.73347633237;53314.66713332198;53332.466675333526;53702.19446708303;53735.19397209045;55508.44491555113;55513.16730248969;55674;55742.72128639331;55784;18593.535161620795;18916.148773305234;18917.43247702571;18921;18938.24247030131;15702.9214853925;15737.055776653437;15742.134182619837;15752.68494630101;15756.60608484797;14991.32539035746;15173.468928587446;15240.161791101375;15333.846661533242;15465.613359666098;5592.748326325325;5705.429457054344;5727.856803579861;5830.591858569859;5845;1058.4707646176912;1086.413336798136;1092.7377429416883;1098.8516550265772;1104.5968221599057;25434.491310173693;25753.74246257551;25857.22428327153;25922.87038564795;26050.86974565115;1213.5509861351356;1217.719924417389;1223.932683702405;1236.7093732972744;1244.3031902134833;13719.725605488034;13745.793813092812;13787.448502060006;13856.30718464093;14045.157290562598;307108;313014;313478;316451;317994;65009;65252;65478.34521654818;65622;65701.028969131;1551.95344139676;1552.7222502006898;1555.8366371530826;1575.779390885277;1576.030741094219;29769.25576860596;29794.414545745043;29876.402471950005;30195.547066793577;30253.69746302597;42630.78684606681;42675.146497070506;42979.14041719086;42998.570014299454;43030;271600;272868;273077;275175;275756;38177.2364552713;38582.80708596439;38736.80631596824;38744.869032203496;38955.2208955825;44995.77502112599;46429;48716.75641621769;49128;49178.75410622924;35145.297094058486;35531.111722207155;35542.822285888404;35587.46618800772;36000;35359.64640353563;35381.469277960336;35418.29163416769;35429.46855797217;36012;40903.38644920388;40931.38602921018;40944.59055409408;40975.1804963905;41142.38286425646;33289.16777080592;33496.66503334935;33660;33931.15172120618;34354;25084.24747257585;25217.369565761004;25426.872865635552;25732.61401078948;25794.96820127174 11:50:35 INFO - PID 24365 | |2;jquery.html;653.0677259106611;655.2047390150987;663.7024616874012;677.630691273256;680.7106979533697;24673.50652986939;25494.745052549468;25598.74401255987;25736.871315643442;25776.35559111023;28317;28565.428691426157;28632.570511442344;28712.856435717844;28810.855945720243;6941.028256044158;7039.366457018868;7094.219635840053;7107.680154393065;7110.253423390547;6994.3705066544;7106.502544821865;7109.715611375539;7122.0385247991635;7125.1093613298335;6818.795436136899;7117.074780278583;7119.430445564342;7120.430365570742;7132.85734285314;7021.648917554127;7033.50765446419;7063.081799366075;7066.258042905472;7066.57600543969;6532.6407047612365;6569.704363303615;6599.670016499156;6603.504737144734;6620.139381880373;31598.842005790055;31910.20224494383;32048;32106;32240.677593224238;2336.205690065386;2375.9524809503887;2378.4291769975252;2380.726216485109;2383.21353953195;21325.89337053305;21564.1374345026;21610.459738506506;21762.455938601503;21786.237481688222;2479.169478224797;2602.843829370244;2626.7110617832022;2642.63003179555;2645.5899335603012;151823;159812.20093899572;165770;172834;173891;16798.664026719398;16874.662506750043;16947;17381.130943452776;18181.818181818013;27909.860450697615;27956;27994;28114.578281325797;28145.155645330673;11508.96419322265;11806.46870890812;12019.33893635841;12030.578929737418;12104.334261615695;10918.72703182411;11030.28303160292;11039.282446640942;11086.667399978014;11165.274257173258;10003.849942250872;10067.194624430029;10181.287309888237;10343.37939723619;10447.477626118663;3002.459557279667;3133.7963032403277;3152.274976755359;3161.7786754926933;3250.691184337484;1021.1728499915092;1056.9312994655322;1062.4687656171914;1073.457903758597;1081.2485322700804;21601.891990539945;22223.888880555816;22358.503768568164;22601.4349641257;22844.771552284597;1114.2924243105524;1120.8935151160626;1133.5635780224673;1133.7845809296207;1140.6635042662435;12071.456784444721;12130.33283169434;12199.218242344725;12360.629181124581;12439.75120497585;649895;655435;668238;675143;685725;138270.30864845612;142682;142998;143378;144233;1246.2958428487875;1276.910616256853;1282.6536835054483;1285.595037563146;1289.1040726694857;19023.809761902205;19094.23623055062;19146.234150634376;19342.32301869428;19648.60702785965;66495;67246;67672.3232767666;68448.65775671089;68815;89531;89644.85533913752;90481;91067.54466227627;92345;16250;16552.75170872462;16686.666266674354;16712.49862504127;16778.077205753314;25194.49611007733;25267.873660632315;25424.364390890376;25509.979600816503;25654.102106426933;19937.302194423126;20051.498712532302;20174.193032278545;20348.18607255693;20481.59036819285;17447.738283926006;17698.203580838635;17864.821351786835;18221.54446138857;18357.265709371477;20997.475063123544;21086.367408977756;21295;21606.783932160477;21730.782692172877;16144.031358118551;16263.59341016484;16330.101844398672;16379;16406.83593164053;19829.504262393555;19987.200511979358;20041.599168016848;20097.497562561053;20103.29638462647 11:50:35 INFO - PID 24365 | |3;mootools.html;1443.1990245413797;1496.2967405319496;1503.2934520775239;1510.3656464285;1515.848415158484;16968.321267149313;17618.559536011606;17636.559086022855;17696.292148314085;17700.55748606284;17212.655746885055;17349;17406.651866962686;17418.3903563375;17429;2937.9265518362;2997.130832058706;3025.788194826363;3038.31637881476;3044.72597466228;2991.1176203020054;3017.0647099399257;3056.083175047488;3056.190109620952;3057.281538838371;3017.200441882892;3025.6217972753407;3073.661897191307;3169.2235402326464;3172.6510083890753;3076.1848110250576;3095.8916437924677;3107.984460077708;3114.5795317632055;3131.170239886432;3004.444177827109;3004.5643381709747;3011.1869795155403;3022.531507616323;3039.149038269288;16871.325146994106;16934.3226270949;17029.48911532656;17036.829631703647;17075.316987320493;9190;9445.952770236105;9460.57427415768;9483.478408687519;9490.335676502647;6115.235595550556;6174.166487524171;6351.824912391223;6388.840278993016;6429.324920883333;2140.957180856374;2171.348595421383;2178.498945242603;2231;2236.9217077402377;31421.84289078563;31547.684523154705;31549.52675709866;31874.681253187635;31896.840515797503;7818.413618978486;7871.960640196762;7921.960390198012;8032.759017229492;8085.919140808634;20244.392668219978;20278;20324;20438.59122817565;20486.487837804176;9067.727968160965;9195.540222988824;9224.769380765534;9226.123518265755;9235.307351948632;8219.260266576037;8234.794130146794;8299.419040667217;8449.619767110495;8501.277391421798;6232.127502149703;6336.746530138835;6350.7459701611415;6390.584612000205;6448.742050317935;1808.1863161577344;1810.1130446081588;1826.205600563759;1834.660587791263;1852.536865783554;862.4868203418956;1006.8590397344377;1007.1590222164575;1009.914157296638;1019.8266294729914;9855.45794981283;9895.851562226573;10022.248331375176;10159.695209143738;10161.949190254001;1066.5467176450134;1074.6292529077455;1098.2092893117103;1100.3837850803575;1119.5297974850582;5917.704114794243;6023.096535519707;6175.413335733098;6296.874062518724;6382.234131904108;24752.628710569355;26091.739082608932;26496;27060;27103.593446098323;24763.876180618983;26097.869510652326;26128.86935565348;26387.73612263853;26469.867650661625;13019.218846869218;13138.211707297593;13282.601521954357;13314.267715275559;13342.332883355988;9179;9257.583408746488;9299.535023248945;9319.673811416567;9325.906740932503;21833.890830545744;22087.447813804785;22522;22576.09695612157;22797.316080517612;22906.770932290463;23076.4230894229;23146.189883354004;23178.884105579364;23219.76780232176;12826.23042617446;12887.806682899576;13037.608871733863;13040.41318140667;13055.281959492318;16110.275037623102;16207.513774586781;16456.506304810875;16482;16499.17504124765;13084.149530280501;13308.93345533266;13384.130031547918;13447.125936814076;13563.59309220725;12841.101122921305;13030.804537932128;13336.93331533375;13388.866111338762;13541.255230962392;10110.140638045848;10159.288849780445;10283.125934295369;10283.588656453658;10286.331388459726;8194.67221311141;8330.958345208235;8338.082810890675;8404;8479.40644154928;8310.750677479686;8517.531535765593;8536.359773017173;8594.31245500371;8629.827403452022 11:50:35 INFO - PID 24365 | |4;prototype.html;586.1530089021361;589.4194218694585;595.1221947627253;610.4658423879107;635.7806556737924;6412.198475190601;6436.195475565554;6493.707783149758;6499.545031847772;6533.607983520992;6357.8410539736415;6379.202599675041;6389.808305750823;6403.807885763423;6453.354664533545;5193.662411943231;5205.297284866532;5212.087884620205;5275.6043296752705;5279.234510995903;4963.379577552788;5074.974625126869;5223.563520032003;5281.709505977189;5294.338207724035;5044.520770526794;5078.314427552288;5092.0579692756955;5100.225832883658;5111.028904508132;5050.343455350818;5056.115179843513;5073.695578265298;5118.181091025455;5134.1528647773075;4623.930641040387;4646.605038571725;4652.092841895832;4652.930206046912;4673.668004618701;6333.7466501339895;6337.207849018872;6351;6373.6175829450385;6378.138951241569;6066.878662426727;6108.816735497942;6117.66352850593;6139.570230083896;6146.66193359365;6805.6597170141295;6836.3083934675215;6857.965710171467;6876.1748590169;6952.270011648755;5002.349694539723;5261.500157485033;5271.182966640177;5288.788448462057;5307.097793375096;7008.439324853999;7065;7163.892541611932;7181;7186.928130718678;5415.6441947752855;5422.7017514036315;5428.158635411518;5435.184722291688;5445.2921120254905;5419.590906364374;5470.124780035176;5474.616776825584;5476.835694929158;5545.584081193846;6005.459508644243;6057.123440997765;6110.908336374958;6128.3258841527395;6141.6007959482495;6865.352315444257;6872.69072891711;6882.5870447772295;6913.585184888922;6935.965320173367;1862.8044055374262;1875.4561177258715;1886.3492095227125;1887.9622407551772;1888.282452668005;1292.9224246545236;1316.82881225442;1344.0658742174292;1350.4260689207047;1355.969463207969;6305.306416294204;6326.398992095744;6353.491720662429;6394.552381333355;6436.871262574722;6866.485013623998;6899.517033807585;6917.27368626287;6924.272951340137;6935;6290.528210384239;6297.866384050915;6323.968380158161;6421.678916054178;6451.645159516272;3628.1292489802786;3684.631536846294;3686.907827304285;3698.9445158322646;3713.387291096939;7162.498625096193;7169.354758071799;7187.856242875113;7201.7756981313305;7227.16887557927;7111.964440177766;7137.00081988522;7217.3504384604585;7227.915812628148;7240.52936559122;7046.6828992695455;7086.681099350541;7101.088553693065;7150.889363127057;7174.354308112295;6907.758228461979;6924.169099708067;6956.339252700804;6958.304169583002;6986.615736134561;6737.461003119836;6824.93175068243;6828.931710682829;6869.7595584154315;6933.37599616037;7057.2237053925055;7140.214576396696;7187.640617969185;7233.493655444068;7269.636518173965;5303.231031500488;5351.5183633471615;5361.973190134025;5375.274337964481;5386.218998245311;6672.199336079701;6796.864062718817;6865.588064716133;6948.583085014915;6980.650967451708;6702.497312701665;6726.495512836459;6768.492363072691;6770.221424536045;6855.417289530246;6660;6670.866582668416;6769.593824370553;6819.965900170468;6831.180258369028;6460.773872914426;6672.933270667231;6687.164104486939;6773.153355830521;6817.965910170616;6882.965585172243;6915.827104322432;6916.619585922823;6921.342472465108;6974.163100427981;6653.9667301663185;6681.899771503528;6689.799306020827;6714.328567143247;6726.764563240263 11:50:35 INFO - PID 24365 | |5;yui.html;1007.4912169354475;1023.4780262066348;1041.0942480042365;1041.2607048995212;1047.993925831202;20842;21186.57626847464;21187.046582903768;21191.364259072252;21200.25799097032;20408.387748367535;20433.69349459759;20671;20699;20741.585168296624;1074.4520294649747;1099.4667586220717;1111.5387114347536;1113.3153110836818;1113.3375641493299;1100.8073587122221;1106.3251416635846;1107.2581370481757;1107.5071593141056;1107.972300692481;1127.8928501792316;1137.5392965848844;1165.4464129538487;1172.0155069741415;1174.829649700793;1162.7441962768178;1169.7601991591746;1176.611718133014;1176.6999415149126;1176.8587769467676;823.0206054794775;824.7525742277293;829.1873963515789;830.3232865214891;830.5224495914873;20617.793822061736;20804.27185048531;20841.16635334585;21024;21041.47396315089;24318.513629727306;24419.812262831998;24843.130490432748;24894;24909.377265568324;19613.705794413094;19766.308179213658;19871.20515179391;19889.60220795576;19951.201951922052;4235.57644235577;4266.87199384019;4267.637250833683;4267.957320426787;4270.572942705736;138524;165829;173521;173561;173731;19127.426177214427;19498;19792.90103549502;19806.801931980783;19821.702674459608;35680.28639427197;36351;36824.631753682654;36869.81565092211;36874.44688329677;10187.796244075076;10276.640317588848;10298.536565854554;10437.530311136017;10437.68686939393;4929.679570827885;5006.64953453262;5040.949590504121;5057.367829021372;5061.620378471555;6361.650109244036;6441.58129721576;6442.742290308429;6445.323241059715;6490.448311893448;1254.2098477958828;1255.8116282557507;1272.090455324429;1273.6433798536425;1276.3299267884436;776.5534817479971;780.679921232292;782.3311069036006;795.3398679096337;799.7600719784042;13599.59201223965;13842.930785346009;14877.925610371878;14947.103173809606;15105.848941510445;773.4894969320221;774.7869335932663;776.4138075752884;779.2713812585251;793.8372633610096;6217.285012223652;6286.779962701284;6344.111824344595;6354.491640668735;6409.102725618417;159510;162363;162711.18644406702;163519;163545;119631.40184299022;135264;137899.86300411003;138293.3085334567;141482.2925885364;124890.37554812168;125061.37469312595;125176.37411813065;125916;126603;15144.394224230908;15677.843221568095;15869.682606347578;15898.920505397398;16010.759838602196;55627.72186139043;55776.72111639416;55966.440335596126;56356.43643563512;57416;70938;71170.64414677894;71258.64370678113;72455.63772181106;74244.25755742373;19844.30544930978;20196.091175896825;20415;20629.58740825205;20650.58698825985;23908;24991.625125623494;25044;25358.619620706075;25448.745512545378;21987.34037978863;22391.888040559694;22429.5514089714;22575.984080716735;22621.547569048857;18508.537286567942;18689.345872894384;18833.71749423787;18934.14796334196;18950.810491894903;18531.0734463279;18733.531661708566;18815.435536933914;18873;18891.43325700231;14963.551093467213;14969.40122395092;15035.398584056515;15070.773938390714;15085.849141508445;14946.626334341729;14983.026103303251;15334.233288335316;15432;15481.922590386976 11:50:35 INFO - PID 24365 | __end_tp_report 11:50:35 INFO - PID 24365 | __start_cc_report 11:50:35 INFO - PID 24365 | _x_x_mozilla_cycle_collect,237 11:50:35 INFO - PID 24365 | __end_cc_report 11:50:35 INFO - PID 24365 | __startTimestamp1507402235180__endTimestamp 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | ------- Summary: start ------- 11:50:35 INFO - PID 24365 | Number of tests: 6 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | [#0] dojo.html Cycles:165 Average:6645.08 Median:6880.45 stddev:774.45 (11.3%) stddev-sans-first:749.18 11:50:35 INFO - PID 24365 | Values: 4030.8 4039.1 4059.7 4071.8 4072.1 6502.9 6582.8 6631.6 6632.3 6674.7 6561.1 6573.9 6597.1 6653.6 6670.4 5832.5 5854.8 5883.8 5885.3 5901.7 5871.6 5899.9 5922.6 5976.0 5983.0 5914.6 5975.2 6013.6 6017.3 6025.7 5836.8 5928.7 5945.9 6016.9 6026.3 5759.8 5795.2 5801.9 5819.1 5855.4 6535.8 6540.8 6554.7 6617.6 6619.0 7169.2 7188.9 7258.2 7282.1 7292.4 7074.8 7234.9 7236.8 7266.1 7338.0 6644.2 6718.6 6723.7 6735.5 6752.8 7297.9 7365.4 7446.7 7473.0 7490.2 7125.7 7161.1 7225.1 7230.0 7264.5 7153.6 7222.9 7257.0 7271.2 7286.9 7194.1 7206.9 7232.3 7266.1 7282.0 7183.4 7185.3 7189.8 7312.3 7312.6 5263.1 5339.1 5344.8 5377.3 5453.7 4913.9 4957.4 4969.0 4985.6 5039.9 6745.4 6760.9 6836.0 6838.0 6839.5 7007.6 7081.4 7096.6 7215.9 7291.7 6756.6 6758.4 6766.6 6782.8 6817.7 6135.1 6147.3 6224.7 6229.3 6231.2 7297.2 7341.6 7373.0 7388.0 7463.1 7152.8 7153.6 7187.6 7210.7 7225.5 7353.5 7409.2 7458.8 7462.7 7463.8 7102.3 7183.3 7184.0 7189.3 7204.8 7171.7 7213.0 7267.2 7281.6 7292.5 6867.7 6933.9 6961.1 6984.2 7070.6 6979.4 6982.9 6997.8 7004.8 7026.2 6856.7 6861.4 6959.5 6970.2 6978.5 6860.8 6973.3 6978.7 7046.0 7068.6 6801.7 6876.0 6878.6 6880.4 6883.9 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | [#1] ext.html Cycles:180 Average:45890.61 Median:38740.84 stddev:72442.97 (187.0%) stddev-sans-first:72567.69 11:50:35 INFO - PID 24365 | Values: 974.6 976.2 1006.3 1032.7 1032.8 44541.8 45259.3 45274.5 45408.8 45521.0 41955.4 42267.8 42272.4 42313.2 42313.2 8073.7 8157.4 8178.2 8185.7 8202.2 8052.2 8170.2 8186.1 8188.8 8195.8 8160.8 8199.6 8204.0 8710.1 8855.8 8803.7 8819.6 8862.4 8870.0 8870.4 8602.8 8628.7 8634.8 8695.9 8702.6 42841.4 43135.6 43164.8 43214.1 43402.0 3894.3 3942.3 3947.2 3952.8 3954.8 34893.1 35160.8 35181.8 35189.3 35198.0 5520.9 5704.0 5735.0 5748.4 5782.4 241093.0 241690.0 242176.8 242512.0 243131.0 53304.7 53314.7 53332.5 53702.2 53735.2 55508.4 55513.2 55674.0 55742.7 55784.0 18593.5 18916.1 18917.4 18921.0 18938.2 15702.9 15737.1 15742.1 15752.7 15756.6 14991.3 15173.5 15240.2 15333.8 15465.6 5592.7 5705.4 5727.9 5830.6 5845.0 1058.5 1086.4 1092.7 1098.9 1104.6 25434.5 25753.7 25857.2 25922.9 26050.9 1213.6 1217.7 1223.9 1236.7 1244.3 13719.7 13745.8 13787.4 13856.3 14045.2 307108.0 313014.0 313478.0 316451.0 317994.0 65009.0 65252.0 65478.3 65622.0 65701.0 1552.0 1552.7 1555.8 1575.8 1576.0 29769.3 29794.4 29876.4 30195.5 30253.7 42630.8 42675.1 42979.1 42998.6 43030.0 271600.0 272868.0 273077.0 275175.0 275756.0 38177.2 38582.8 38736.8 38744.9 38955.2 44995.8 46429.0 48716.8 49128.0 49178.8 35145.3 35531.1 35542.8 35587.5 36000.0 35359.6 35381.5 35418.3 35429.5 36012.0 40903.4 40931.4 40944.6 40975.2 41142.4 33289.2 33496.7 33660.0 33931.2 34354.0 25084.2 25217.4 25426.9 25732.6 25795.0 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | [#2] jquery.html Cycles:180 Average:43253.55 Median:22005.06 stddev:111655.66 (507.4%) stddev-sans-first:111923.07 11:50:35 INFO - PID 24365 | Values: 653.1 655.2 663.7 677.6 680.7 24673.5 25494.7 25598.7 25736.9 25776.4 28317.0 28565.4 28632.6 28712.9 28810.9 6941.0 7039.4 7094.2 7107.7 7110.3 6994.4 7106.5 7109.7 7122.0 7125.1 6818.8 7117.1 7119.4 7120.4 7132.9 7021.6 7033.5 7063.1 7066.3 7066.6 6532.6 6569.7 6599.7 6603.5 6620.1 31598.8 31910.2 32048.0 32106.0 32240.7 2336.2 2376.0 2378.4 2380.7 2383.2 21325.9 21564.1 21610.5 21762.5 21786.2 2479.2 2602.8 2626.7 2642.6 2645.6 151823.0 159812.2 165770.0 172834.0 173891.0 16798.7 16874.7 16947.0 17381.1 18181.8 27909.9 27956.0 27994.0 28114.6 28145.2 11509.0 11806.5 12019.3 12030.6 12104.3 10918.7 11030.3 11039.3 11086.7 11165.3 10003.8 10067.2 10181.3 10343.4 10447.5 3002.5 3133.8 3152.3 3161.8 3250.7 1021.2 1056.9 1062.5 1073.5 1081.2 21601.9 22223.9 22358.5 22601.4 22844.8 1114.3 1120.9 1133.6 1133.8 1140.7 12071.5 12130.3 12199.2 12360.6 12439.8 649895.0 655435.0 668238.0 675143.0 685725.0 138270.3 142682.0 142998.0 143378.0 144233.0 1246.3 1276.9 1282.7 1285.6 1289.1 19023.8 19094.2 19146.2 19342.3 19648.6 66495.0 67246.0 67672.3 68448.7 68815.0 89531.0 89644.9 90481.0 91067.5 92345.0 16250.0 16552.8 16686.7 16712.5 16778.1 25194.5 25267.9 25424.4 25510.0 25654.1 19937.3 20051.5 20174.2 20348.2 20481.6 17447.7 17698.2 17864.8 18221.5 18357.3 20997.5 21086.4 21295.0 21606.8 21730.8 16144.0 16263.6 16330.1 16379.0 16406.8 19829.5 19987.2 20041.6 20097.5 20103.3 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | [#3] mootools.html Cycles:180 Average:10935.47 Median:26113.37 stddev:7998.31 (30.6%) stddev-sans-first:7988.95 11:50:35 INFO - PID 24365 | Values: 1443.2 1496.3 1503.3 1510.4 1515.8 16968.3 17618.6 17636.6 17696.3 17700.6 17212.7 17349.0 17406.7 17418.4 17429.0 2937.9 2997.1 3025.8 3038.3 3044.7 2991.1 3017.1 3056.1 3056.2 3057.3 3017.2 3025.6 3073.7 3169.2 3172.7 3076.2 3095.9 3108.0 3114.6 3131.2 3004.4 3004.6 3011.2 3022.5 3039.1 16871.3 16934.3 17029.5 17036.8 17075.3 9190.0 9446.0 9460.6 9483.5 9490.3 6115.2 6174.2 6351.8 6388.8 6429.3 2141.0 2171.3 2178.5 2231.0 2236.9 31421.8 31547.7 31549.5 31874.7 31896.8 7818.4 7872.0 7922.0 8032.8 8085.9 20244.4 20278.0 20324.0 20438.6 20486.5 9067.7 9195.5 9224.8 9226.1 9235.3 8219.3 8234.8 8299.4 8449.6 8501.3 6232.1 6336.7 6350.7 6390.6 6448.7 1808.2 1810.1 1826.2 1834.7 1852.5 862.5 1006.9 1007.2 1009.9 1019.8 9855.5 9895.9 10022.2 10159.7 10161.9 1066.5 1074.6 1098.2 1100.4 1119.5 5917.7 6023.1 6175.4 6296.9 6382.2 24752.6 26091.7 26496.0 27060.0 27103.6 24763.9 26097.9 26128.9 26387.7 26469.9 13019.2 13138.2 13282.6 13314.3 13342.3 9179.0 9257.6 9299.5 9319.7 9325.9 21833.9 22087.4 22522.0 22576.1 22797.3 22906.8 23076.4 23146.2 23178.9 23219.8 12826.2 12887.8 13037.6 13040.4 13055.3 16110.3 16207.5 16456.5 16482.0 16499.2 13084.1 13308.9 13384.1 13447.1 13563.6 12841.1 13030.8 13336.9 13388.9 13541.3 10110.1 10159.3 10283.1 10283.6 10286.3 8194.7 8331.0 8338.1 8404.0 8479.4 8310.8 8517.5 8536.4 8594.3 8629.8 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | [#4] prototype.html Cycles:180 Average:5812.98 Median:6408.00 stddev:1617.28 (25.2%) stddev-sans-first:1573.51 11:50:35 INFO - PID 24365 | Values: 586.2 589.4 595.1 610.5 635.8 6412.2 6436.2 6493.7 6499.5 6533.6 6357.8 6379.2 6389.8 6403.8 6453.4 5193.7 5205.3 5212.1 5275.6 5279.2 4963.4 5075.0 5223.6 5281.7 5294.3 5044.5 5078.3 5092.1 5100.2 5111.0 5050.3 5056.1 5073.7 5118.2 5134.2 4623.9 4646.6 4652.1 4652.9 4673.7 6333.7 6337.2 6351.0 6373.6 6378.1 6066.9 6108.8 6117.7 6139.6 6146.7 6805.7 6836.3 6858.0 6876.2 6952.3 5002.3 5261.5 5271.2 5288.8 5307.1 7008.4 7065.0 7163.9 7181.0 7186.9 5415.6 5422.7 5428.2 5435.2 5445.3 5419.6 5470.1 5474.6 5476.8 5545.6 6005.5 6057.1 6110.9 6128.3 6141.6 6865.4 6872.7 6882.6 6913.6 6936.0 1862.8 1875.5 1886.3 1888.0 1888.3 1292.9 1316.8 1344.1 1350.4 1356.0 6305.3 6326.4 6353.5 6394.6 6436.9 6866.5 6899.5 6917.3 6924.3 6935.0 6290.5 6297.9 6324.0 6421.7 6451.6 3628.1 3684.6 3686.9 3698.9 3713.4 7162.5 7169.4 7187.9 7201.8 7227.2 7112.0 7137.0 7217.4 7227.9 7240.5 7046.7 7086.7 7101.1 7150.9 7174.4 6907.8 6924.2 6956.3 6958.3 6986.6 6737.5 6824.9 6828.9 6869.8 6933.4 7057.2 7140.2 7187.6 7233.5 7269.6 5303.2 5351.5 5362.0 5375.3 5386.2 6672.2 6796.9 6865.6 6948.6 6980.7 6702.5 6726.5 6768.5 6770.2 6855.4 6660.0 6670.9 6769.6 6820.0 6831.2 6460.8 6672.9 6687.2 6773.2 6818.0 6883.0 6915.8 6916.6 6921.3 6974.2 6654.0 6681.9 6689.8 6714.3 6726.8 11:50:35 INFO - PID 24365 | 11:50:35 INFO - PID 24365 | [#5] yui.html Cycles:180 Average:30170.95 Median:19814.25 stddev:44436.39 (224.3%) stddev-sans-first:44507.09 11:50:35 INFO - PID 24365 | Values: 1007.5 1023.5 1041.1 1041.3 1048.0 20842.0 21186.6 21187.0 21191.4 21200.3 20408.4 20433.7 20671.0 20699.0 20741.6 1074.5 1099.5 1111.5 1113.3 1113.3 1100.8 1106.3 1107.3 1107.5 1108.0 1127.9 1137.5 1165.4 1172.0 1174.8 1162.7 1169.8 1176.6 1176.7 1176.9 823.0 824.8 829.2 830.3 830.5 20617.8 20804.3 20841.2 21024.0 21041.5 24318.5 24419.8 24843.1 24894.0 24909.4 19613.7 19766.3 19871.2 19889.6 19951.2 4235.6 4266.9 4267.6 4268.0 4270.6 138524.0 165829.0 173521.0 173561.0 173731.0 19127.4 19498.0 19792.9 19806.8 19821.7 35680.3 36351.0 36824.6 36869.8 36874.4 10187.8 10276.6 10298.5 10437.5 10437.7 4929.7 5006.6 5040.9 5057.4 5061.6 6361.7 6441.6 6442.7 6445.3 6490.4 1254.2 1255.8 1272.1 1273.6 1276.3 776.6 780.7 782.3 795.3 799.8 13599.6 13842.9 14877.9 14947.1 15105.8 773.5 774.8 776.4 779.3 793.8 6217.3 6286.8 6344.1 6354.5 6409.1 159510.0 162363.0 162711.2 163519.0 163545.0 119631.4 135264.0 137899.9 138293.3 141482.3 124890.4 125061.4 125176.4 125916.0 126603.0 15144.4 15677.8 15869.7 15898.9 16010.8 55627.7 55776.7 55966.4 56356.4 57416.0 70938.0 71170.6 71258.6 72455.6 74244.3 19844.3 20196.1 20415.0 20629.6 20650.6 23908.0 24991.6 25044.0 25358.6 25448.7 21987.3 22391.9 22429.6 22576.0 22621.5 18508.5 18689.3 18833.7 18934.1 18950.8 18531.1 18733.5 18815.4 18873.0 18891.4 14963.6 14969.4 15035.4 15070.8 15085.8 14946.6 14983.0 15334.2 15432.0 15481.9 11:50:35 INFO - PID 24365 | -------- Summary: end -------- 11:50:35 INFO - PID 24365 | 11:50:35 INFO - TEST-INFO | 24365: exit 0 11:50:35 INFO - TEST-OK | dromaeo_css | took 1106764ms 11:50:35 INFO - TEST-START | kraken 11:50:35 INFO - Initialising browser for kraken test... 11:50:35 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:55287/getInfo.html -profile /tmp/tmpm_RJCN/profile 11:50:35 INFO - TEST-INFO | started process 24735 (/builds/slave/test/build/application/firefox/firefox http://localhost:55287/getInfo.html) 11:50:40 INFO - TEST-INFO | 24735: exit 0 11:50:40 INFO - Browser initialized. 11:50:40 INFO - Running cycle 1/1 for kraken test... 11:50:40 INFO - Using env: {'DISPLAY': ':0', 11:50:40 INFO - 'HOME': '/home/cltbld', 11:50:40 INFO - 'JSGC_DISABLE_POISONING': '1', 11:50:40 INFO - 'LANG': 'en_US.UTF-8', 11:50:40 INFO - 'LANGUAGE': 'en_US:en', 11:50:40 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 11:50:40 INFO - 'LOGNAME': 'cltbld', 11:50:40 INFO - 'MAIL': '/var/mail/cltbld', 11:50:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:50:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:50:40 INFO - 'MOZ_CRASHREPORTER': '1', 11:50:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:50:40 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 11:50:40 INFO - 'MOZ_NO_REMOTE': '1', 11:50:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:50:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:50:40 INFO - 'NO_EM_RESTART': '1', 11:50:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:50:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:50:40 INFO - 'PWD': '/builds/slave/test', 11:50:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:50:40 INFO - 'RUST_BACKTRACE': 'full', 11:50:40 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:50:40 INFO - 'SHELL': '/bin/bash', 11:50:40 INFO - 'SHLVL': '1', 11:50:40 INFO - 'TERM': 'linux', 11:50:40 INFO - 'TMOUT': '86400', 11:50:40 INFO - 'USER': 'cltbld', 11:50:40 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665', 11:50:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:50:40 INFO - '_': '/tools/buildbot/bin/python'} 11:50:40 INFO - TEST-INFO | started process 24961 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm_RJCN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 11:50:41 INFO - PID 24961 | 11:50:41 INFO - PID 24961 | (/builds/slave/test/build/application/firefox/firefox:25009): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 11:50:41 INFO - PID 24961 | 11:50:51 INFO - PID 24961 | RSS: Main: 143368192 11:50:51 INFO - PID 24961 | 11:50:54 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55287/tests/kraken/driver.html?testName=audio-beat-detection) 11:50:55 INFO - PID 24961 | RSS: Main: 149876736 11:50:55 INFO - PID 24961 | 11:50:57 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55287/tests/kraken/driver.html?testName=audio-dft) 11:50:58 INFO - PID 24961 | RSS: Main: 150491136 11:50:58 INFO - PID 24961 | 11:51:01 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55287/tests/kraken/driver.html?testName=audio-fft) 11:51:01 INFO - PID 24961 | RSS: Main: 152150016 11:51:01 INFO - PID 24961 | 11:51:03 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55287/tests/kraken/driver.html?testName=audio-oscillator) 11:51:04 INFO - PID 24961 | RSS: Main: 152092672 11:51:04 INFO - PID 24961 | 11:51:06 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55287/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:06 INFO - PID 24961 | RSS: Main: 151838720 11:51:06 INFO - PID 24961 | 11:51:10 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55287/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:10 INFO - PID 24961 | RSS: Main: 151281664 11:51:10 INFO - PID 24961 | 11:51:14 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55287/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:14 INFO - PID 24961 | RSS: Main: 154095616 11:51:14 INFO - PID 24961 | 11:51:17 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55287/tests/kraken/driver.html?testName=json-parse-financial) 11:51:18 INFO - PID 24961 | RSS: Main: 154980352 11:51:18 INFO - PID 24961 | 11:51:19 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55287/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:20 INFO - PID 24961 | RSS: Main: 155303936 11:51:20 INFO - PID 24961 | 11:51:21 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:51:22 INFO - PID 24961 | RSS: Main: 155234304 11:51:22 INFO - PID 24961 | 11:51:24 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:25 INFO - PID 24961 | RSS: Main: 151928832 11:51:25 INFO - PID 24961 | 11:51:27 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:51:27 INFO - PID 24961 | RSS: Main: 152145920 11:51:27 INFO - PID 24961 | 11:51:30 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:51:31 INFO - PID 24961 | RSS: Main: 152391680 11:51:31 INFO - PID 24961 | 11:51:32 INFO - PID 24961 | Cycle 1(1): loaded http://localhost:55287/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55287/tests/kraken/driver.html?testName=ai-astar) 11:51:33 INFO - PID 24961 | RSS: Main: 153706496 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | __start_tp_report 11:51:33 INFO - PID 24961 | _x_x_mozilla_page_load 11:51:33 INFO - PID 24961 | _x_x_mozilla_page_load_details 11:51:33 INFO - PID 24961 | |i|pagename|runs| 11:51:33 INFO - PID 24961 | |0;ai-astar;106;107;107;106;105;108;108;107;106;106 11:51:33 INFO - PID 24961 | |1;audio-beat-detection;111;112;114;111;115;110;113;113;112;112 11:51:33 INFO - PID 24961 | |2;audio-dft;162;160;163;164;164;162;161;162;160;161 11:51:33 INFO - PID 24961 | |3;audio-fft;74;74;76;75;75;78;74;81;72;73 11:51:33 INFO - PID 24961 | |4;audio-oscillator;80;77;83;77;78;78;80;77;78;78 11:51:33 INFO - PID 24961 | |5;imaging-gaussian-blur;110;113;113;114;114;114;114;117;113;115 11:51:33 INFO - PID 24961 | |6;imaging-darkroom;149;147;148;148;148;149;147;149;148;150 11:51:33 INFO - PID 24961 | |7;imaging-desaturate;94;94;94;94;94;94;103;95;99;99 11:51:33 INFO - PID 24961 | |8;json-parse-financial;44;43;43;43;43;43;45;43;43;48 11:51:33 INFO - PID 24961 | |9;json-stringify-tinderbox;38;38;38;38;38;38;38;38;38;38 11:51:33 INFO - PID 24961 | |10;stanford-crypto-aes;73;75;69;70;68;69;69;72;70;69 11:51:33 INFO - PID 24961 | |11;stanford-crypto-ccm;102;102;103;108;110;106;101;105;104;108 11:51:33 INFO - PID 24961 | |12;stanford-crypto-pbkdf2;154;154;152;155;150;149;148;147;147;149 11:51:33 INFO - PID 24961 | |13;stanford-crypto-sha256-iterative;62;60;59;58;55;60;57;60;61;63 11:51:33 INFO - PID 24961 | __end_tp_report 11:51:33 INFO - PID 24961 | __start_cc_report 11:51:33 INFO - PID 24961 | _x_x_mozilla_cycle_collect,692 11:51:33 INFO - PID 24961 | __end_cc_report 11:51:33 INFO - PID 24961 | __startTimestamp1507402293142__endTimestamp 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | ------- Summary: start ------- 11:51:33 INFO - PID 24961 | Number of tests: 14 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#0] ai-astar Cycles:10 Average:106.60 Median:107.00 stddev:0.97 (0.9%) stddev-sans-first:1.00 11:51:33 INFO - PID 24961 | Values: 106.0 107.0 107.0 106.0 105.0 108.0 108.0 107.0 106.0 106.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#1] audio-beat-detection Cycles:10 Average:112.30 Median:112.50 stddev:1.49 (1.3%) stddev-sans-first:1.51 11:51:33 INFO - PID 24961 | Values: 111.0 112.0 114.0 111.0 115.0 110.0 113.0 113.0 112.0 112.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.45 (0.9%) stddev-sans-first:1.54 11:51:33 INFO - PID 24961 | Values: 162.0 160.0 163.0 164.0 164.0 162.0 161.0 162.0 160.0 161.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#3] audio-fft Cycles:10 Average:75.20 Median:75.00 stddev:2.62 (3.5%) stddev-sans-first:2.74 11:51:33 INFO - PID 24961 | Values: 74.0 74.0 76.0 75.0 75.0 78.0 74.0 81.0 72.0 73.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#4] audio-oscillator Cycles:10 Average:78.60 Median:78.00 stddev:1.90 (2.4%) stddev-sans-first:1.94 11:51:33 INFO - PID 24961 | Values: 80.0 77.0 83.0 77.0 78.0 78.0 80.0 77.0 78.0 78.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#5] imaging-gaussian-blur Cycles:10 Average:113.70 Median:114.00 stddev:1.77 (1.5%) stddev-sans-first:1.27 11:51:33 INFO - PID 24961 | Values: 110.0 113.0 113.0 114.0 114.0 114.0 114.0 117.0 113.0 115.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 11:51:33 INFO - PID 24961 | Values: 149.0 147.0 148.0 148.0 148.0 149.0 147.0 149.0 148.0 150.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:94.00 stddev:3.20 (3.4%) stddev-sans-first:3.31 11:51:33 INFO - PID 24961 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 103.0 95.0 99.0 99.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#8] json-parse-financial Cycles:10 Average:43.80 Median:43.00 stddev:1.62 (3.8%) stddev-sans-first:1.72 11:51:33 INFO - PID 24961 | Values: 44.0 43.0 43.0 43.0 43.0 43.0 45.0 43.0 43.0 48.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#9] json-stringify-tinderbox Cycles:10 Average:38.00 Median:38.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:51:33 INFO - PID 24961 | Values: 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 38.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#10] stanford-crypto-aes Cycles:10 Average:70.40 Median:70.00 stddev:2.22 (3.2%) stddev-sans-first:2.15 11:51:33 INFO - PID 24961 | Values: 73.0 75.0 69.0 70.0 68.0 69.0 69.0 72.0 70.0 69.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#11] stanford-crypto-ccm Cycles:10 Average:104.90 Median:105.50 stddev:3.03 (2.9%) stddev-sans-first:3.03 11:51:33 INFO - PID 24961 | Values: 102.0 102.0 103.0 108.0 110.0 106.0 101.0 105.0 104.0 108.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:151.00 stddev:3.03 (2.0%) stddev-sans-first:2.93 11:51:33 INFO - PID 24961 | Values: 154.0 154.0 152.0 155.0 150.0 149.0 148.0 147.0 147.0 149.0 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:59.50 Median:60.00 stddev:2.37 (3.9%) stddev-sans-first:2.33 11:51:33 INFO - PID 24961 | Values: 62.0 60.0 59.0 58.0 55.0 60.0 57.0 60.0 61.0 63.0 11:51:33 INFO - PID 24961 | -------- Summary: end -------- 11:51:33 INFO - PID 24961 | 11:51:33 INFO - PID 24961 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 11:51:33 INFO - TEST-INFO | 24961: exit 0 11:51:33 INFO - TEST-OK | kraken | took 57982ms 11:51:33 INFO - SUITE-END | took 1164s 11:51:33 INFO - Completed test suite (00:19:24) 11:51:33 INFO - javascript benchmark 11:51:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9571.47874613452, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [4030.8186131624075, 4039.050823056581, 4059.675225981922, 4071.8371265149376, 4072.1448495815866, 6502.902456463151, 6582.835429114274, 6631.635260060701, 6632.2704502504685, 6674.733010679573, 6561.114249576306, 6573.868522629545, 6597.142371491711, 6653.634050127241, 6670.433013193872, 5832.475077243047, 5854.824355269348, 5883.82024265644, 5885.264341957255, 5901.675407852566, 5871.618344807595, 5899.941000590004, 5922.58541902067, 5976.0, 5982.97008514959, 5914.585978981473, 5975.223220981266, 6013.639181649115, 6017.338092809788, 6025.728842202111, 5836.795712150097, 5928.6739229342365, 5945.881082378328, 6016.939830601682, 6026.337102918676, 5759.769609215668, 5795.2176456178295, 5801.883962320772, 5819.127130930352, 5855.4144585541535, 6535.836604084889, 6540.771073012469, 6554.70503827329, 6617.636030018395, 6619.040239165294, 7169.24722904098, 7188.856222875565, 7258.165310989251, 7282.089738782653, 7292.416606671453, 7074.752383666547, 7234.927650723478, 7236.782896513113, 7266.091738532684, 7338.046054012998, 6644.169478815148, 6718.563293385963, 6723.663816809189, 6735.4948378871295, 6752.83117922046, 7297.89053164203, 7365.3739432147795, 7446.73936412223, 7472.962635186789, 7490.176080631126, 7125.714971401086, 7161.140663120459, 7225.060742103598, 7230.0239467672245, 7264.491485595958, 7153.642317884085, 7222.855542889113, 7257.0, 7271.163816161104, 7286.927130728624, 7194.100737407824, 7206.891896621555, 7232.349088582053, 7266.091738532684, 7281.963590182015, 7183.42532597391, 7185.281471852877, 7189.784306470814, 7312.341889229995, 7312.561246325131, 5263.052650522943, 5339.11904535755, 5344.812931547377, 5377.327834020747, 5453.672779633234, 4913.852584422473, 4957.380327459067, 4969.0310389474425, 4985.576226020757, 5039.949600504021, 6745.426638735665, 6760.898586521206, 6835.965820170967, 6837.965810170917, 6839.487038472134, 7007.579545227302, 7081.433485321162, 7096.574205547684, 7215.855682886313, 7291.70833166678, 6756.628385438848, 6758.3917447428985, 6766.6278354689985, 6782.796516104525, 6817.659117044128, 6135.141080248769, 6147.262328520606, 6224.688765561795, 6229.345918678474, 6231.158793562901, 7297.1608265049135, 7341.596212208273, 7372.96313518429, 7388.0, 7463.14173870001, 7152.8211794706585, 7153.6423178839805, 7187.640617969185, 7210.675519601526, 7225.494215405081, 7353.522021068614, 7409.222031686595, 7458.776236712907, 7462.738804141829, 7463.776086717407, 7102.325279098477, 7183.281671832775, 7183.958326042799, 7189.2810718927685, 7204.783856484314, 7171.748988785367, 7212.963935180291, 7267.236940121423, 7281.599512026889, 7292.489525733148, 6867.656617169221, 6933.89599156003, 6961.060256865461, 6984.231734509099, 7070.575765454089, 6979.371856532936, 6982.860342793014, 6997.8250543734775, 7004.824879377852, 7026.191987921455, 6856.657167141722, 6861.382475577222, 6959.547629404073, 6970.198427180939, 6978.511504194657, 6860.828479288058, 6973.267806880204, 6978.720851165896, 7045.964770176116, 7068.5758854468895, 6801.727930882709, 6876.037354770437, 6878.55289406187, 6880.449564034765, 6883.931160688329], "value": 6593.234143391332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [974.6004138303297, 976.1995163965543, 1006.3307900246336, 1032.7160030991472, 1032.7831155457357, 44541.77729111354, 45259.32111018333, 45274.547254527446, 45408.77295613517, 45521.0, 41955.37066943998, 42267.78866105673, 42272.365914511305, 42313.15373692524, 42313.15373692524, 8073.71741989029, 8157.388195885303, 8178.223068808454, 8185.7135000275, 8202.220789025034, 8052.19478052196, 8170.1829817018415, 8186.140455252202, 8188.836223275531, 8195.79510512236, 8160.795980100485, 8199.590020498952, 8203.95898020512, 8710.128987101303, 8855.822883542325, 8803.735887923373, 8819.559022048905, 8862.423942443786, 8869.95565022174, 8870.37907346486, 8602.827943441158, 8628.697995570188, 8634.784130396727, 8695.869561956513, 8702.608382622797, 42841.35737963933, 43135.56864431347, 43164.784176078916, 43214.13571728548, 43402.0, 3894.2990261752875, 3942.349512330462, 3947.1513624570857, 3952.7825969571663, 3954.8418063277436, 34893.12767180816, 35160.82419587886, 35181.824090879636, 35189.29621407583, 35198.0, 5520.91718624221, 5703.971480142573, 5735.0, 5748.396418376052, 5782.421757824184, 241093.0, 241690.0, 242176.78911605506, 242512.0, 243131.0, 53304.73347633237, 53314.66713332198, 53332.466675333526, 53702.19446708303, 53735.19397209045, 55508.44491555113, 55513.16730248969, 55674.0, 55742.72128639331, 55784.0, 18593.535161620795, 18916.148773305234, 18917.43247702571, 18921.0, 18938.24247030131, 15702.9214853925, 15737.055776653437, 15742.134182619837, 15752.68494630101, 15756.60608484797, 14991.32539035746, 15173.468928587446, 15240.161791101375, 15333.846661533242, 15465.613359666098, 5592.748326325325, 5705.429457054344, 5727.856803579861, 5830.591858569859, 5845.0, 1058.4707646176912, 1086.413336798136, 1092.7377429416883, 1098.8516550265772, 1104.5968221599057, 25434.491310173693, 25753.74246257551, 25857.22428327153, 25922.87038564795, 26050.86974565115, 1213.5509861351356, 1217.719924417389, 1223.932683702405, 1236.7093732972744, 1244.3031902134833, 13719.725605488034, 13745.793813092812, 13787.448502060006, 13856.30718464093, 14045.157290562598, 307108.0, 313014.0, 313478.0, 316451.0, 317994.0, 65009.0, 65252.0, 65478.34521654818, 65622.0, 65701.028969131, 1551.95344139676, 1552.7222502006898, 1555.8366371530826, 1575.779390885277, 1576.030741094219, 29769.25576860596, 29794.414545745043, 29876.402471950005, 30195.547066793577, 30253.69746302597, 42630.78684606681, 42675.146497070506, 42979.14041719086, 42998.570014299454, 43030.0, 271600.0, 272868.0, 273077.0, 275175.0, 275756.0, 38177.2364552713, 38582.80708596439, 38736.80631596824, 38744.869032203496, 38955.2208955825, 44995.77502112599, 46429.0, 48716.75641621769, 49128.0, 49178.75410622924, 35145.297094058486, 35531.111722207155, 35542.822285888404, 35587.46618800772, 36000.0, 35359.64640353563, 35381.469277960336, 35418.29163416769, 35429.46855797217, 36012.0, 40903.38644920388, 40931.38602921018, 40944.59055409408, 40975.1804963905, 41142.38286425646, 33289.16777080592, 33496.66503334935, 33660.0, 33931.15172120618, 34354.0, 25084.24747257585, 25217.369565761004, 25426.872865635552, 25732.61401078948, 25794.96820127174], "value": 19404.12154597875, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.0677259106611, 655.2047390150987, 663.7024616874012, 677.630691273256, 680.7106979533697, 24673.50652986939, 25494.745052549468, 25598.74401255987, 25736.871315643442, 25776.35559111023, 28317.0, 28565.428691426157, 28632.570511442344, 28712.856435717844, 28810.855945720243, 6941.028256044158, 7039.366457018868, 7094.219635840053, 7107.680154393065, 7110.253423390547, 6994.3705066544, 7106.502544821865, 7109.715611375539, 7122.0385247991635, 7125.1093613298335, 6818.795436136899, 7117.074780278583, 7119.430445564342, 7120.430365570742, 7132.85734285314, 7021.648917554127, 7033.50765446419, 7063.081799366075, 7066.258042905472, 7066.57600543969, 6532.6407047612365, 6569.704363303615, 6599.670016499156, 6603.504737144734, 6620.139381880373, 31598.842005790055, 31910.20224494383, 32048.0, 32106.0, 32240.677593224238, 2336.205690065386, 2375.9524809503887, 2378.4291769975252, 2380.726216485109, 2383.21353953195, 21325.89337053305, 21564.1374345026, 21610.459738506506, 21762.455938601503, 21786.237481688222, 2479.169478224797, 2602.843829370244, 2626.7110617832022, 2642.63003179555, 2645.5899335603012, 151823.0, 159812.20093899572, 165770.0, 172834.0, 173891.0, 16798.664026719398, 16874.662506750043, 16947.0, 17381.130943452776, 18181.818181818013, 27909.860450697615, 27956.0, 27994.0, 28114.578281325797, 28145.155645330673, 11508.96419322265, 11806.46870890812, 12019.33893635841, 12030.578929737418, 12104.334261615695, 10918.72703182411, 11030.28303160292, 11039.282446640942, 11086.667399978014, 11165.274257173258, 10003.849942250872, 10067.194624430029, 10181.287309888237, 10343.37939723619, 10447.477626118663, 3002.459557279667, 3133.7963032403277, 3152.274976755359, 3161.7786754926933, 3250.691184337484, 1021.1728499915092, 1056.9312994655322, 1062.4687656171914, 1073.457903758597, 1081.2485322700804, 21601.891990539945, 22223.888880555816, 22358.503768568164, 22601.4349641257, 22844.771552284597, 1114.2924243105524, 1120.8935151160626, 1133.5635780224673, 1133.7845809296207, 1140.6635042662435, 12071.456784444721, 12130.33283169434, 12199.218242344725, 12360.629181124581, 12439.75120497585, 649895.0, 655435.0, 668238.0, 675143.0, 685725.0, 138270.30864845612, 142682.0, 142998.0, 143378.0, 144233.0, 1246.2958428487875, 1276.910616256853, 1282.6536835054483, 1285.595037563146, 1289.1040726694857, 19023.809761902205, 19094.23623055062, 19146.234150634376, 19342.32301869428, 19648.60702785965, 66495.0, 67246.0, 67672.3232767666, 68448.65775671089, 68815.0, 89531.0, 89644.85533913752, 90481.0, 91067.54466227627, 92345.0, 16250.0, 16552.75170872462, 16686.666266674354, 16712.49862504127, 16778.077205753314, 25194.49611007733, 25267.873660632315, 25424.364390890376, 25509.979600816503, 25654.102106426933, 19937.302194423126, 20051.498712532302, 20174.193032278545, 20348.18607255693, 20481.59036819285, 17447.738283926006, 17698.203580838635, 17864.821351786835, 18221.54446138857, 18357.265709371477, 20997.475063123544, 21086.367408977756, 21295.0, 21606.783932160477, 21730.782692172877, 16144.031358118551, 16263.59341016484, 16330.101844398672, 16379.0, 16406.83593164053, 19829.504262393555, 19987.200511979358, 20041.599168016848, 20097.497562561053, 20103.29638462647], "value": 13553.547327522905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1443.1990245413797, 1496.2967405319496, 1503.2934520775239, 1510.3656464285, 1515.848415158484, 16968.321267149313, 17618.559536011606, 17636.559086022855, 17696.292148314085, 17700.55748606284, 17212.655746885055, 17349.0, 17406.651866962686, 17418.3903563375, 17429.0, 2937.9265518362, 2997.130832058706, 3025.788194826363, 3038.31637881476, 3044.72597466228, 2991.1176203020054, 3017.0647099399257, 3056.083175047488, 3056.190109620952, 3057.281538838371, 3017.200441882892, 3025.6217972753407, 3073.661897191307, 3169.2235402326464, 3172.6510083890753, 3076.1848110250576, 3095.8916437924677, 3107.984460077708, 3114.5795317632055, 3131.170239886432, 3004.444177827109, 3004.5643381709747, 3011.1869795155403, 3022.531507616323, 3039.149038269288, 16871.325146994106, 16934.3226270949, 17029.48911532656, 17036.829631703647, 17075.316987320493, 9190.0, 9445.952770236105, 9460.57427415768, 9483.478408687519, 9490.335676502647, 6115.235595550556, 6174.166487524171, 6351.824912391223, 6388.840278993016, 6429.324920883333, 2140.957180856374, 2171.348595421383, 2178.498945242603, 2231.0, 2236.9217077402377, 31421.84289078563, 31547.684523154705, 31549.52675709866, 31874.681253187635, 31896.840515797503, 7818.413618978486, 7871.960640196762, 7921.960390198012, 8032.759017229492, 8085.919140808634, 20244.392668219978, 20278.0, 20324.0, 20438.59122817565, 20486.487837804176, 9067.727968160965, 9195.540222988824, 9224.769380765534, 9226.123518265755, 9235.307351948632, 8219.260266576037, 8234.794130146794, 8299.419040667217, 8449.619767110495, 8501.277391421798, 6232.127502149703, 6336.746530138835, 6350.7459701611415, 6390.584612000205, 6448.742050317935, 1808.1863161577344, 1810.1130446081588, 1826.205600563759, 1834.660587791263, 1852.536865783554, 862.4868203418956, 1006.8590397344377, 1007.1590222164575, 1009.914157296638, 1019.8266294729914, 9855.45794981283, 9895.851562226573, 10022.248331375176, 10159.695209143738, 10161.949190254001, 1066.5467176450134, 1074.6292529077455, 1098.2092893117103, 1100.3837850803575, 1119.5297974850582, 5917.704114794243, 6023.096535519707, 6175.413335733098, 6296.874062518724, 6382.234131904108, 24752.628710569355, 26091.739082608932, 26496.0, 27060.0, 27103.593446098323, 24763.876180618983, 26097.869510652326, 26128.86935565348, 26387.73612263853, 26469.867650661625, 13019.218846869218, 13138.211707297593, 13282.601521954357, 13314.267715275559, 13342.332883355988, 9179.0, 9257.583408746488, 9299.535023248945, 9319.673811416567, 9325.906740932503, 21833.890830545744, 22087.447813804785, 22522.0, 22576.09695612157, 22797.316080517612, 22906.770932290463, 23076.4230894229, 23146.189883354004, 23178.884105579364, 23219.76780232176, 12826.23042617446, 12887.806682899576, 13037.608871733863, 13040.41318140667, 13055.281959492318, 16110.275037623102, 16207.513774586781, 16456.506304810875, 16482.0, 16499.17504124765, 13084.149530280501, 13308.93345533266, 13384.130031547918, 13447.125936814076, 13563.59309220725, 12841.101122921305, 13030.804537932128, 13336.93331533375, 13388.866111338762, 13541.255230962392, 10110.140638045848, 10159.288849780445, 10283.125934295369, 10283.588656453658, 10286.331388459726, 8194.67221311141, 8330.958345208235, 8338.082810890675, 8404.0, 8479.40644154928, 8310.750677479686, 8517.531535765593, 8536.359773017173, 8594.31245500371, 8629.827403452022], "value": 7730.208226289946, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.1530089021361, 589.4194218694585, 595.1221947627253, 610.4658423879107, 635.7806556737924, 6412.198475190601, 6436.195475565554, 6493.707783149758, 6499.545031847772, 6533.607983520992, 6357.8410539736415, 6379.202599675041, 6389.808305750823, 6403.807885763423, 6453.354664533545, 5193.662411943231, 5205.297284866532, 5212.087884620205, 5275.6043296752705, 5279.234510995903, 4963.379577552788, 5074.974625126869, 5223.563520032003, 5281.709505977189, 5294.338207724035, 5044.520770526794, 5078.314427552288, 5092.0579692756955, 5100.225832883658, 5111.028904508132, 5050.343455350818, 5056.115179843513, 5073.695578265298, 5118.181091025455, 5134.1528647773075, 4623.930641040387, 4646.605038571725, 4652.092841895832, 4652.930206046912, 4673.668004618701, 6333.7466501339895, 6337.207849018872, 6351.0, 6373.6175829450385, 6378.138951241569, 6066.878662426727, 6108.816735497942, 6117.66352850593, 6139.570230083896, 6146.66193359365, 6805.6597170141295, 6836.3083934675215, 6857.965710171467, 6876.1748590169, 6952.270011648755, 5002.349694539723, 5261.500157485033, 5271.182966640177, 5288.788448462057, 5307.097793375096, 7008.439324853999, 7065.0, 7163.892541611932, 7181.0, 7186.928130718678, 5415.6441947752855, 5422.7017514036315, 5428.158635411518, 5435.184722291688, 5445.2921120254905, 5419.590906364374, 5470.124780035176, 5474.616776825584, 5476.835694929158, 5545.584081193846, 6005.459508644243, 6057.123440997765, 6110.908336374958, 6128.3258841527395, 6141.6007959482495, 6865.352315444257, 6872.69072891711, 6882.5870447772295, 6913.585184888922, 6935.965320173367, 1862.8044055374262, 1875.4561177258715, 1886.3492095227125, 1887.9622407551772, 1888.282452668005, 1292.9224246545236, 1316.82881225442, 1344.0658742174292, 1350.4260689207047, 1355.969463207969, 6305.306416294204, 6326.398992095744, 6353.491720662429, 6394.552381333355, 6436.871262574722, 6866.485013623998, 6899.517033807585, 6917.27368626287, 6924.272951340137, 6935.0, 6290.528210384239, 6297.866384050915, 6323.968380158161, 6421.678916054178, 6451.645159516272, 3628.1292489802786, 3684.631536846294, 3686.907827304285, 3698.9445158322646, 3713.387291096939, 7162.498625096193, 7169.354758071799, 7187.856242875113, 7201.7756981313305, 7227.16887557927, 7111.964440177766, 7137.00081988522, 7217.3504384604585, 7227.915812628148, 7240.52936559122, 7046.6828992695455, 7086.681099350541, 7101.088553693065, 7150.889363127057, 7174.354308112295, 6907.758228461979, 6924.169099708067, 6956.339252700804, 6958.304169583002, 6986.615736134561, 6737.461003119836, 6824.93175068243, 6828.931710682829, 6869.7595584154315, 6933.37599616037, 7057.2237053925055, 7140.214576396696, 7187.640617969185, 7233.493655444068, 7269.636518173965, 5303.231031500488, 5351.5183633471615, 5361.973190134025, 5375.274337964481, 5386.218998245311, 6672.199336079701, 6796.864062718817, 6865.588064716133, 6948.583085014915, 6980.650967451708, 6702.497312701665, 6726.495512836459, 6768.492363072691, 6770.221424536045, 6855.417289530246, 6660.0, 6670.866582668416, 6769.593824370553, 6819.965900170468, 6831.180258369028, 6460.773872914426, 6672.933270667231, 6687.164104486939, 6773.153355830521, 6817.965910170616, 6882.965585172243, 6915.827104322432, 6916.619585922823, 6921.342472465108, 6974.163100427981, 6653.9667301663185, 6681.899771503528, 6689.799306020827, 6714.328567143247, 6726.764563240263], "value": 5352.574495971589, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1007.4912169354475, 1023.4780262066348, 1041.0942480042365, 1041.2607048995212, 1047.993925831202, 20842.0, 21186.57626847464, 21187.046582903768, 21191.364259072252, 21200.25799097032, 20408.387748367535, 20433.69349459759, 20671.0, 20699.0, 20741.585168296624, 1074.4520294649747, 1099.4667586220717, 1111.5387114347536, 1113.3153110836818, 1113.3375641493299, 1100.8073587122221, 1106.3251416635846, 1107.2581370481757, 1107.5071593141056, 1107.972300692481, 1127.8928501792316, 1137.5392965848844, 1165.4464129538487, 1172.0155069741415, 1174.829649700793, 1162.7441962768178, 1169.7601991591746, 1176.611718133014, 1176.6999415149126, 1176.8587769467676, 823.0206054794775, 824.7525742277293, 829.1873963515789, 830.3232865214891, 830.5224495914873, 20617.793822061736, 20804.27185048531, 20841.16635334585, 21024.0, 21041.47396315089, 24318.513629727306, 24419.812262831998, 24843.130490432748, 24894.0, 24909.377265568324, 19613.705794413094, 19766.308179213658, 19871.20515179391, 19889.60220795576, 19951.201951922052, 4235.57644235577, 4266.87199384019, 4267.637250833683, 4267.957320426787, 4270.572942705736, 138524.0, 165829.0, 173521.0, 173561.0, 173731.0, 19127.426177214427, 19498.0, 19792.90103549502, 19806.801931980783, 19821.702674459608, 35680.28639427197, 36351.0, 36824.631753682654, 36869.81565092211, 36874.44688329677, 10187.796244075076, 10276.640317588848, 10298.536565854554, 10437.530311136017, 10437.68686939393, 4929.679570827885, 5006.64953453262, 5040.949590504121, 5057.367829021372, 5061.620378471555, 6361.650109244036, 6441.58129721576, 6442.742290308429, 6445.323241059715, 6490.448311893448, 1254.2098477958828, 1255.8116282557507, 1272.090455324429, 1273.6433798536425, 1276.3299267884436, 776.5534817479971, 780.679921232292, 782.3311069036006, 795.3398679096337, 799.7600719784042, 13599.59201223965, 13842.930785346009, 14877.925610371878, 14947.103173809606, 15105.848941510445, 773.4894969320221, 774.7869335932663, 776.4138075752884, 779.2713812585251, 793.8372633610096, 6217.285012223652, 6286.779962701284, 6344.111824344595, 6354.491640668735, 6409.102725618417, 159510.0, 162363.0, 162711.18644406702, 163519.0, 163545.0, 119631.40184299022, 135264.0, 137899.86300411003, 138293.3085334567, 141482.2925885364, 124890.37554812168, 125061.37469312595, 125176.37411813065, 125916.0, 126603.0, 15144.394224230908, 15677.843221568095, 15869.682606347578, 15898.920505397398, 16010.759838602196, 55627.72186139043, 55776.72111639416, 55966.440335596126, 56356.43643563512, 57416.0, 70938.0, 71170.64414677894, 71258.64370678113, 72455.63772181106, 74244.25755742373, 19844.30544930978, 20196.091175896825, 20415.0, 20629.58740825205, 20650.58698825985, 23908.0, 24991.625125623494, 25044.0, 25358.619620706075, 25448.745512545378, 21987.34037978863, 22391.888040559694, 22429.5514089714, 22575.984080716735, 22621.547569048857, 18508.537286567942, 18689.345872894384, 18833.71749423787, 18934.14796334196, 18950.810491894903, 18531.0734463279, 18733.531661708566, 18815.435536933914, 18873.0, 18891.43325700231, 14963.551093467213, 14969.40122395092, 15035.398584056515, 15070.773938390714, 15085.849141508445, 14946.626334341729, 14983.026103303251, 15334.233288335316, 15432.0, 15481.922590386976], "value": 10716.401344836546, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1359.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 107.0, 107.0, 106.0, 105.0, 108.0, 108.0, 107.0, 106.0, 106.0], "value": 106.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 114.0, 111.0, 115.0, 110.0, 113.0, 113.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 164.0, 164.0, 162.0, 161.0, 162.0, 160.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 75.0, 75.0, 78.0, 74.0, 81.0, 72.0, 73.0], "value": 75.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 77.0, 83.0, 77.0, 78.0, 78.0, 80.0, 77.0, 78.0, 78.0], "value": 78.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0, 117.0, 113.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 147.0, 148.0, 148.0, 148.0, 149.0, 147.0, 149.0, 148.0, 150.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 103.0, 95.0, 99.0, 99.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [44.0, 43.0, 43.0, 43.0, 43.0, 43.0, 45.0, 43.0, 43.0, 48.0], "value": 43.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0, 38.0], "value": 38.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 69.0, 70.0, 68.0, 69.0, 69.0, 72.0, 70.0, 69.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 102.0, 103.0, 108.0, 110.0, 106.0, 101.0, 105.0, 104.0, 108.0], "value": 104.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 154.0, 152.0, 155.0, 150.0, 149.0, 148.0, 147.0, 147.0, 149.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 59.0, 58.0, 55.0, 60.0, 57.0, 60.0, 61.0, 63.0], "value": 59.5, "unit": "score"}]}]} 11:51:33 INFO - Return code: 0 11:51:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 11:51:33 INFO - # TBPL SUCCESS # 11:51:33 INFO - Running post-action listener: _package_coverage_data 11:51:33 INFO - Running post-action listener: _resource_record_post_action 11:51:33 INFO - [mozharness: 2017-10-07 18:51:33.950160Z] Finished run-tests step (success) 11:51:33 INFO - Running post-run listener: _resource_record_post_run 11:51:34 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 284856320; Read time: 12; Write time: 128204 11:51:34 INFO - TinderboxPrint: CPU usage
13.0% 11:51:34 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 11:51:34 INFO - TinderboxPrint: I/O write bytes / time
284,856,320 / 128,204 11:51:34 INFO - TinderboxPrint: CPU idle
8,181.5 (87.0%) 11:51:34 INFO - TinderboxPrint: CPU user
1,179.2 (12.5%) 11:51:34 INFO - TinderboxPrint: Swap in / out
0 / 0 11:51:34 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 9117696; Read time: 0; Write time: 1068 11:51:34 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 11:51:34 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275365888; Read time: 12; Write time: 127112 11:51:34 INFO - Running post-run listener: _upload_blobber_files 11:51:34 INFO - Blob upload gear active. 11:51:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:51:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 11:51:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 11:51:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 11:51:34 INFO - (blobuploader) - INFO - Open directory for files ... 11:51:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:51:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:51:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:35 INFO - (blobuploader) - INFO - Done attempting. 11:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:36 INFO - (blobuploader) - INFO - Done attempting. 11:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 11:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 11:51:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:43 INFO - (blobuploader) - INFO - Done attempting. 11:51:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 11:51:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:51:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:51:44 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 11:51:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:51:44 INFO - (blobuploader) - INFO - Done attempting. 11:51:44 INFO - (blobuploader) - INFO - Iteration through files over. 11:51:44 INFO - Return code: 0 11:51:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:51:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:51:44 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/adea3ed99e4e6fb5ab288db93c283495caeb8c586033caba3eec3fa6e0472fbb3b0aa3c924ba88192440f499748ab2af925fa567f24844780fb3ba9fa18b831c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e31b04778740462b152a78fee9ada090e7a7436da05d79081ee08294bfd9e1ae3a37629f560dc191b226dc38f34d741a037279b234d356143f42cd627066fa6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a89c964dc05ef3259aeda8fbf50eefd1ec7bb7ef9d0ff4487440123c428e7a474e4d766dc085b7570525f12fbd016ebca199f667da5f2e9a81d241b9c7cfeb1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/668f7caf35004f6cb23aa6d9a1759a2b687688a72ed71b514287c6e41f8822410aeb03bfadbc277d93556ae52f2fbc3faaefa7f07eedeb2e4f1b44e7c46acaa9"} 11:51:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:51:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:51:44 INFO - Contents: 11:51:44 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/adea3ed99e4e6fb5ab288db93c283495caeb8c586033caba3eec3fa6e0472fbb3b0aa3c924ba88192440f499748ab2af925fa567f24844780fb3ba9fa18b831c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e31b04778740462b152a78fee9ada090e7a7436da05d79081ee08294bfd9e1ae3a37629f560dc191b226dc38f34d741a037279b234d356143f42cd627066fa6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a89c964dc05ef3259aeda8fbf50eefd1ec7bb7ef9d0ff4487440123c428e7a474e4d766dc085b7570525f12fbd016ebca199f667da5f2e9a81d241b9c7cfeb1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/668f7caf35004f6cb23aa6d9a1759a2b687688a72ed71b514287c6e41f8822410aeb03bfadbc277d93556ae52f2fbc3faaefa7f07eedeb2e4f1b44e7c46acaa9"} 11:51:44 INFO - Running post-run listener: copy_logs_to_upload_dir 11:51:44 INFO - Copying logs to upload dir... 11:51:44 INFO - mkdir: /builds/slave/test/build/upload/logs 11:51:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.927426 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2017-10-07 11:51:45.026657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-07 11:51:45.029988) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/adea3ed99e4e6fb5ab288db93c283495caeb8c586033caba3eec3fa6e0472fbb3b0aa3c924ba88192440f499748ab2af925fa567f24844780fb3ba9fa18b831c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e31b04778740462b152a78fee9ada090e7a7436da05d79081ee08294bfd9e1ae3a37629f560dc191b226dc38f34d741a037279b234d356143f42cd627066fa6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a89c964dc05ef3259aeda8fbf50eefd1ec7bb7ef9d0ff4487440123c428e7a474e4d766dc085b7570525f12fbd016ebca199f667da5f2e9a81d241b9c7cfeb1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/668f7caf35004f6cb23aa6d9a1759a2b687688a72ed71b514287c6e41f8822410aeb03bfadbc277d93556ae52f2fbc3faaefa7f07eedeb2e4f1b44e7c46acaa9"} build_url:https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011477 build_url: 'https://queue.taskcluster.net/v1/task/SEHjNn5WRO26WkzdmSigsQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/adea3ed99e4e6fb5ab288db93c283495caeb8c586033caba3eec3fa6e0472fbb3b0aa3c924ba88192440f499748ab2af925fa567f24844780fb3ba9fa18b831c", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2e31b04778740462b152a78fee9ada090e7a7436da05d79081ee08294bfd9e1ae3a37629f560dc191b226dc38f34d741a037279b234d356143f42cd627066fa6", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/6a89c964dc05ef3259aeda8fbf50eefd1ec7bb7ef9d0ff4487440123c428e7a474e4d766dc085b7570525f12fbd016ebca199f667da5f2e9a81d241b9c7cfeb1", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/668f7caf35004f6cb23aa6d9a1759a2b687688a72ed71b514287c6e41f8822410aeb03bfadbc277d93556ae52f2fbc3faaefa7f07eedeb2e4f1b44e7c46acaa9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-07 11:51:45.062183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:51:45.062852) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7fc86f70bae03e018da0b1d8000001c4-1507400164.989496-1587319665 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-07 11:51:45.143854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-07 11:51:45.144201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-07 11:51:45.144530) ========= ========= Total master_lag: 0.20 =========