builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-031 starttime: 1507645755.48 results: success (0) revision: d88cd1a9f80611636ded817b3682dd04e838de6c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.483851) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.484284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.484550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.503489) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.503840) ========= 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=db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-10-10 07:29:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2017-10-10 07:29:15 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105662 ========= master_lag: 0.09 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.700530) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.700902) ========= 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=db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020943 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.766558) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:15.767402) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d88cd1a9f80611636ded817b3682dd04e838de6c --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 d88cd1a9f80611636ded817b3682dd04e838de6c --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=db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-10-10 07:29:15,820 truncating revision to first 12 chars 2017-10-10 07:29:15,820 Setting DEBUG logging. 2017-10-10 07:29:15,820 attempt 1/10 2017-10-10 07:29:15,820 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d88cd1a9f806?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-10-10 07:29:16,308 unpacking tar archive at: mozilla-beta-d88cd1a9f806/testing/mozharness/ program finished with exit code 0 elapsedTime=0.820971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:16.607063) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:16.607991) ========= script_repo_revision: d88cd1a9f80611636ded817b3682dd04e838de6c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:16.608448) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:16.608740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-10-10 07:29:16.623022) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-10 07:29:16.623415) ========= /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=db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:29:16 INFO - MultiFileLogger online at 20171010 07:29:16 in /builds/slave/test 07:29:16 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 07:29:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:29:16 INFO - {'append_to_log': False, 07:29:16 INFO - 'base_work_dir': '/builds/slave/test', 07:29:16 INFO - 'blob_upload_branch': 'Mozilla-Beta-Non-PGO', 07:29:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:29:16 INFO - 'branch': 'Mozilla-Beta-Non-PGO', 07:29:16 INFO - 'buildbot_json_path': 'buildprops.json', 07:29:16 INFO - 'code_coverage': False, 07:29:16 INFO - 'config_files': ('talos/linux_config.py',), 07:29:16 INFO - 'default_actions': ('clobber', 07:29:16 INFO - 'read-buildbot-config', 07:29:16 INFO - 'download-and-extract', 07:29:16 INFO - 'populate-webroot', 07:29:16 INFO - 'create-virtualenv', 07:29:16 INFO - 'install', 07:29:16 INFO - 'setup-mitmproxy', 07:29:16 INFO - 'run-tests'), 07:29:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:29:16 INFO - 'disable_ccov_upload': False, 07:29:16 INFO - 'disable_stylo': False, 07:29:16 INFO - 'download_minidump_stackwalk': True, 07:29:16 INFO - 'download_symbols': 'ondemand', 07:29:16 INFO - 'enable_stylo': False, 07:29:16 INFO - 'enable_webrender': False, 07:29:16 INFO - 'exes': {'tooltool.py': '/tools/tooltool.py'}, 07:29:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:29:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:29:16 INFO - 'gecko_profile': False, 07:29:16 INFO - 'gecko_profile_interval': 0, 07:29:16 INFO - 'installer_path': 'installer.exe', 07:29:16 INFO - 'log_level': 'info', 07:29:16 INFO - 'log_name': 'talos', 07:29:16 INFO - 'log_to_console': True, 07:29:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:29:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:29:16 INFO - 'opt_config_files': (), 07:29:16 INFO - 'pip_index': False, 07:29:16 INFO - 'suite': 'dromaeojs-e10s', 07:29:16 INFO - 'system_bits': '32', 07:29:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:29:16 INFO - 'title': 'talos-linux64-ix-031', 07:29:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:29:16 INFO - 'use_talos_json': True, 07:29:16 INFO - 'verify': 'False', 07:29:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:29:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:29:16 INFO - 'work_dir': 'build'} 07:29:16 INFO - [mozharness: 2017-10-10 14:29:16.815663Z] Running clobber step. 07:29:16 INFO - Running pre-action listener: _resource_record_pre_action 07:29:16 INFO - Running main action method: clobber 07:29:16 INFO - rmtree: /builds/slave/test/build 07:29:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:29:17 INFO - Running post-action listener: _resource_record_post_action 07:29:17 INFO - [mozharness: 2017-10-10 14:29:17.827438Z] Finished clobber step (success) 07:29:17 INFO - [mozharness: 2017-10-10 14:29:17.827534Z] Running read-buildbot-config step. 07:29:17 INFO - Running pre-action listener: _resource_record_pre_action 07:29:17 INFO - Running main action method: read_buildbot_config 07:29:17 INFO - Using buildbot properties: 07:29:17 INFO - { 07:29:17 INFO - "project": "", 07:29:17 INFO - "product": "firefox", 07:29:17 INFO - "who": "ryanvm@gmail.com", 07:29:17 INFO - "installer_path": "public/build/target.tar.bz2", 07:29:17 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 07:29:17 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta", 07:29:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta talos dromaeojs-e10s", 07:29:17 INFO - "stage_platform": "linux64", 07:29:17 INFO - "basedir": "/builds/slave/test", 07:29:17 INFO - "buildnumber": 130, 07:29:17 INFO - "platform": "ubuntu64_hw", 07:29:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:29:17 INFO - "slavebuilddir": "test", 07:29:17 INFO - "taskId": "bPAJGfAQSh2cN7z9cAptwQ", 07:29:17 INFO - "branch": "mozilla-beta", 07:29:17 INFO - "script_repo_revision": "production", 07:29:17 INFO - "revision": "d88cd1a9f80611636ded817b3682dd04e838de6c", 07:29:17 INFO - "slavename": "talos-linux64-ix-031", 07:29:17 INFO - "repo_path": "releases/mozilla-beta" 07:29:17 INFO - } 07:29:17 INFO - Finding installer, test and symbols from parent task. 07:29:17 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bPAJGfAQSh2cN7z9cAptwQ'}, attempt #1 07:29:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bPAJGfAQSh2cN7z9cAptwQ'}, attempt #1 07:29:18 INFO - Task dependencies: IkAJlwb6TImMfvpHikmHVA 07:29:18 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA'}, attempt #1 07:29:19 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.tar.bz2 07:29:19 INFO - Set test_packages_url: https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.test_packages.json 07:29:19 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.crashreporter-symbols.zip 07:29:19 INFO - Running post-action listener: _resource_record_post_action 07:29:19 INFO - [mozharness: 2017-10-10 14:29:19.166403Z] Finished read-buildbot-config step (success) 07:29:19 INFO - [mozharness: 2017-10-10 14:29:19.166618Z] Running download-and-extract step. 07:29:19 INFO - Running pre-action listener: _resource_record_pre_action 07:29:19 INFO - Running main action method: download_and_extract 07:29:19 INFO - mkdir: /builds/slave/test/build/tests 07:29:19 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')]} 07:29:19 INFO - trying https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.test_packages.json 07:29:19 INFO - Downloading https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:29:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:29:19 INFO - Downloaded 989 bytes. 07:29:19 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:29:19 INFO - Using the following test package requirements: 07:29:19 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 07:29:19 INFO - u'common': [u'target.common.tests.zip'], 07:29:19 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:29:19 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:29:19 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:29:19 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:29:19 INFO - u'mozbase': [u'target.common.tests.zip'], 07:29:19 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:29:19 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:29:19 INFO - u'web-platform': [u'target.common.tests.zip', 07:29:19 INFO - u'target.web-platform.tests.tar.gz'], 07:29:19 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:29:19 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite categories: ['common', 'talos'] 07:29:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.common.tests.zip 07:29:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:29:19 INFO - Fetch https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.common.tests.zip into memory 07:29:22 INFO - Content-Length response header: 55177526 07:29:22 INFO - Bytes received: 55177526 07:29:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.talos.tests.zip 07:29:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:29:33 INFO - Fetch https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.talos.tests.zip into memory 07:29:34 INFO - Content-Length response header: 14509251 07:29:34 INFO - Bytes received: 14509251 07:29: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')]} 07:29:34 INFO - trying https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.tar.bz2 07:29:34 INFO - Downloading https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:29:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:29:37 INFO - Downloaded 53596882 bytes. 07:29:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.tar.bz2 07:29:37 INFO - mkdir: /builds/slave/test/properties 07:29:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:29:37 INFO - Writing to file /builds/slave/test/properties/build_url 07:29:37 INFO - Contents: 07:29:37 INFO - build_url:https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.tar.bz2 07:29:37 INFO - Running post-action listener: _resource_record_post_action 07:29:37 INFO - Running post-action listener: find_tests_for_verification 07:29:37 INFO - Running post-action listener: set_extra_try_arguments 07:29:37 INFO - [mozharness: 2017-10-10 14:29:37.083001Z] Finished download-and-extract step (success) 07:29:37 INFO - [mozharness: 2017-10-10 14:29:37.083192Z] Running populate-webroot step. 07:29:37 INFO - Running pre-action listener: _resource_record_pre_action 07:29:37 INFO - Running main action method: populate_webroot 07:29:37 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:29:37 INFO - 'chromez-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['tresize', 07:29:37 INFO - 'tcanvasmark']}, 07:29:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:29:37 INFO - 'dromaeojs-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['dromaeo_css', 07:29:37 INFO - 'kraken']}, 07:29:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:37 INFO - 'g1-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:29:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'tests': ['damp', 'tps']}, 07:29:37 INFO - 'g2-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['damp', 'tps']}, 07:29:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:29:37 INFO - 'g3-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['dromaeo_dom']}, 07:29:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:29:37 INFO - 'g4-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['basic_compositor_video', 07:29:37 INFO - 'glvideo']}, 07:29:37 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 07:29:37 INFO - 'g5-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['ts_paint_webext', 07:29:37 INFO - 'tp5o_webext']}, 07:29:37 INFO - 'other-e10s': {'tests': ['a11yr', 07:29:37 INFO - 'ts_paint', 07:29:37 INFO - 'tpaint', 07:29:37 INFO - 'sessionrestore', 07:29:37 INFO - 'sessionrestore_many_windows', 07:29:37 INFO - 'sessionrestore_no_auto_restore', 07:29:37 INFO - 'tabpaint']}, 07:29:37 INFO - 'other-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['a11yr', 07:29:37 INFO - 'ts_paint', 07:29:37 INFO - 'tpaint', 07:29:37 INFO - 'sessionrestore', 07:29:37 INFO - 'sessionrestore_many_windows', 07:29:37 INFO - 'sessionrestore_no_auto_restore', 07:29:37 INFO - 'tabpaint']}, 07:29:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 07:29:37 INFO - 'perf-reftest-singletons-e10s': {'tests': ['perf_reftest_singletons']}, 07:29:37 INFO - 'perf-reftest-singletons-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['perf_reftest_singletons']}, 07:29:37 INFO - 'perf-reftest-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['bloom_basic']}, 07:29:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:29:37 INFO - 'tsvgr_opacity', 07:29:37 INFO - 'tart', 07:29:37 INFO - 'tscrollx', 07:29:37 INFO - 'tsvg_static']}, 07:29:37 INFO - 'svgr-stylo-disabled-e10s': {'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['tsvgx', 07:29:37 INFO - 'tsvgr_opacity', 07:29:37 INFO - 'tart', 07:29:37 INFO - 'tscrollx', 07:29:37 INFO - 'tsvg_static']}, 07:29:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:29:37 INFO - 'tp5o-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'talos_options': ['--disable-stylo'], 07:29:37 INFO - 'tests': ['tp5o']}, 07:29:37 INFO - 'tp6-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:29:37 INFO - 'talos_options': ['--mitmproxy', 07:29:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:29:37 INFO - '--firstNonBlankPaint'], 07:29:37 INFO - 'tests': ['tp6_google', 07:29:37 INFO - 'tp6_youtube', 07:29:37 INFO - 'tp6_amazon', 07:29:37 INFO - 'tp6_facebook']}, 07:29:37 INFO - 'tp6-stylo-disabled-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:29:37 INFO - 'talos_options': ['--disable-stylo', 07:29:37 INFO - '--mitmproxy', 07:29:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:29:37 INFO - '--firstNonBlankPaint'], 07:29:37 INFO - 'tests': ['tp6_google', 07:29:37 INFO - 'tp6_youtube', 07:29:37 INFO - 'tp6_amazon', 07:29:37 INFO - 'tp6_facebook']}, 07:29:37 INFO - 'tp6-stylo-threads-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 07:29:37 INFO - 'talos_options': ['--stylo-threads=1', 07:29:37 INFO - '--mitmproxy', 07:29:37 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 07:29:37 INFO - '--firstNonBlankPaint'], 07:29:37 INFO - 'tests': ['tp6_google', 07:29:37 INFO - 'tp6_youtube', 07:29:37 INFO - 'tp6_amazon', 07:29:37 INFO - 'tp6_facebook']}, 07:29:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'talos_options': ['--xperf_path', 07:29:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:37 INFO - 'tests': ['tp5n']}, 07:29:37 INFO - 'xperf-stylo-disabled-e10s': {'pagesets_name': 'tp5n.zip', 07:29:37 INFO - 'talos_options': ['--disable-stylo', 07:29:37 INFO - '--xperf_path', 07:29:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:29:37 INFO - 'tests': ['tp5n']}}} 07:29:37 INFO - Running post-action listener: _resource_record_post_action 07:29:37 INFO - [mozharness: 2017-10-10 14:29:37.099214Z] Finished populate-webroot step (success) 07:29:37 INFO - [mozharness: 2017-10-10 14:29:37.099305Z] Running create-virtualenv step. 07:29:37 INFO - Running pre-action listener: _resource_record_pre_action 07:29:37 INFO - Running main action method: create_virtualenv 07:29:37 INFO - Creating virtualenv /builds/slave/test/build/venv 07:29:37 INFO - Running command: ['virtualenv', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:29:37 INFO - Copy/paste: virtualenv --no-site-packages --distribute /builds/slave/test/build/venv 07:29:37 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 07:29:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:29:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:29:38 INFO - Installing distribute.............................................................................................................................................................................................done. 07:29:38 INFO - Installing pip...............done. 07:29:38 INFO - Return code: 0 07:29:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:29:39 INFO - Reading from file tmpfile_stdout 07:29:39 INFO - Output received: 07:29:39 INFO - pip 1.1 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.1-py2.7.egg (python 2.7) 07:29:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:29:39 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')]} 07:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:39 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')]} 07:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:39 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:39 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 07:29:39 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 07:29:39 INFO - Using env: {'DISPLAY': ':0', 07:29:39 INFO - 'HOME': '/home/cltbld', 07:29:39 INFO - 'LANG': 'en_US.UTF-8', 07:29:39 INFO - 'LANGUAGE': 'en_US:en', 07:29:39 INFO - 'LOGNAME': 'cltbld', 07:29:39 INFO - 'MAIL': '/var/mail/cltbld', 07:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:39 INFO - 'MOZ_NO_REMOTE': '1', 07:29:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:39 INFO - 'NO_EM_RESTART': '1', 07:29:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:39 INFO - 'PWD': '/builds/slave/test', 07:29:39 INFO - 'SHELL': '/bin/bash', 07:29:39 INFO - 'SHLVL': '1', 07:29:39 INFO - 'TERM': 'linux', 07:29:39 INFO - 'TMOUT': '86400', 07:29:39 INFO - 'USER': 'cltbld', 07:29:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:39 INFO - '_': '/tools/buildbot/bin/python'} 07:29:40 INFO - Ignoring indexes: http://pypi.python.org/simple/ 07:29:40 INFO - Downloading/unpacking pip>=1.5 07:29:40 INFO - Running setup.py egg_info for package pip 07:29:40 INFO - warning: no files found matching 'pip/cacert.pem' 07:29:40 INFO - warning: no files found matching '*.html' under directory 'docs' 07:29:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:29:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:29:40 INFO - Installing collected packages: pip 07:29:40 INFO - Found existing installation: pip 1.1 07:29:40 INFO - Uninstalling pip: 07:29:40 INFO - Successfully uninstalled pip 07:29:40 INFO - Running setup.py install for pip 07:29:40 INFO - warning: no files found matching 'pip/cacert.pem' 07:29:40 INFO - warning: no files found matching '*.html' under directory 'docs' 07:29:40 INFO - warning: no previously-included files matching '*.rst' found under directory 'docs/_build' 07:29:40 INFO - no previously-included directories found matching 'docs/_build/_sources' 07:29:40 INFO - Installing pip script to /builds/slave/test/build/venv/bin 07:29:40 INFO - Installing pip2.7 script to /builds/slave/test/build/venv/bin 07:29:40 INFO - Installing pip2 script to /builds/slave/test/build/venv/bin 07:29:40 INFO - Successfully installed pip 07:29:40 INFO - Cleaning up... 07:29:40 INFO - Return code: 0 07:29:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29: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')]} 07:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29: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', '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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29: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', 'psutil>=3.1.1'] in /builds/slave/test/build 07:29: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 psutil>=3.1.1 07:29:40 INFO - Using env: {'DISPLAY': ':0', 07:29:40 INFO - 'HOME': '/home/cltbld', 07:29:40 INFO - 'LANG': 'en_US.UTF-8', 07:29:40 INFO - 'LANGUAGE': 'en_US:en', 07:29:40 INFO - 'LOGNAME': 'cltbld', 07:29:40 INFO - 'MAIL': '/var/mail/cltbld', 07:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:40 INFO - 'MOZ_NO_REMOTE': '1', 07:29:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:40 INFO - 'NO_EM_RESTART': '1', 07:29:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:40 INFO - 'PWD': '/builds/slave/test', 07:29:40 INFO - 'SHELL': '/bin/bash', 07:29:40 INFO - 'SHLVL': '1', 07:29:40 INFO - 'TERM': 'linux', 07:29:40 INFO - 'TMOUT': '86400', 07:29:40 INFO - 'USER': 'cltbld', 07:29:40 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:40 INFO - '_': '/tools/buildbot/bin/python'} 07:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:40 INFO - Downloading/unpacking psutil>=3.1.1 07:29: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 07:29: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 07:29: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 07:29: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 07:29:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:29:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:41 INFO - Installing collected packages: psutil 07:29:41 INFO - Running setup.py install for psutil 07:29:41 INFO - building 'psutil._psutil_linux' extension 07:29:41 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 07:29:41 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 07:29:41 INFO - building 'psutil._psutil_posix' extension 07:29:41 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 07:29:42 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 07:29:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:29:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:29:43 INFO - Successfully installed psutil 07:29:43 INFO - Cleaning up... 07:29:43 INFO - Return code: 0 07:29:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:29:43 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')]} 07:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:43 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')]} 07:29:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:43 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:43 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 07:29:43 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 07:29:43 INFO - Using env: {'DISPLAY': ':0', 07:29:43 INFO - 'HOME': '/home/cltbld', 07:29:43 INFO - 'LANG': 'en_US.UTF-8', 07:29:43 INFO - 'LANGUAGE': 'en_US:en', 07:29:43 INFO - 'LOGNAME': 'cltbld', 07:29:43 INFO - 'MAIL': '/var/mail/cltbld', 07:29:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:43 INFO - 'MOZ_NO_REMOTE': '1', 07:29:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:43 INFO - 'NO_EM_RESTART': '1', 07:29:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:43 INFO - 'PWD': '/builds/slave/test', 07:29:43 INFO - 'SHELL': '/bin/bash', 07:29:43 INFO - 'SHLVL': '1', 07:29:43 INFO - 'TERM': 'linux', 07:29:43 INFO - 'TMOUT': '86400', 07:29:43 INFO - 'USER': 'cltbld', 07:29:43 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:43 INFO - '_': '/tools/buildbot/bin/python'} 07:29:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:29: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 07:29: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 07:29: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 07:29: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 07:29:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:29:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:29:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:29:44 INFO - Installing collected packages: mozsystemmonitor 07:29:44 INFO - Running setup.py install for mozsystemmonitor 07:29:44 INFO - Successfully installed mozsystemmonitor 07:29:44 INFO - Cleaning up... 07:29:44 INFO - Return code: 0 07:29:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:29: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')]} 07:29:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29: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')]} 07:29:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:44 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:44 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 07:29:44 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 07:29:44 INFO - Using env: {'DISPLAY': ':0', 07:29:44 INFO - 'HOME': '/home/cltbld', 07:29:44 INFO - 'LANG': 'en_US.UTF-8', 07:29:44 INFO - 'LANGUAGE': 'en_US:en', 07:29:44 INFO - 'LOGNAME': 'cltbld', 07:29:44 INFO - 'MAIL': '/var/mail/cltbld', 07:29:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:44 INFO - 'MOZ_NO_REMOTE': '1', 07:29:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:44 INFO - 'NO_EM_RESTART': '1', 07:29:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:44 INFO - 'PWD': '/builds/slave/test', 07:29:44 INFO - 'SHELL': '/bin/bash', 07:29:44 INFO - 'SHLVL': '1', 07:29:44 INFO - 'TERM': 'linux', 07:29:44 INFO - 'TMOUT': '86400', 07:29:44 INFO - 'USER': 'cltbld', 07:29:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:44 INFO - '_': '/tools/buildbot/bin/python'} 07:29:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:45 INFO - Downloading/unpacking jsonschema==2.5.1 07:29:45 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 07:29:45 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 07:29:45 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 07:29:45 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 07:29:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:29:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:29:46 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 07:29:46 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 07:29:46 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 07:29:46 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 07:29:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:29:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:29:46 INFO - warning: no files found matching '*.txt' 07:29:46 INFO - no previously-included directories found matching 'build' 07:29:46 INFO - no previously-included directories found matching 'dist' 07:29:46 INFO - no previously-included directories found matching '.git*' 07:29:46 INFO - Installing collected packages: jsonschema, functools32 07:29:46 INFO - Running setup.py install for functools32 07:29:46 INFO - warning: no files found matching '*.txt' 07:29:46 INFO - no previously-included directories found matching 'build' 07:29:46 INFO - no previously-included directories found matching 'dist' 07:29:46 INFO - no previously-included directories found matching '.git*' 07:29:46 INFO - Successfully installed jsonschema functools32 07:29:46 INFO - Cleaning up... 07:29:46 INFO - Return code: 0 07:29:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:29:46 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')]} 07:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:46 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')]} 07:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:46 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:46 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 07:29:46 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 07:29:46 INFO - Using env: {'DISPLAY': ':0', 07:29:46 INFO - 'HOME': '/home/cltbld', 07:29:46 INFO - 'LANG': 'en_US.UTF-8', 07:29:46 INFO - 'LANGUAGE': 'en_US:en', 07:29:46 INFO - 'LOGNAME': 'cltbld', 07:29:46 INFO - 'MAIL': '/var/mail/cltbld', 07:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:46 INFO - 'MOZ_NO_REMOTE': '1', 07:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:46 INFO - 'NO_EM_RESTART': '1', 07:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:46 INFO - 'PWD': '/builds/slave/test', 07:29:46 INFO - 'SHELL': '/bin/bash', 07:29:46 INFO - 'SHLVL': '1', 07:29:46 INFO - 'TERM': 'linux', 07:29:46 INFO - 'TMOUT': '86400', 07:29:46 INFO - 'USER': 'cltbld', 07:29:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:46 INFO - '_': '/tools/buildbot/bin/python'} 07:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:29:46 INFO - Cleaning up... 07:29:46 INFO - Return code: 0 07:29:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:29:46 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')]} 07:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:46 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')]} 07:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:46 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:46 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 07:29:46 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 07:29:46 INFO - Using env: {'DISPLAY': ':0', 07:29:46 INFO - 'HOME': '/home/cltbld', 07:29:46 INFO - 'LANG': 'en_US.UTF-8', 07:29:46 INFO - 'LANGUAGE': 'en_US:en', 07:29:46 INFO - 'LOGNAME': 'cltbld', 07:29:46 INFO - 'MAIL': '/var/mail/cltbld', 07:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:46 INFO - 'MOZ_NO_REMOTE': '1', 07:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:46 INFO - 'NO_EM_RESTART': '1', 07:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:46 INFO - 'PWD': '/builds/slave/test', 07:29:46 INFO - 'SHELL': '/bin/bash', 07:29:46 INFO - 'SHLVL': '1', 07:29:46 INFO - 'TERM': 'linux', 07:29:46 INFO - 'TMOUT': '86400', 07:29:46 INFO - 'USER': 'cltbld', 07:29:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:46 INFO - '_': '/tools/buildbot/bin/python'} 07:29:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:29:47 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 07:29:47 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 07:29:47 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 07:29:47 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 07:29:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:29:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:29:48 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 07:29:48 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 07:29:48 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 07:29:48 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 07:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:29:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:29:48 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 07:29:48 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 07:29:48 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 07:29:48 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 07:29:48 INFO - Downloading docopt-0.6.1.tar.gz 07:29:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:29:48 INFO - Installing collected packages: blobuploader, requests, docopt 07:29:48 INFO - Running setup.py install for blobuploader 07:29:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:29:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:29:48 INFO - Running setup.py install for requests 07:29:49 INFO - Running setup.py install for docopt 07:29:49 INFO - Successfully installed blobuploader requests docopt 07:29:49 INFO - Cleaning up... 07:29:49 INFO - Return code: 0 07:29:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:49 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')]} 07:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:49 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')]} 07:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:49 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:49 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 07:29:49 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 07:29:49 INFO - Using env: {'DISPLAY': ':0', 07:29:49 INFO - 'HOME': '/home/cltbld', 07:29:49 INFO - 'LANG': 'en_US.UTF-8', 07:29:49 INFO - 'LANGUAGE': 'en_US:en', 07:29:49 INFO - 'LOGNAME': 'cltbld', 07:29:49 INFO - 'MAIL': '/var/mail/cltbld', 07:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:49 INFO - 'MOZ_NO_REMOTE': '1', 07:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:49 INFO - 'NO_EM_RESTART': '1', 07:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:49 INFO - 'PWD': '/builds/slave/test', 07:29:49 INFO - 'SHELL': '/bin/bash', 07:29:49 INFO - 'SHLVL': '1', 07:29:49 INFO - 'TERM': 'linux', 07:29:49 INFO - 'TMOUT': '86400', 07:29:49 INFO - 'USER': 'cltbld', 07:29:49 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:49 INFO - '_': '/tools/buildbot/bin/python'} 07:29:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:49 INFO - Running setup.py (path:/tmp/pip-8PaHid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:49 INFO - Running setup.py (path:/tmp/pip-7m6UV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:49 INFO - Running setup.py (path:/tmp/pip-fvqh01-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:49 INFO - Running setup.py (path:/tmp/pip-rZjdUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:49 INFO - Running setup.py (path:/tmp/pip-NmFZxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:50 INFO - Running setup.py (path:/tmp/pip-GCNtjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:50 INFO - Running setup.py (path:/tmp/pip-DKbKCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:50 INFO - Running setup.py (path:/tmp/pip-Q90LRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:50 INFO - Running setup.py (path:/tmp/pip-WNr3u3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:50 INFO - Running setup.py (path:/tmp/pip-By9E5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:50 INFO - Running setup.py (path:/tmp/pip-BCiZz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:50 INFO - Running setup.py (path:/tmp/pip-dvoLT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:50 INFO - Running setup.py (path:/tmp/pip-UeJxYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:50 INFO - Running setup.py (path:/tmp/pip-y36XXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:50 INFO - Running setup.py (path:/tmp/pip-Y6pWd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:50 INFO - Running setup.py (path:/tmp/pip-uGDNT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:50 INFO - Running setup.py (path:/tmp/pip-AdaWQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:29:50 INFO - Running setup.py install for manifestparser 07:29:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:29:50 INFO - Running setup.py install for mozcrash 07:29:51 INFO - Running setup.py install for mozdebug 07:29:51 INFO - Running setup.py install for mozdevice 07:29:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozfile 07:29:51 INFO - Running setup.py install for mozhttpd 07:29:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozinfo 07:29:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozInstall 07:29:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozleak 07:29:51 INFO - Running setup.py install for mozlog 07:29:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for moznetwork 07:29:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:29:51 INFO - Running setup.py install for mozprocess 07:29:52 INFO - Running setup.py install for mozprofile 07:29:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:29:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:29:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:29:52 INFO - Running setup.py install for mozrunner 07:29:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:29:52 INFO - Running setup.py install for mozscreenshot 07:29:52 INFO - Running setup.py install for moztest 07:29:52 INFO - Running setup.py install for mozversion 07:29:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:29:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:29:52 INFO - Cleaning up... 07:29:52 INFO - Return code: 0 07:29:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:52 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')]} 07:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:52 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')]} 07:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:52 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:52 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 07:29:52 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 07:29:52 INFO - Using env: {'DISPLAY': ':0', 07:29:52 INFO - 'HOME': '/home/cltbld', 07:29:52 INFO - 'LANG': 'en_US.UTF-8', 07:29:52 INFO - 'LANGUAGE': 'en_US:en', 07:29:52 INFO - 'LOGNAME': 'cltbld', 07:29:52 INFO - 'MAIL': '/var/mail/cltbld', 07:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:52 INFO - 'MOZ_NO_REMOTE': '1', 07:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:52 INFO - 'NO_EM_RESTART': '1', 07:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:52 INFO - 'PWD': '/builds/slave/test', 07:29:52 INFO - 'SHELL': '/bin/bash', 07:29:52 INFO - 'SHLVL': '1', 07:29:52 INFO - 'TERM': 'linux', 07:29:52 INFO - 'TMOUT': '86400', 07:29:52 INFO - 'USER': 'cltbld', 07:29:52 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:52 INFO - '_': '/tools/buildbot/bin/python'} 07:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:29:52 INFO - Running setup.py (path:/tmp/pip-0srhkw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:29:52 INFO - Running setup.py (path:/tmp/pip-yv6nY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:29:52 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)) 07:29:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:29:52 INFO - Running setup.py (path:/tmp/pip-CapVrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:29:53 INFO - Running setup.py (path:/tmp/pip-JySdb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:29:53 INFO - Running setup.py (path:/tmp/pip-jbv3Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:29:53 INFO - Running setup.py (path:/tmp/pip-Rz0jXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:29:53 INFO - Running setup.py (path:/tmp/pip-xZvlHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:29:53 INFO - Running setup.py (path:/tmp/pip-zAp8GW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:29:53 INFO - Running setup.py (path:/tmp/pip-Ef6Q4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:29:53 INFO - Running setup.py (path:/tmp/pip-uH8xEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:29:53 INFO - Running setup.py (path:/tmp/pip-EdjSyc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:29:53 INFO - Running setup.py (path:/tmp/pip-SgHOMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:29:53 INFO - Running setup.py (path:/tmp/pip-iYsn4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:29:53 INFO - Running setup.py (path:/tmp/pip-IAwl5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:53 INFO - Running setup.py (path:/tmp/pip-cg3Zma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:29:53 INFO - Running setup.py (path:/tmp/pip-M3zJAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:29:53 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)) 07:29:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:29:53 INFO - Running setup.py (path:/tmp/pip-eopSzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:29:54 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)) 07:29:54 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)) 07:29:54 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)) 07:29:54 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)) 07:29:54 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)) 07:29:54 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)) 07:29:54 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)) 07:29:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:29:54 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 07:29:54 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 07:29:54 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 07:29:54 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 07:29:55 INFO - Downloading blessings-1.6.tar.gz 07:29:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:29:55 INFO - Installing collected packages: blessings 07:29:55 INFO - Running setup.py install for blessings 07:29:55 INFO - Successfully installed blessings 07:29:55 INFO - Cleaning up... 07:29:55 INFO - Return code: 0 07:29:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:29:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:55 INFO - Reading from file tmpfile_stdout 07:29:55 INFO - Current package versions: 07:29:55 INFO - argparse == 1.2.1 07:29:55 INFO - blessings == 1.6 07:29:55 INFO - blobuploader == 1.2.4 07:29:55 INFO - docopt == 0.6.1 07:29:55 INFO - functools32 == 3.2.3-2 07:29:55 INFO - jsonschema == 2.5.1 07:29:55 INFO - manifestparser == 1.1 07:29:55 INFO - mozInstall == 1.13 07:29:55 INFO - mozcrash == 1.0 07:29:55 INFO - mozdebug == 0.1 07:29:55 INFO - mozdevice == 0.51 07:29:55 INFO - mozfile == 1.2 07:29:55 INFO - mozhttpd == 0.7 07:29:55 INFO - mozinfo == 0.10 07:29:55 INFO - mozleak == 0.1 07:29:55 INFO - mozlog == 3.5 07:29:55 INFO - moznetwork == 0.27 07:29:55 INFO - mozprocess == 0.25 07:29:55 INFO - mozprofile == 0.28 07:29:55 INFO - mozrunner == 6.13 07:29:55 INFO - mozscreenshot == 0.1 07:29:55 INFO - mozsystemmonitor == 0.3 07:29:55 INFO - moztest == 0.8 07:29:55 INFO - mozversion == 1.4 07:29:55 INFO - psutil == 3.1.1 07:29:55 INFO - requests == 1.2.3 07:29:55 INFO - wsgiref == 0.1.2 07:29:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:29:55 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')]} 07:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:55 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')]} 07:29:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:55 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:55 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 07:29:55 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 07:29:55 INFO - Using env: {'DISPLAY': ':0', 07:29:55 INFO - 'HOME': '/home/cltbld', 07:29:55 INFO - 'LANG': 'en_US.UTF-8', 07:29:55 INFO - 'LANGUAGE': 'en_US:en', 07:29:55 INFO - 'LOGNAME': 'cltbld', 07:29:55 INFO - 'MAIL': '/var/mail/cltbld', 07:29:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:55 INFO - 'MOZ_NO_REMOTE': '1', 07:29:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:55 INFO - 'NO_EM_RESTART': '1', 07:29:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:55 INFO - 'PWD': '/builds/slave/test', 07:29:55 INFO - 'SHELL': '/bin/bash', 07:29:55 INFO - 'SHLVL': '1', 07:29:55 INFO - 'TERM': 'linux', 07:29:55 INFO - 'TMOUT': '86400', 07:29:55 INFO - 'USER': 'cltbld', 07:29:55 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:55 INFO - '_': '/tools/buildbot/bin/python'} 07:29:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 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)) 07:29:55 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 07:29:55 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 07:29:55 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 07:29:55 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 07:29:55 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 07:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 07:29:57 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)) 07:29:57 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)) 07:29:57 INFO - Installing collected packages: simplejson 07:29:57 INFO - Running setup.py install for simplejson 07:29:57 INFO - building 'simplejson._speedups' extension 07:29:57 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 07:29:57 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 07:29:58 INFO - Successfully installed simplejson 07:29:58 INFO - Cleaning up... 07:29:58 INFO - Return code: 0 07:29:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:29:58 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')]} 07:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:29:58 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')]} 07:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:29:58 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 0xd311f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109ca60>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, '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': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', '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 07:29:58 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 07:29:58 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 07:29:58 INFO - Using env: {'DISPLAY': ':0', 07:29:58 INFO - 'HOME': '/home/cltbld', 07:29:58 INFO - 'LANG': 'en_US.UTF-8', 07:29:58 INFO - 'LANGUAGE': 'en_US:en', 07:29:58 INFO - 'LOGNAME': 'cltbld', 07:29:58 INFO - 'MAIL': '/var/mail/cltbld', 07:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:29:58 INFO - 'MOZ_NO_REMOTE': '1', 07:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:29:58 INFO - 'NO_EM_RESTART': '1', 07:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:29:58 INFO - 'PWD': '/builds/slave/test', 07:29:58 INFO - 'SHELL': '/bin/bash', 07:29:58 INFO - 'SHLVL': '1', 07:29:58 INFO - 'TERM': 'linux', 07:29:58 INFO - 'TMOUT': '86400', 07:29:58 INFO - 'USER': 'cltbld', 07:29:58 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:29:58 INFO - '_': '/tools/buildbot/bin/python'} 07:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:29:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:29:58 INFO - Cleaning up... 07:29:58 INFO - Return code: 0 07:29:58 INFO - Running post-action listener: _resource_record_post_action 07:29:58 INFO - Running post-action listener: _start_resource_monitoring 07:29:58 INFO - Starting resource monitoring. 07:29:58 INFO - [mozharness: 2017-10-10 14:29:58.332919Z] Finished create-virtualenv step (success) 07:29:58 INFO - [mozharness: 2017-10-10 14:29:58.333433Z] Running install step. 07:29:58 INFO - Running pre-action listener: _resource_record_pre_action 07:29:58 INFO - Running main action method: install 07:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:29:58 INFO - Reading from file tmpfile_stdout 07:29:58 INFO - Detecting whether we're running mozinstall >=1.0... 07:29:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:29:58 INFO - Reading from file tmpfile_stdout 07:29:58 INFO - Output received: 07:29:58 INFO - Usage: mozinstall [options] installer 07:29:58 INFO - Options: 07:29:58 INFO - -h, --help show this help message and exit 07:29:58 INFO - -d DEST, --destination=DEST 07:29:58 INFO - Directory to install application into. [default: 07:29:58 INFO - "/builds/slave/test"] 07:29:58 INFO - --app=APP Application being installed. [default: firefox] 07:29:58 INFO - mkdir: /builds/slave/test/build/application 07:29:58 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'] 07:29:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:30:13 INFO - Reading from file tmpfile_stdout 07:30:13 INFO - Output received: 07:30:13 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:13 INFO - Running post-action listener: _resource_record_post_action 07:30:13 INFO - [mozharness: 2017-10-10 14:30:13.284069Z] Finished install step (success) 07:30:13 INFO - [mozharness: 2017-10-10 14:30:13.284320Z] Running setup-mitmproxy step. 07:30:13 INFO - Running pre-action listener: _resource_record_pre_action 07:30:13 INFO - Running main action method: setup_mitmproxy 07:30:13 INFO - Skipping: mitmproxy is not required 07:30:13 INFO - Running post-action listener: _resource_record_post_action 07:30:13 INFO - [mozharness: 2017-10-10 14:30:13.285612Z] Finished setup-mitmproxy step (success) 07:30:13 INFO - [mozharness: 2017-10-10 14:30:13.285832Z] Running run-tests step. 07:30:13 INFO - Running pre-action listener: _resource_record_pre_action 07:30:13 INFO - Running pre-action listener: _set_gcov_prefix 07:30:13 INFO - Running main action method: run_tests 07:30:13 WARNING - Try message not found. 07:30:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:13 INFO - Python 2.7.3 07:30:13 INFO - Return code: 0 07:30:13 INFO - grabbing minidump binary from tooltool 07:30:13 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')]} 07:30:13 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 0x10a0090>, '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 0x10a0d80>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109af90>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:13 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 07:30:13 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 07:30:13 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 07:30:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:13 INFO - Return code: 0 07:30:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:13 INFO - ENV: RUST_BACKTRACE is now full 07:30:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:13 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/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:30:13 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/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-031 --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 07:30:13 INFO - Using env: {'DISPLAY': ':0', 07:30:13 INFO - 'HOME': '/home/cltbld', 07:30:13 INFO - 'LANG': 'en_US.UTF-8', 07:30:13 INFO - 'LANGUAGE': 'en_US:en', 07:30:13 INFO - 'LOGNAME': 'cltbld', 07:30:13 INFO - 'MAIL': '/var/mail/cltbld', 07:30:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:13 INFO - 'MOZ_NO_REMOTE': '1', 07:30:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:13 INFO - 'NO_EM_RESTART': '1', 07:30:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:13 INFO - 'PWD': '/builds/slave/test', 07:30:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:13 INFO - 'RUST_BACKTRACE': 'full', 07:30:13 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:30:13 INFO - 'SHELL': '/bin/bash', 07:30:13 INFO - 'SHLVL': '1', 07:30:13 INFO - 'TERM': 'linux', 07:30:13 INFO - 'TMOUT': '86400', 07:30:13 INFO - 'USER': 'cltbld', 07:30:13 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:30:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:13 INFO - '_': '/tools/buildbot/bin/python'} 07:30:13 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/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--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 07:30:13 INFO - mozversion application_buildid: 20171010130347 07:30:13 INFO - mozversion application_changeset: d88cd1a9f80611636ded817b3682dd04e838de6c 07:30:13 INFO - mozversion application_display_name: Firefox 07:30:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:13 INFO - mozversion application_name: Firefox 07:30:13 INFO - mozversion application_remotingname: firefox 07:30:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:30:13 INFO - mozversion application_vendor: Mozilla 07:30:13 INFO - mozversion application_version: 57.0 07:30:13 INFO - mozversion platform_buildid: 20171010130347 07:30:13 INFO - mozversion platform_changeset: d88cd1a9f80611636ded817b3682dd04e838de6c 07:30:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:30:13 INFO - mozversion platform_version: 57.0 07:30:13 INFO - using testdate: 1507645813 07:30:13 INFO - actual date: 1507645813 07:30:13 INFO - starting webserver on 'localhost:42389' 07:30:13 INFO - SUITE-START | Running 2 tests 07:30:13 INFO - TEST-START | dromaeo_css 07:30:13 INFO - Initialising browser for dromaeo_css test... 07:30:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42389/getInfo.html -profile /tmp/tmpE6nYr6/profile 07:30:13 INFO - TEST-INFO | started process 16781 (/builds/slave/test/build/application/firefox/firefox http://localhost:42389/getInfo.html) 07:30:18 INFO - TEST-INFO | 16781: exit 0 07:30:18 INFO - Browser initialized. 07:30:18 INFO - Running cycle 1/1 for dromaeo_css test... 07:30:18 INFO - Using env: {'DISPLAY': ':0', 07:30:18 INFO - 'HOME': '/home/cltbld', 07:30:18 INFO - 'JSGC_DISABLE_POISONING': '1', 07:30:18 INFO - 'LANG': 'en_US.UTF-8', 07:30:18 INFO - 'LANGUAGE': 'en_US:en', 07:30:18 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:30:18 INFO - 'LOGNAME': 'cltbld', 07:30:18 INFO - 'MAIL': '/var/mail/cltbld', 07:30:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:18 INFO - 'MOZ_CRASHREPORTER': '1', 07:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:18 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:30:18 INFO - 'MOZ_NO_REMOTE': '1', 07:30:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:18 INFO - 'NO_EM_RESTART': '1', 07:30:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:18 INFO - 'PWD': '/builds/slave/test', 07:30:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:18 INFO - 'RUST_BACKTRACE': 'full', 07:30:18 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:30:18 INFO - 'SHELL': '/bin/bash', 07:30:18 INFO - 'SHLVL': '1', 07:30:18 INFO - 'TERM': 'linux', 07:30:18 INFO - 'TMOUT': '86400', 07:30:18 INFO - 'USER': 'cltbld', 07:30:18 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:18 INFO - '_': '/tools/buildbot/bin/python'} 07:30:18 INFO - TEST-INFO | started process 17008 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE6nYr6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:30:19 INFO - PID 17008 | 07:30:19 INFO - PID 17008 | (/builds/slave/test/build/application/firefox/firefox:17056): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:30:19 INFO - PID 17008 | 07:30:29 INFO - PID 17008 | RSS: Main: 143638528 07:30:29 INFO - PID 17008 | 07:33:27 INFO - PID 17008 | Cycle 1(1): loaded http://localhost:42389/tests/dromaeo/cssquery-dojo.html (next: http://localhost:42389/tests/dromaeo/cssquery-ext.html) 07:33:28 INFO - PID 17008 | RSS: Main: 146395136 07:33:28 INFO - PID 17008 | 07:36:29 INFO - PID 17008 | Cycle 1(1): loaded http://localhost:42389/tests/dromaeo/cssquery-ext.html (next: http://localhost:42389/tests/dromaeo/cssquery-jquery.html) 07:36:30 INFO - PID 17008 | RSS: Main: 144551936 07:36:30 INFO - PID 17008 | 07:39:31 INFO - PID 17008 | Cycle 1(1): loaded http://localhost:42389/tests/dromaeo/cssquery-jquery.html (next: http://localhost:42389/tests/dromaeo/cssquery-mootools.html) 07:39:32 INFO - PID 17008 | RSS: Main: 145416192 07:39:32 INFO - PID 17008 | 07:42:33 INFO - PID 17008 | Cycle 1(1): loaded http://localhost:42389/tests/dromaeo/cssquery-mootools.html (next: http://localhost:42389/tests/dromaeo/cssquery-prototype.html) 07:42:34 INFO - PID 17008 | RSS: Main: 145530880 07:42:34 INFO - PID 17008 | 07:45:37 INFO - PID 17008 | Cycle 1(1): loaded http://localhost:42389/tests/dromaeo/cssquery-prototype.html (next: http://localhost:42389/tests/dromaeo/cssquery-yui.html) 07:45:38 INFO - PID 17008 | RSS: Main: 146497536 07:45:38 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | Cycle 1(1): loaded http://localhost:42389/tests/dromaeo/cssquery-yui.html (next: http://localhost:42389/tests/dromaeo/cssquery-dojo.html) 07:48:39 INFO - PID 17008 | RSS: Main: 149770240 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | __start_tp_report 07:48:39 INFO - PID 17008 | _x_x_mozilla_page_load 07:48:39 INFO - PID 17008 | _x_x_mozilla_page_load_details 07:48:39 INFO - PID 17008 | |i|pagename|runs| 07:48:39 INFO - PID 17008 | |0;dojo.html;3951.585083566225;4011.899702507435;4034.6772258219344;4046.736962097463;4062.126642771804;6455.257645370783;6531.771388001421;6574.276829548752;6628.4034436900665;6633.734650613969;6513.576617519858;6540.149780528536;6553.705083271252;6609;6631.270560238382;5886.88226235475;5978.312494063195;5996.910046349309;5997.640141591497;6015.248093988252;5882.088276317178;5986.8802623947495;5990.640561566298;6073.544484163684;6093.390660933894;5969.910451343233;5989.251343582052;5990.371011043843;5994.190784244115;6001.4298641628975;5981.252343457068;6004.249468816398;6013.067974463965;6016.699165041752;6046.727897244613;5866.853328666774;5913.379095195029;5979.940200597982;6060.848478788022;6084.817455476343;6413.615183088983;6492;6518.706658200393;6543;6569.57297775643;7161.89257161143;7178.748743793994;7219.819504512377;7276.054112965334;7281.672324745399;7002.579845209304;7047.43620510358;7227.421806255487;7250.093738282715;7345.669444874993;6669.76655817049;6694.062831203587;6745.123133992599;6761.087253220752;6783.660816959133;7392.186859445456;7420.072490938633;7492.7752167435065;7504.099508059068;7507.887381689279;7095.7054911365285;7106;7189.2810718927685;7195.352418282379;7200.351968322876;7041.119860017498;7102.396296314768;7219.747308844166;7259.201487836333;7316.195218525958;7170.2471240519;7191.280871912767;7245.9275407246305;7268.127824661075;7284.890726639104;7188.460865435113;7216.7834964951135;7217.458690598226;7312.670929808171;7315.487915845946;5317.920231196458;5352.116900711417;5381.515663590296;5394.78420863161;5398.973005134949;4915.680480768739;4923.606111511071;4955.0585388776735;4989.276554899519;4993.400791904995;6697.564658297195;6700.128983232246;6778.796636100925;6787.864242715217;6791.388775010273;7064.081669382947;7119.679614417364;7191.748288809867;7201.675924583406;7244.130704315516;6724.193096828314;6742;6745.898811517831;6750.054992301082;6754.223264324567;6065.696715164224;6107.022876339854;6144.477719393902;6153.692315384213;6173.197484327009;7371.557706537517;7410.184879663233;7487.101547814297;7515.21090285523;7557.4331925105835;7243.0946131733535;7253.963730181315;7279.45404094695;7303.014093097364;7332.45006624516;7491.843717673159;7499.700011999459;7506.887396689163;7509.7371591994015;7605.049368828896;7128.501004929813;7164.820879478055;7172.605506697182;7178.856422871618;7209.35115839577;7231.096112985877;7314.597697126709;7316.634168291671;7317.231690672403;7337.376323012603;6955.061066755923;6979.860402792017;6988.930110698828;7040.718371265092;7058.470614703815;6820.147481564804;6920.688569014507;6923.5499692519825;6984.4761642878;7034.261402552863;6966.233714291323;7023.648817559204;7026.227115017242;7031.1211098612675;7036.120484939383;6925.445964322943;7046.788596342118;7067.540609860343;7141.535800172972;7161.641917903979;6595.571287866273;6710.530262881747;6718.966405168138;6837.965810170917;6903.413209877016 07:48:39 INFO - PID 17008 | |1;ext.html;986.3342243985309;987.5555999800092;1015.9746006349841;1021.167748285148;1047.7328281288276;45621.31568026478;46267.53732462674;46377.304340434835;46487.30269045967;46498.535014649846;43811;43839;44189.558104418946;44254.11491770163;44324.556754432444;8149.674013039471;8240.670373185065;8247.134050924657;8262.710805121791;8268.297194738425;8082.1917808219005;8160.428769986103;8161.959190204041;8163.551004694739;8166.020077590698;8747.868781968244;8967;8971.730848074569;8975.461472311683;8979.461232326048;8880.8667869982;8901.821963560693;8912.153345432174;8937.061608531141;8950.507722075283;8736.8689469658;8778.956105219497;8784.736457906272;8811.735647930573;8842.20420162182;41730.582694172976;41799;41882.581174188475;42131.36802947928;42147.578524214674;3864.111254411473;3898.766074035567;3900.1614652849776;3902.180542086165;3903.1217975955183;34379.82810085959;34585.65414345875;34597;34634.48048279278;34701.826490867636;5653.802116925929;5659.943400565983;5665.065264231397;5675.290588676416;5680.31836179657;240284;242356;242453;242876;243285;56062;56114.158287625716;56192.719036405375;56211.43788562144;56396.43603563912;58849.41150588525;58858;59143;59370.703146484855;59383.70308148432;18786.154623041995;18794.43616691474;18932.337368192322;18951.241950321833;19022.23911043543;15656.686866262839;15677.451289204822;15685.607859803597;15724.05655660641;15739.44911928077;15896.920515397349;16459.506214813573;16563.83436165647;16586.419475318307;16589.66820663604;6193.411625895533;6242.843928901813;6263.71813268404;6379.138816259839;6466.191726034246;1107.6566264458045;1109.7336639206533;1115.3475216998147;1125.4035361258545;1149.0577726264382;26281.605775913376;26385.73614263871;26512.072077477194;26561;26574.6013809793;1232.679503329123;1239.0087929656238;1240.3116270469975;1248.850137983448;1255.0775180242515;13582.456701732017;13741.312934353242;13811.378487968066;13840.515581954583;14082.71834563303;282214;319994;322431;326436;327494;66164.33835661678;66257;66449.33550664432;66458;66552;1538.7076455473425;1582.082392212514;1589.1021572811323;1589.9841001589837;1591.228254296642;30804.53793193149;31023.844880776356;31126.68873311238;31307.84346078255;31326.686733132377;43287.783561082;43475.130497390506;43517.56482435135;43548.56451435572;43598.34602480902;250152;254742;255622;256621;256992;37523.43714844225;37942.8102859495;38282.27729752112;38464.6153538461;38472;49121.01757964892;49731.502684972686;49761.75119124381;50165.49834501608;50207.24689129593;35280;35458.29083418369;35640.108997275274;35968.8201559001;36321.81839090788;35391;35743.821280893426;35865.28269434544;36007.81996090003;36346.63653363432;42294.78852605717;42295.7885210572;42468.78765606152;42544.361834571886;42923.57076429196;33918.982430527125;34416;34628.30743385169;34975.65024349724;35215.82392088023;25431.10991115302;25479.87260063762;26009;26037.73962260353;26369.20892373232 07:48:39 INFO - PID 17008 | |2;jquery.html;637.6073996769076;643.8430669273396;649.4980702602929;655.5283388792162;656.2510908429036;24423.511529769417;25273;25280.87359563204;25294.873525632345;25306;26428.603570946452;26938.595921061198;27002.864985675045;27033.18900432985;27092.051778187768;6453.161089058416;6582.769603063905;6697.095892054584;6726.293739157367;6729.1924969003785;6658.334166583351;6748.561343512681;6748.6288254146;6748.696308666097;6752.223494298145;6655.201375834882;6708.127943367355;6719.731210751588;6721.529492935497;6881;6853.485988550854;6878.243393226716;6879.2432832388395;6886.965565172142;6891.552049116792;6423.421892029693;6446.452051575622;6481.48148148147;6484.157059582271;6491.805245842632;30522.84738576315;31393.215169620715;31820.681793182004;31879.203019924455;31933.680663193536;2360.7403185649564;2407.4703565215623;2409.6867407236946;2411.03558576569;2419.479811840445;20898.26856060046;21394.786052139436;21440;21450.46373840651;21467.03398347078;2587.2238328501376;2659.6409484719507;2687.046098634976;2711.52548304046;2712.8779204935827;157132;160574;168541;173647;173896;17377.47867563975;17382.826171738372;17491;17517.7372339415;17988.2804687811;27819.721802781714;27888.86055569709;27913.44173116526;27941.580876286873;28093.859530702215;11649.242799218024;11814.586489472827;11893.88106118945;11923.76152476963;11990.520379184734;10854.837177442345;10862.511186996604;10893.074088702391;10943.671689849318;10953.945230273797;10003.499825008867;10338.12125969301;10493;10571.894281057092;10581.682549523373;2893.7540309073543;3010.3377257003426;3045.4365942300747;3072.6773688762805;3163.731082857983;1049.3861091261697;1080.475969154959;1081.588996181446;1086.0876863434594;1086.2884810449168;21058.262960796605;21521.923903804745;21643.13427462884;21674.241401551186;21974.780252197274;1130.1467392118898;1144.6108323170163;1157.6121999130385;1166.1953252255917;1169.5789515774316;11630.70923226926;11877.168598198215;11903.404829758478;12066.155369124077;12268.631941041784;567986;611764;614752;626144;632326;129553.35223324012;130538.34730826285;131457.34567561978;132782.33608831893;132903;1142.965711028654;1202.5009621007184;1248.525560287085;1272.6118533847266;1287.8068289756611;22396.888015559816;22660.320190394315;22882.199123030616;22990.42523936915;23164.536709265383;64921;65090;65712.34287657062;66065.33934660592;66630.66684666545;79713;79873.6006319988;80163;81250;82255.58872205601;15574;16142.515724528283;16476;16517.917410412872;16572.337106516086;23819.880900595384;23999;24141.879290603436;24369;24580.385490362885;20103.798962010194;20352.491187719832;20499;20506.58986820285;20517.281895133598;17809.73285400694;17864.642707145525;17936.19287132056;18204.635907281514;18504.81495185031;20356;20628.690569641767;20750;20790.376288711363;20984.160633574487;16088.195590220676;16231.756523651919;16293.429729959395;16302.59243518874;16326.918365408097;19540.90229548843;19862.801371986094;19863.304784333057;20186.293479728138;20240.291589794288 07:48:39 INFO - PID 17008 | |3;mootools.html;1464.597235760166;1486.695227478367;1491;1523.6343277613369;1525.786389905413;17510;18347.81652183478;18352;18353.44939651809;18361.173747181376;17743.201555929983;17763.55591110223;17846.10769461525;17853.19660615272;17921.103944802773;2959.4525012872687;3010.8042977206464;3024.6370435547765;3040.8783648654025;3051.389722055587;3035.150157955765;3035.8482075896227;3054.618172728409;3056.205386599489;3060.739837113848;2981.0907673159677;3023.9848800755967;3036.6356037275445;3045.6649768525554;3054.816710997336;2821.901233456819;2876.381577960738;2882.3658795065053;2885.6970018148004;2889.8410587417684;2789.609454676347;2812.2125804774696;2816.2536927714173;2818.8590570471392;2826.7597254233415;17059.232334544977;17127.571810704707;17188.65622687552;17254.56863578408;17306;8535.914640853636;8847.336449766293;8857.689980850639;8860.06969268224;8864.157904999014;5764.711764411804;5829.5919285650025;5954.374790647006;6072.149899014142;6100.298465676459;2157.7410710714817;2161.200355868323;2187.704659870913;2229.2277639276813;2259.4690247791755;28857.278568035756;29942.85028574865;31365.686343136505;32294.192645183823;32675.67324326726;7881.566513841679;7926.841463170705;8131.390145739093;8193.918060819435;8524.14758524155;24142;24224;24262.393440164138;24269.393265168514;24279.514409711708;8997.190252877272;9172.633094676139;9202.217811485965;9270.351075424656;9330.066993300616;7974.5215287082965;7983.84032319362;8251.546164960864;8317.500949943023;8322.042965058974;6589.472842172615;6590.406863382223;6628.171478565179;6642.269350371455;6702.832429189211;1845.953851153705;1849.5653521422455;1868.7757469103794;1874.6906760384657;1884.689026310671;1017.2421545948316;1030.1861529391847;1035.699647102347;1040.6097713357492;1057.2652006855162;9279.443233406017;9350.90649093514;9367;9415.435073895589;9415.811683766286;828.6561077153035;830.4892491117919;832.6919039955255;837.4975014991079;840.4243093480985;5474.370447398521;5572.832815015556;5620.213170156181;5661.433856614306;5688.658680479184;24729.87635061813;26413.73586264151;26454.47091058168;26465.735342646713;26489.602655960178;24201.63697544538;25488.235352939442;25720.742792572208;25763.22710318656;25834.224973250457;11213.719657008476;12833.807492887614;12994.48022079125;13362.732745345233;13398.732025359439;10905.672829815117;10918.344899306067;11002.449877505933;11021.393823339793;11030.172737044593;21920.561588767818;22757.203497878156;22998.885005575536;23132.537349252583;23545.175918842757;22706.772932270465;22943.88528057349;23694;24208.51582968366;24384;12834.935825321187;13242.933785331012;13244.271565064015;13265;13267.203967761965;16195.514134575982;16264.837351626333;16280.592985175464;16380.918095409446;16416.09711465881;13088.80366794518;13175.341232938506;13326.466941322238;13498.93250533741;13742.587722368346;12747.171433856769;12851;12865.906397956278;12912.289824059766;13081.149725268207;10416.427096509462;10562.155027597928;10565.524551395052;10572.36565806054;10591.841122383325;8861.60122794463;8951.283897288331;8983.281337492854;9101.180893719596;9205.815883682422;8683.913160868564;8792.692255771017;8818.162274583905;8862.468251904906;8931.821363572562 07:48:39 INFO - PID 17008 | |4;prototype.html;571.077709499159;579.3135134865182;595.1697382151898;620.7020630097553;629.9748010079597;6399.488040956724;6515.599146183569;6528.543001989862;6597.736090556384;6602.1747281589805;6453.774117905874;6469.805905822833;6481.319461456538;6501.317361677026;6503.90244146337;5367.838964831061;5400.621956463049;5409.134538473845;5412.188171774226;5451.863703407407;5163.664361816489;5259.447757985414;5259.500347466985;5307.1243244864745;5375.919361209565;5134.589232861381;5207.557357624606;5226.216067589873;5267.183586544092;5281.498257665516;5207.583393328525;5210.791568337262;5214.296070030536;5223.503767142115;5226.895462090756;4692.741899195543;4748.596369308613;4790.8323208687525;4796.304535842283;4829.420469543677;6470.158879345655;6476.319986401454;6480;6518.315576864408;6522.771702990372;6064.484518815906;6129.085432557603;6204.627722336674;6222.937770622327;6240.344763799826;6974.476914231453;7077.3984211341585;7077.71689132434;7094.290570942916;7111.4666400020205;5128.1282182029145;5333.8265581571995;5364.678119312854;5383.327084114486;5391.649542779707;7102.786916392516;7177.461690373243;7217.711291548384;7252.166000909858;7343.77968660941;5490.3411590609385;5508.724563771795;5522.392536820947;5541.639793413416;5566.777328906879;5555.833325000256;5596.860078497989;5603.243562119062;5610.831675049755;5661.405552417019;6188.752449902044;6191.071339299141;6218.507558186003;6222.160008398899;6252.812415627538;7057.470689698293;7104.467164962545;7121.89317160243;7125.287471252833;7130.964345178241;1917.8465722742146;1920.9807901920801;1932.8936908470168;1941.9708704369446;1946.2701486942397;1328.0836223006095;1369.3564024908278;1377.2493990775051;1385.840628327735;1395.4976208564908;6572.11276477679;6576.1122248496795;6586.901196482057;6608.471322294205;6623.933760662428;6991.475639326969;7067.363937245673;7068.151821781419;7170.820729481805;7172.6055066970775;6535.934640653532;6552.737890484327;6578.144841170617;6612.173478315211;6629.204495460575;3752.724073814916;3786.6402691744242;3815.2369526094335;3822.2546603412625;3830.4062870255157;7293.9635301823155;7381.88927166093;7395.852082958419;7410.851782964311;7482.214367491444;7318.34134927859;7349.044624198927;7361.926380736231;7368.636802191611;7440.330370266702;7061.399781018671;7167.175774785862;7208.135023797073;7238.746643867545;7342.449316301192;7042.908349205882;7058.082449281561;7060.364567188978;7065.788026359218;7077.150741911004;6977.895331569929;7067.752628657972;7075.858482830417;7087.22040575526;7110.182329032227;7370.705171793283;7382.778516644509;7415.703371865065;7428.665710043169;7461.328480436787;5496.725163741877;5499.597602611469;5517.117261238182;5518.33779946409;5545.585875601696;6805.795826125224;6958.520739630185;6971.65141742921;7060.505764596429;7074.540154889915;6524.282328943717;6790.25307216196;6801.775680377579;6824.215215250111;6980.267071957372;6734.158230221223;6745.291744366967;6815.568730566637;6860.3139686031;6860.348266914635;6786.760369078093;6800.863982720219;6811.318868113149;6811.4550835934;6821.522493425413;6777.322267773183;6859.108315918898;6937.236903940461;6941.015363393789;6951.756688515878;6616.933830661632;6632.436242919213;6641.203055633355;6719.4624430044505;6758.357955994173 07:48:39 INFO - PID 17008 | |5;yui.html;977.8044391121778;1024.3700124423478;1027.964021259256;1040.115901483739;1051.6476980211628;21480;21729.23947661832;21798.89100554499;21813.345599631997;21821.563568728616;19868.205271789113;20060.297889573867;20866.582668346626;21010.474738131554;21022.894885525588;1068.7969285835686;1074.5379486820664;1080.060347497678;1080.1412876762993;1080.4057768227483;1076.9730756731067;1087.9564817407295;1110.4836251143217;1110.8555887734583;1113.4822307626953;1188.4295538141698;1190.3512585640847;1192.648168790209;1192.9343886086263;1194.3192380343207;1173.8591369035728;1174.477357575879;1177.7703347847173;1178.8113901775719;1184.9289042657467;864.7016779211162;866.0733015673233;866.5104216117936;867.9783005424852;868.2663149638545;21869.67195492069;22404.88797556018;22573.661395079085;22574.548509029726;22613.321600352017;23929;24067.638985415233;24328.756712432827;24387.634185487233;24479.26562203137;18597.25610975559;19049.238030478766;19054.42836714901;19110.71333929992;19124.617507649768;4053.7770422626745;4130.690198235115;4131.50421949368;4132.070284186064;4142.647874930634;163184.18407908003;166972;169111.15444422944;169888;170598;15513;15556.766648500281;15718.21408929549;15750.291236894367;15753.842461575467;27163.185104446897;27940;28003.43993120167;28047.158585242476;28188.71811281902;9490.525473726424;9558.091981261769;9593.616255349707;9644.18024467914;9786.657466988621;4802.8799280018275;4860.17377045896;4867.440244371872;4869.074875773592;4873.00103478786;6471.514636402195;6513.12072870166;6570.868582628416;6580.341965803477;6643.169603799525;1166.259425264946;1190.2620375367328;1204.3195594489262;1207.486818102303;1208.7884620191608;770.9884351734728;781.6013832945239;782.5891407011364;792.9127795942557;793.547677823635;12433.316167610687;13282.601521954357;13408.932955335162;14803.259837008107;14824.3329050193;776.6621519638975;780.1730166024033;781.0783275734688;783.4241832253289;793.746001279585;6176.104464852571;6208.782692605737;6361.427471527492;6402.263739669905;6506.056621789814;157508;159450;160311.19844400938;160984;161721.19139404464;132499;133384;134844.60621575222;135260;139782;113662;116417.41791290989;119256;119738;121655;13961.930190348983;14513.201773902536;14517.78223326672;14538.418463261774;14654.853451465775;54228.18657720216;55014.724926375115;55322;55401.7229913864;56308.15537766855;96540.51729741307;96965.5151724237;97119;97819.51090244504;103600;20918.581628367043;20962.895185523976;21328.78671213268;21435.67846482273;21536.353909382742;23964.760352396253;24612.50774984526;24772.876135619208;25082.372940675898;25176.37059073538;20611;20658;22023.22918697838;22154.003069861574;22654.546909061395;20706.275280365116;20816;21276.468088297297;21812.56374872462;21998.89000554987;21624.783752162908;21813.23653672177;21877;22002.559948801256;22020.559588808454;14146.929265353607;14156.292185390483;14289.996702539194;16655.50033498997;16707.16464176762;15954.521364359089;16056.598585035468;16285.511434656979;16656.250468728693;16675.49973500797 07:48:39 INFO - PID 17008 | __end_tp_report 07:48:39 INFO - PID 17008 | __start_cc_report 07:48:39 INFO - PID 17008 | _x_x_mozilla_cycle_collect,250 07:48:39 INFO - PID 17008 | __end_cc_report 07:48:39 INFO - PID 17008 | __startTimestamp1507646919765__endTimestamp 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | ------- Summary: start ------- 07:48:39 INFO - PID 17008 | Number of tests: 6 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | [#0] dojo.html Cycles:165 Average:6657.12 Median:6923.55 stddev:778.09 (11.2%) stddev-sans-first:750.97 07:48:39 INFO - PID 17008 | Values: 3951.6 4011.9 4034.7 4046.7 4062.1 6455.3 6531.8 6574.3 6628.4 6633.7 6513.6 6540.1 6553.7 6609.0 6631.3 5886.9 5978.3 5996.9 5997.6 6015.2 5882.1 5986.9 5990.6 6073.5 6093.4 5969.9 5989.3 5990.4 5994.2 6001.4 5981.3 6004.2 6013.1 6016.7 6046.7 5866.9 5913.4 5979.9 6060.8 6084.8 6413.6 6492.0 6518.7 6543.0 6569.6 7161.9 7178.7 7219.8 7276.1 7281.7 7002.6 7047.4 7227.4 7250.1 7345.7 6669.8 6694.1 6745.1 6761.1 6783.7 7392.2 7420.1 7492.8 7504.1 7507.9 7095.7 7106.0 7189.3 7195.4 7200.4 7041.1 7102.4 7219.7 7259.2 7316.2 7170.2 7191.3 7245.9 7268.1 7284.9 7188.5 7216.8 7217.5 7312.7 7315.5 5317.9 5352.1 5381.5 5394.8 5399.0 4915.7 4923.6 4955.1 4989.3 4993.4 6697.6 6700.1 6778.8 6787.9 6791.4 7064.1 7119.7 7191.7 7201.7 7244.1 6724.2 6742.0 6745.9 6750.1 6754.2 6065.7 6107.0 6144.5 6153.7 6173.2 7371.6 7410.2 7487.1 7515.2 7557.4 7243.1 7254.0 7279.5 7303.0 7332.5 7491.8 7499.7 7506.9 7509.7 7605.0 7128.5 7164.8 7172.6 7178.9 7209.4 7231.1 7314.6 7316.6 7317.2 7337.4 6955.1 6979.9 6988.9 7040.7 7058.5 6820.1 6920.7 6923.5 6984.5 7034.3 6966.2 7023.6 7026.2 7031.1 7036.1 6925.4 7046.8 7067.5 7141.5 7161.6 6595.6 6710.5 6719.0 6838.0 6903.4 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | [#1] ext.html Cycles:180 Average:45933.54 Median:38373.45 stddev:71103.36 (185.3%) stddev-sans-first:71222.73 07:48:39 INFO - PID 17008 | Values: 986.3 987.6 1016.0 1021.2 1047.7 45621.3 46267.5 46377.3 46487.3 46498.5 43811.0 43839.0 44189.6 44254.1 44324.6 8149.7 8240.7 8247.1 8262.7 8268.3 8082.2 8160.4 8162.0 8163.6 8166.0 8747.9 8967.0 8971.7 8975.5 8979.5 8880.9 8901.8 8912.2 8937.1 8950.5 8736.9 8779.0 8784.7 8811.7 8842.2 41730.6 41799.0 41882.6 42131.4 42147.6 3864.1 3898.8 3900.2 3902.2 3903.1 34379.8 34585.7 34597.0 34634.5 34701.8 5653.8 5659.9 5665.1 5675.3 5680.3 240284.0 242356.0 242453.0 242876.0 243285.0 56062.0 56114.2 56192.7 56211.4 56396.4 58849.4 58858.0 59143.0 59370.7 59383.7 18786.2 18794.4 18932.3 18951.2 19022.2 15656.7 15677.5 15685.6 15724.1 15739.4 15896.9 16459.5 16563.8 16586.4 16589.7 6193.4 6242.8 6263.7 6379.1 6466.2 1107.7 1109.7 1115.3 1125.4 1149.1 26281.6 26385.7 26512.1 26561.0 26574.6 1232.7 1239.0 1240.3 1248.9 1255.1 13582.5 13741.3 13811.4 13840.5 14082.7 282214.0 319994.0 322431.0 326436.0 327494.0 66164.3 66257.0 66449.3 66458.0 66552.0 1538.7 1582.1 1589.1 1590.0 1591.2 30804.5 31023.8 31126.7 31307.8 31326.7 43287.8 43475.1 43517.6 43548.6 43598.3 250152.0 254742.0 255622.0 256621.0 256992.0 37523.4 37942.8 38282.3 38464.6 38472.0 49121.0 49731.5 49761.8 50165.5 50207.2 35280.0 35458.3 35640.1 35968.8 36321.8 35391.0 35743.8 35865.3 36007.8 36346.6 42294.8 42295.8 42468.8 42544.4 42923.6 33919.0 34416.0 34628.3 34975.7 35215.8 25431.1 25479.9 26009.0 26037.7 26369.2 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | [#2] jquery.html Cycles:180 Average:41011.82 Median:22528.60 stddev:102627.39 (455.5%) stddev-sans-first:102870.52 07:48:39 INFO - PID 17008 | Values: 637.6 643.8 649.5 655.5 656.3 24423.5 25273.0 25280.9 25294.9 25306.0 26428.6 26938.6 27002.9 27033.2 27092.1 6453.2 6582.8 6697.1 6726.3 6729.2 6658.3 6748.6 6748.6 6748.7 6752.2 6655.2 6708.1 6719.7 6721.5 6881.0 6853.5 6878.2 6879.2 6887.0 6891.6 6423.4 6446.5 6481.5 6484.2 6491.8 30522.8 31393.2 31820.7 31879.2 31933.7 2360.7 2407.5 2409.7 2411.0 2419.5 20898.3 21394.8 21440.0 21450.5 21467.0 2587.2 2659.6 2687.0 2711.5 2712.9 157132.0 160574.0 168541.0 173647.0 173896.0 17377.5 17382.8 17491.0 17517.7 17988.3 27819.7 27888.9 27913.4 27941.6 28093.9 11649.2 11814.6 11893.9 11923.8 11990.5 10854.8 10862.5 10893.1 10943.7 10953.9 10003.5 10338.1 10493.0 10571.9 10581.7 2893.8 3010.3 3045.4 3072.7 3163.7 1049.4 1080.5 1081.6 1086.1 1086.3 21058.3 21521.9 21643.1 21674.2 21974.8 1130.1 1144.6 1157.6 1166.2 1169.6 11630.7 11877.2 11903.4 12066.2 12268.6 567986.0 611764.0 614752.0 626144.0 632326.0 129553.4 130538.3 131457.3 132782.3 132903.0 1143.0 1202.5 1248.5 1272.6 1287.8 22396.9 22660.3 22882.2 22990.4 23164.5 64921.0 65090.0 65712.3 66065.3 66630.7 79713.0 79873.6 80163.0 81250.0 82255.6 15574.0 16142.5 16476.0 16517.9 16572.3 23819.9 23999.0 24141.9 24369.0 24580.4 20103.8 20352.5 20499.0 20506.6 20517.3 17809.7 17864.6 17936.2 18204.6 18504.8 20356.0 20628.7 20750.0 20790.4 20984.2 16088.2 16231.8 16293.4 16302.6 16326.9 19540.9 19862.8 19863.3 20186.3 20240.3 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | [#3] mootools.html Cycles:180 Average:11064.65 Median:26123.98 stddev:8161.56 (31.2%) stddev-sans-first:8152.59 07:48:39 INFO - PID 17008 | Values: 1464.6 1486.7 1491.0 1523.6 1525.8 17510.0 18347.8 18352.0 18353.4 18361.2 17743.2 17763.6 17846.1 17853.2 17921.1 2959.5 3010.8 3024.6 3040.9 3051.4 3035.2 3035.8 3054.6 3056.2 3060.7 2981.1 3024.0 3036.6 3045.7 3054.8 2821.9 2876.4 2882.4 2885.7 2889.8 2789.6 2812.2 2816.3 2818.9 2826.8 17059.2 17127.6 17188.7 17254.6 17306.0 8535.9 8847.3 8857.7 8860.1 8864.2 5764.7 5829.6 5954.4 6072.1 6100.3 2157.7 2161.2 2187.7 2229.2 2259.5 28857.3 29942.9 31365.7 32294.2 32675.7 7881.6 7926.8 8131.4 8193.9 8524.1 24142.0 24224.0 24262.4 24269.4 24279.5 8997.2 9172.6 9202.2 9270.4 9330.1 7974.5 7983.8 8251.5 8317.5 8322.0 6589.5 6590.4 6628.2 6642.3 6702.8 1846.0 1849.6 1868.8 1874.7 1884.7 1017.2 1030.2 1035.7 1040.6 1057.3 9279.4 9350.9 9367.0 9415.4 9415.8 828.7 830.5 832.7 837.5 840.4 5474.4 5572.8 5620.2 5661.4 5688.7 24729.9 26413.7 26454.5 26465.7 26489.6 24201.6 25488.2 25720.7 25763.2 25834.2 11213.7 12833.8 12994.5 13362.7 13398.7 10905.7 10918.3 11002.4 11021.4 11030.2 21920.6 22757.2 22998.9 23132.5 23545.2 22706.8 22943.9 23694.0 24208.5 24384.0 12834.9 13242.9 13244.3 13265.0 13267.2 16195.5 16264.8 16280.6 16380.9 16416.1 13088.8 13175.3 13326.5 13498.9 13742.6 12747.2 12851.0 12865.9 12912.3 13081.1 10416.4 10562.2 10565.5 10572.4 10591.8 8861.6 8951.3 8983.3 9101.2 9205.8 8683.9 8792.7 8818.2 8862.5 8931.8 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | [#4] prototype.html Cycles:180 Average:5932.06 Median:6562.43 stddev:1644.29 (25.1%) stddev-sans-first:1598.91 07:48:39 INFO - PID 17008 | Values: 571.1 579.3 595.2 620.7 630.0 6399.5 6515.6 6528.5 6597.7 6602.2 6453.8 6469.8 6481.3 6501.3 6503.9 5367.8 5400.6 5409.1 5412.2 5451.9 5163.7 5259.4 5259.5 5307.1 5375.9 5134.6 5207.6 5226.2 5267.2 5281.5 5207.6 5210.8 5214.3 5223.5 5226.9 4692.7 4748.6 4790.8 4796.3 4829.4 6470.2 6476.3 6480.0 6518.3 6522.8 6064.5 6129.1 6204.6 6222.9 6240.3 6974.5 7077.4 7077.7 7094.3 7111.5 5128.1 5333.8 5364.7 5383.3 5391.6 7102.8 7177.5 7217.7 7252.2 7343.8 5490.3 5508.7 5522.4 5541.6 5566.8 5555.8 5596.9 5603.2 5610.8 5661.4 6188.8 6191.1 6218.5 6222.2 6252.8 7057.5 7104.5 7121.9 7125.3 7131.0 1917.8 1921.0 1932.9 1942.0 1946.3 1328.1 1369.4 1377.2 1385.8 1395.5 6572.1 6576.1 6586.9 6608.5 6623.9 6991.5 7067.4 7068.2 7170.8 7172.6 6535.9 6552.7 6578.1 6612.2 6629.2 3752.7 3786.6 3815.2 3822.3 3830.4 7294.0 7381.9 7395.9 7410.9 7482.2 7318.3 7349.0 7361.9 7368.6 7440.3 7061.4 7167.2 7208.1 7238.7 7342.4 7042.9 7058.1 7060.4 7065.8 7077.2 6977.9 7067.8 7075.9 7087.2 7110.2 7370.7 7382.8 7415.7 7428.7 7461.3 5496.7 5499.6 5517.1 5518.3 5545.6 6805.8 6958.5 6971.7 7060.5 7074.5 6524.3 6790.3 6801.8 6824.2 6980.3 6734.2 6745.3 6815.6 6860.3 6860.3 6786.8 6800.9 6811.3 6811.5 6821.5 6777.3 6859.1 6937.2 6941.0 6951.8 6616.9 6632.4 6641.2 6719.5 6758.4 07:48:39 INFO - PID 17008 | 07:48:39 INFO - PID 17008 | [#5] yui.html Cycles:180 Average:30486.39 Median:21149.68 stddev:44937.60 (212.5%) stddev-sans-first:45009.04 07:48:39 INFO - PID 17008 | Values: 977.8 1024.4 1028.0 1040.1 1051.6 21480.0 21729.2 21798.9 21813.3 21821.6 19868.2 20060.3 20866.6 21010.5 21022.9 1068.8 1074.5 1080.1 1080.1 1080.4 1077.0 1088.0 1110.5 1110.9 1113.5 1188.4 1190.4 1192.6 1192.9 1194.3 1173.9 1174.5 1177.8 1178.8 1184.9 864.7 866.1 866.5 868.0 868.3 21869.7 22404.9 22573.7 22574.5 22613.3 23929.0 24067.6 24328.8 24387.6 24479.3 18597.3 19049.2 19054.4 19110.7 19124.6 4053.8 4130.7 4131.5 4132.1 4142.6 163184.2 166972.0 169111.2 169888.0 170598.0 15513.0 15556.8 15718.2 15750.3 15753.8 27163.2 27940.0 28003.4 28047.2 28188.7 9490.5 9558.1 9593.6 9644.2 9786.7 4802.9 4860.2 4867.4 4869.1 4873.0 6471.5 6513.1 6570.9 6580.3 6643.2 1166.3 1190.3 1204.3 1207.5 1208.8 771.0 781.6 782.6 792.9 793.5 12433.3 13282.6 13408.9 14803.3 14824.3 776.7 780.2 781.1 783.4 793.7 6176.1 6208.8 6361.4 6402.3 6506.1 157508.0 159450.0 160311.2 160984.0 161721.2 132499.0 133384.0 134844.6 135260.0 139782.0 113662.0 116417.4 119256.0 119738.0 121655.0 13961.9 14513.2 14517.8 14538.4 14654.9 54228.2 55014.7 55322.0 55401.7 56308.2 96540.5 96965.5 97119.0 97819.5 103600.0 20918.6 20962.9 21328.8 21435.7 21536.4 23964.8 24612.5 24772.9 25082.4 25176.4 20611.0 20658.0 22023.2 22154.0 22654.5 20706.3 20816.0 21276.5 21812.6 21998.9 21624.8 21813.2 21877.0 22002.6 22020.6 14146.9 14156.3 14290.0 16655.5 16707.2 15954.5 16056.6 16285.5 16656.3 16675.5 07:48:39 INFO - PID 17008 | -------- Summary: end -------- 07:48:39 INFO - PID 17008 | 07:48:40 INFO - TEST-INFO | 17008: exit 0 07:48:40 INFO - TEST-OK | dromaeo_css | took 1106755ms 07:48:40 INFO - TEST-START | kraken 07:48:40 INFO - Initialising browser for kraken test... 07:48:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:42389/getInfo.html -profile /tmp/tmpgY3VfE/profile 07:48:40 INFO - TEST-INFO | started process 17372 (/builds/slave/test/build/application/firefox/firefox http://localhost:42389/getInfo.html) 07:48:45 INFO - TEST-INFO | 17372: exit 0 07:48:45 INFO - Browser initialized. 07:48:45 INFO - Running cycle 1/1 for kraken test... 07:48:45 INFO - Using env: {'DISPLAY': ':0', 07:48:45 INFO - 'HOME': '/home/cltbld', 07:48:45 INFO - 'JSGC_DISABLE_POISONING': '1', 07:48:45 INFO - 'LANG': 'en_US.UTF-8', 07:48:45 INFO - 'LANGUAGE': 'en_US:en', 07:48:45 INFO - 'LD_LIBRARY_PATH': '/builds/slave/test/build/application/firefox', 07:48:45 INFO - 'LOGNAME': 'cltbld', 07:48:45 INFO - 'MAIL': '/var/mail/cltbld', 07:48:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:48:45 INFO - 'MOZ_CRASHREPORTER': '1', 07:48:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:45 INFO - 'MOZ_DISABLE_NONLOCAL_CONNECTIONS': '1', 07:48:45 INFO - 'MOZ_NO_REMOTE': '1', 07:48:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:45 INFO - 'NO_EM_RESTART': '1', 07:48:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:45 INFO - 'PWD': '/builds/slave/test', 07:48:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:45 INFO - 'RUST_BACKTRACE': 'full', 07:48:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 07:48:45 INFO - 'SHELL': '/bin/bash', 07:48:45 INFO - 'SHLVL': '1', 07:48:45 INFO - 'TERM': 'linux', 07:48:45 INFO - 'TMOUT': '86400', 07:48:45 INFO - 'USER': 'cltbld', 07:48:45 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691', 07:48:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:45 INFO - '_': '/tools/buildbot/bin/python'} 07:48:45 INFO - TEST-INFO | started process 17611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgY3VfE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:46 INFO - PID 17611 | 07:48:46 INFO - PID 17611 | (/builds/slave/test/build/application/firefox/firefox:17660): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 07:48:46 INFO - PID 17611 | 07:48:56 INFO - PID 17611 | RSS: Main: 141918208 07:48:56 INFO - PID 17611 | 07:48:59 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:42389/tests/kraken/driver.html?testName=audio-beat-detection) 07:48:59 INFO - PID 17611 | RSS: Main: 147677184 07:48:59 INFO - PID 17611 | 07:49:02 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:42389/tests/kraken/driver.html?testName=audio-dft) 07:49:03 INFO - PID 17611 | RSS: Main: 148279296 07:49:03 INFO - PID 17611 | 07:49:05 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:42389/tests/kraken/driver.html?testName=audio-fft) 07:49:06 INFO - PID 17611 | RSS: Main: 149852160 07:49:06 INFO - PID 17611 | 07:49:08 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:42389/tests/kraken/driver.html?testName=audio-oscillator) 07:49:09 INFO - PID 17611 | RSS: Main: 149725184 07:49:09 INFO - PID 17611 | 07:49:11 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:42389/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:49:11 INFO - PID 17611 | RSS: Main: 149270528 07:49:11 INFO - PID 17611 | 07:49:14 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:42389/tests/kraken/driver.html?testName=imaging-darkroom) 07:49:15 INFO - PID 17611 | RSS: Main: 149221376 07:49:15 INFO - PID 17611 | 07:49:18 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:42389/tests/kraken/driver.html?testName=imaging-desaturate) 07:49:19 INFO - PID 17611 | RSS: Main: 150827008 07:49:19 INFO - PID 17611 | 07:49:22 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:42389/tests/kraken/driver.html?testName=json-parse-financial) 07:49:22 INFO - PID 17611 | RSS: Main: 152268800 07:49:22 INFO - PID 17611 | 07:49:24 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:42389/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:49:25 INFO - PID 17611 | RSS: Main: 152760320 07:49:25 INFO - PID 17611 | 07:49:26 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:49:27 INFO - PID 17611 | RSS: Main: 152604672 07:49:27 INFO - PID 17611 | 07:49:29 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:49:29 INFO - PID 17611 | RSS: Main: 149282816 07:49:29 INFO - PID 17611 | 07:49:32 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:49:32 INFO - PID 17611 | RSS: Main: 150081536 07:49:32 INFO - PID 17611 | 07:49:35 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:49:36 INFO - PID 17611 | RSS: Main: 149704704 07:49:36 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | Cycle 1(1): loaded http://localhost:42389/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:42389/tests/kraken/driver.html?testName=ai-astar) 07:49:37 INFO - PID 17611 | RSS: Main: 151187456 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | __start_tp_report 07:49:37 INFO - PID 17611 | _x_x_mozilla_page_load 07:49:37 INFO - PID 17611 | _x_x_mozilla_page_load_details 07:49:37 INFO - PID 17611 | |i|pagename|runs| 07:49:37 INFO - PID 17611 | |0;ai-astar;106;104;105;105;105;112;108;104;105;105 07:49:37 INFO - PID 17611 | |1;audio-beat-detection;110;111;117;111;110;112;111;115;139;115 07:49:37 INFO - PID 17611 | |2;audio-dft;162;161;162;161;163;161;161;162;162;172 07:49:37 INFO - PID 17611 | |3;audio-fft;80;73;73;72;71;74;72;73;75;76 07:49:37 INFO - PID 17611 | |4;audio-oscillator;77;77;77;77;77;77;78;77;78;77 07:49:37 INFO - PID 17611 | |5;imaging-gaussian-blur;113;113;114;113;113;113;113;114;113;115 07:49:37 INFO - PID 17611 | |6;imaging-darkroom;147;148;147;149;148;148;150;149;148;147 07:49:37 INFO - PID 17611 | |7;imaging-desaturate;93;94;94;93;94;94;94;94;95;95 07:49:37 INFO - PID 17611 | |8;json-parse-financial;42;42;42;44;44;44;41;43;42;43 07:49:37 INFO - PID 17611 | |9;json-stringify-tinderbox;38;39;38;38;39;38;38;38;38;37 07:49:37 INFO - PID 17611 | |10;stanford-crypto-aes;70;76;71;69;73;70;73;79;70;69 07:49:37 INFO - PID 17611 | |11;stanford-crypto-ccm;104;98;102;103;102;104;113;104;101;107 07:49:37 INFO - PID 17611 | |12;stanford-crypto-pbkdf2;153;145;150;150;155;154;155;145;156;152 07:49:37 INFO - PID 17611 | |13;stanford-crypto-sha256-iterative;57;58;59;61;59;59;56;57;59;62 07:49:37 INFO - PID 17611 | __end_tp_report 07:49:37 INFO - PID 17611 | __start_cc_report 07:49:37 INFO - PID 17611 | _x_x_mozilla_cycle_collect,677 07:49:37 INFO - PID 17611 | __end_cc_report 07:49:37 INFO - PID 17611 | __startTimestamp1507646977982__endTimestamp 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | ------- Summary: start ------- 07:49:37 INFO - PID 17611 | Number of tests: 14 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#0] ai-astar Cycles:10 Average:105.90 Median:105.00 stddev:2.42 (2.3%) stddev-sans-first:2.57 07:49:37 INFO - PID 17611 | Values: 106.0 104.0 105.0 105.0 105.0 112.0 108.0 104.0 105.0 105.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#1] audio-beat-detection Cycles:10 Average:115.10 Median:113.50 stddev:8.74 (7.7%) stddev-sans-first:9.07 07:49:37 INFO - PID 17611 | Values: 110.0 111.0 117.0 111.0 110.0 112.0 111.0 115.0 139.0 115.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#2] audio-dft Cycles:10 Average:162.70 Median:162.00 stddev:3.33 (2.1%) stddev-sans-first:3.53 07:49:37 INFO - PID 17611 | Values: 162.0 161.0 162.0 161.0 163.0 161.0 161.0 162.0 162.0 172.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#3] audio-fft Cycles:10 Average:73.90 Median:73.50 stddev:2.60 (3.5%) stddev-sans-first:1.56 07:49:37 INFO - PID 17611 | Values: 80.0 73.0 73.0 72.0 71.0 74.0 72.0 73.0 75.0 76.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:77.00 stddev:0.42 (0.5%) stddev-sans-first:0.44 07:49:37 INFO - PID 17611 | Values: 77.0 77.0 77.0 77.0 77.0 77.0 78.0 77.0 78.0 77.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 07:49:37 INFO - PID 17611 | Values: 113.0 113.0 114.0 113.0 113.0 113.0 113.0 114.0 113.0 115.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:0.97 07:49:37 INFO - PID 17611 | Values: 147.0 148.0 147.0 149.0 148.0 148.0 150.0 149.0 148.0 147.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#7] imaging-desaturate Cycles:10 Average:94.00 Median:94.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 07:49:37 INFO - PID 17611 | Values: 93.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 95.0 95.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#8] json-parse-financial Cycles:10 Average:42.70 Median:43.00 stddev:1.06 (2.5%) stddev-sans-first:1.09 07:49:37 INFO - PID 17611 | Values: 42.0 42.0 42.0 44.0 44.0 44.0 41.0 43.0 42.0 43.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#9] json-stringify-tinderbox Cycles:10 Average:38.10 Median:38.00 stddev:0.57 (1.5%) stddev-sans-first:0.60 07:49:37 INFO - PID 17611 | Values: 38.0 39.0 38.0 38.0 39.0 38.0 38.0 38.0 38.0 37.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#10] stanford-crypto-aes Cycles:10 Average:72.00 Median:72.00 stddev:3.30 (4.6%) stddev-sans-first:3.42 07:49:37 INFO - PID 17611 | Values: 70.0 76.0 71.0 69.0 73.0 70.0 73.0 79.0 70.0 69.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#11] stanford-crypto-ccm Cycles:10 Average:103.80 Median:104.00 stddev:3.99 (3.8%) stddev-sans-first:4.24 07:49:37 INFO - PID 17611 | Values: 104.0 98.0 102.0 103.0 102.0 104.0 113.0 104.0 101.0 107.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:151.50 Median:153.50 stddev:3.98 (2.6%) stddev-sans-first:4.18 07:49:37 INFO - PID 17611 | Values: 153.0 145.0 150.0 150.0 155.0 154.0 155.0 145.0 156.0 152.0 07:49:37 INFO - PID 17611 | 07:49:37 INFO - PID 17611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:58.70 Median:59.00 stddev:1.83 (3.1%) stddev-sans-first:1.83 07:49:37 INFO - PID 17611 | Values: 57.0 58.0 59.0 61.0 59.0 59.0 56.0 57.0 59.0 62.0 07:49:37 INFO - PID 17611 | -------- Summary: end -------- 07:49:37 INFO - PID 17611 | 07:49:38 INFO - PID 17611 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 07:49:38 INFO - TEST-INFO | 17611: exit 0 07:49:38 INFO - TEST-OK | kraken | took 58129ms 07:49:38 INFO - SUITE-END | took 1164s 07:49:38 INFO - Completed test suite (00:19:24) 07:49:38 INFO - javascript benchmark 07:49:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 9597.001490966179, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3951.585083566225, 4011.899702507435, 4034.6772258219344, 4046.736962097463, 4062.126642771804, 6455.257645370783, 6531.771388001421, 6574.276829548752, 6628.4034436900665, 6633.734650613969, 6513.576617519858, 6540.149780528536, 6553.705083271252, 6609.0, 6631.270560238382, 5886.88226235475, 5978.312494063195, 5996.910046349309, 5997.640141591497, 6015.248093988252, 5882.088276317178, 5986.8802623947495, 5990.640561566298, 6073.544484163684, 6093.390660933894, 5969.910451343233, 5989.251343582052, 5990.371011043843, 5994.190784244115, 6001.4298641628975, 5981.252343457068, 6004.249468816398, 6013.067974463965, 6016.699165041752, 6046.727897244613, 5866.853328666774, 5913.379095195029, 5979.940200597982, 6060.848478788022, 6084.817455476343, 6413.615183088983, 6492.0, 6518.706658200393, 6543.0, 6569.57297775643, 7161.89257161143, 7178.748743793994, 7219.819504512377, 7276.054112965334, 7281.672324745399, 7002.579845209304, 7047.43620510358, 7227.421806255487, 7250.093738282715, 7345.669444874993, 6669.76655817049, 6694.062831203587, 6745.123133992599, 6761.087253220752, 6783.660816959133, 7392.186859445456, 7420.072490938633, 7492.7752167435065, 7504.099508059068, 7507.887381689279, 7095.7054911365285, 7106.0, 7189.2810718927685, 7195.352418282379, 7200.351968322876, 7041.119860017498, 7102.396296314768, 7219.747308844166, 7259.201487836333, 7316.195218525958, 7170.2471240519, 7191.280871912767, 7245.9275407246305, 7268.127824661075, 7284.890726639104, 7188.460865435113, 7216.7834964951135, 7217.458690598226, 7312.670929808171, 7315.487915845946, 5317.920231196458, 5352.116900711417, 5381.515663590296, 5394.78420863161, 5398.973005134949, 4915.680480768739, 4923.606111511071, 4955.0585388776735, 4989.276554899519, 4993.400791904995, 6697.564658297195, 6700.128983232246, 6778.796636100925, 6787.864242715217, 6791.388775010273, 7064.081669382947, 7119.679614417364, 7191.748288809867, 7201.675924583406, 7244.130704315516, 6724.193096828314, 6742.0, 6745.898811517831, 6750.054992301082, 6754.223264324567, 6065.696715164224, 6107.022876339854, 6144.477719393902, 6153.692315384213, 6173.197484327009, 7371.557706537517, 7410.184879663233, 7487.101547814297, 7515.21090285523, 7557.4331925105835, 7243.0946131733535, 7253.963730181315, 7279.45404094695, 7303.014093097364, 7332.45006624516, 7491.843717673159, 7499.700011999459, 7506.887396689163, 7509.7371591994015, 7605.049368828896, 7128.501004929813, 7164.820879478055, 7172.605506697182, 7178.856422871618, 7209.35115839577, 7231.096112985877, 7314.597697126709, 7316.634168291671, 7317.231690672403, 7337.376323012603, 6955.061066755923, 6979.860402792017, 6988.930110698828, 7040.718371265092, 7058.470614703815, 6820.147481564804, 6920.688569014507, 6923.5499692519825, 6984.4761642878, 7034.261402552863, 6966.233714291323, 7023.648817559204, 7026.227115017242, 7031.1211098612675, 7036.120484939383, 6925.445964322943, 7046.788596342118, 7067.540609860343, 7141.535800172972, 7161.641917903979, 6595.571287866273, 6710.530262881747, 6718.966405168138, 6837.965810170917, 6903.413209877016], "value": 6604.802299409718, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [986.3342243985309, 987.5555999800092, 1015.9746006349841, 1021.167748285148, 1047.7328281288276, 45621.31568026478, 46267.53732462674, 46377.304340434835, 46487.30269045967, 46498.535014649846, 43811.0, 43839.0, 44189.558104418946, 44254.11491770163, 44324.556754432444, 8149.674013039471, 8240.670373185065, 8247.134050924657, 8262.710805121791, 8268.297194738425, 8082.1917808219005, 8160.428769986103, 8161.959190204041, 8163.551004694739, 8166.020077590698, 8747.868781968244, 8967.0, 8971.730848074569, 8975.461472311683, 8979.461232326048, 8880.8667869982, 8901.821963560693, 8912.153345432174, 8937.061608531141, 8950.507722075283, 8736.8689469658, 8778.956105219497, 8784.736457906272, 8811.735647930573, 8842.20420162182, 41730.582694172976, 41799.0, 41882.581174188475, 42131.36802947928, 42147.578524214674, 3864.111254411473, 3898.766074035567, 3900.1614652849776, 3902.180542086165, 3903.1217975955183, 34379.82810085959, 34585.65414345875, 34597.0, 34634.48048279278, 34701.826490867636, 5653.802116925929, 5659.943400565983, 5665.065264231397, 5675.290588676416, 5680.31836179657, 240284.0, 242356.0, 242453.0, 242876.0, 243285.0, 56062.0, 56114.158287625716, 56192.719036405375, 56211.43788562144, 56396.43603563912, 58849.41150588525, 58858.0, 59143.0, 59370.703146484855, 59383.70308148432, 18786.154623041995, 18794.43616691474, 18932.337368192322, 18951.241950321833, 19022.23911043543, 15656.686866262839, 15677.451289204822, 15685.607859803597, 15724.05655660641, 15739.44911928077, 15896.920515397349, 16459.506214813573, 16563.83436165647, 16586.419475318307, 16589.66820663604, 6193.411625895533, 6242.843928901813, 6263.71813268404, 6379.138816259839, 6466.191726034246, 1107.6566264458045, 1109.7336639206533, 1115.3475216998147, 1125.4035361258545, 1149.0577726264382, 26281.605775913376, 26385.73614263871, 26512.072077477194, 26561.0, 26574.6013809793, 1232.679503329123, 1239.0087929656238, 1240.3116270469975, 1248.850137983448, 1255.0775180242515, 13582.456701732017, 13741.312934353242, 13811.378487968066, 13840.515581954583, 14082.71834563303, 282214.0, 319994.0, 322431.0, 326436.0, 327494.0, 66164.33835661678, 66257.0, 66449.33550664432, 66458.0, 66552.0, 1538.7076455473425, 1582.082392212514, 1589.1021572811323, 1589.9841001589837, 1591.228254296642, 30804.53793193149, 31023.844880776356, 31126.68873311238, 31307.84346078255, 31326.686733132377, 43287.783561082, 43475.130497390506, 43517.56482435135, 43548.56451435572, 43598.34602480902, 250152.0, 254742.0, 255622.0, 256621.0, 256992.0, 37523.43714844225, 37942.8102859495, 38282.27729752112, 38464.6153538461, 38472.0, 49121.01757964892, 49731.502684972686, 49761.75119124381, 50165.49834501608, 50207.24689129593, 35280.0, 35458.29083418369, 35640.108997275274, 35968.8201559001, 36321.81839090788, 35391.0, 35743.821280893426, 35865.28269434544, 36007.81996090003, 36346.63653363432, 42294.78852605717, 42295.7885210572, 42468.78765606152, 42544.361834571886, 42923.57076429196, 33918.982430527125, 34416.0, 34628.30743385169, 34975.65024349724, 35215.82392088023, 25431.10991115302, 25479.87260063762, 26009.0, 26037.73962260353, 26369.20892373232], "value": 19720.62636297577, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [637.6073996769076, 643.8430669273396, 649.4980702602929, 655.5283388792162, 656.2510908429036, 24423.511529769417, 25273.0, 25280.87359563204, 25294.873525632345, 25306.0, 26428.603570946452, 26938.595921061198, 27002.864985675045, 27033.18900432985, 27092.051778187768, 6453.161089058416, 6582.769603063905, 6697.095892054584, 6726.293739157367, 6729.1924969003785, 6658.334166583351, 6748.561343512681, 6748.6288254146, 6748.696308666097, 6752.223494298145, 6655.201375834882, 6708.127943367355, 6719.731210751588, 6721.529492935497, 6881.0, 6853.485988550854, 6878.243393226716, 6879.2432832388395, 6886.965565172142, 6891.552049116792, 6423.421892029693, 6446.452051575622, 6481.48148148147, 6484.157059582271, 6491.805245842632, 30522.84738576315, 31393.215169620715, 31820.681793182004, 31879.203019924455, 31933.680663193536, 2360.7403185649564, 2407.4703565215623, 2409.6867407236946, 2411.03558576569, 2419.479811840445, 20898.26856060046, 21394.786052139436, 21440.0, 21450.46373840651, 21467.03398347078, 2587.2238328501376, 2659.6409484719507, 2687.046098634976, 2711.52548304046, 2712.8779204935827, 157132.0, 160574.0, 168541.0, 173647.0, 173896.0, 17377.47867563975, 17382.826171738372, 17491.0, 17517.7372339415, 17988.2804687811, 27819.721802781714, 27888.86055569709, 27913.44173116526, 27941.580876286873, 28093.859530702215, 11649.242799218024, 11814.586489472827, 11893.88106118945, 11923.76152476963, 11990.520379184734, 10854.837177442345, 10862.511186996604, 10893.074088702391, 10943.671689849318, 10953.945230273797, 10003.499825008867, 10338.12125969301, 10493.0, 10571.894281057092, 10581.682549523373, 2893.7540309073543, 3010.3377257003426, 3045.4365942300747, 3072.6773688762805, 3163.731082857983, 1049.3861091261697, 1080.475969154959, 1081.588996181446, 1086.0876863434594, 1086.2884810449168, 21058.262960796605, 21521.923903804745, 21643.13427462884, 21674.241401551186, 21974.780252197274, 1130.1467392118898, 1144.6108323170163, 1157.6121999130385, 1166.1953252255917, 1169.5789515774316, 11630.70923226926, 11877.168598198215, 11903.404829758478, 12066.155369124077, 12268.631941041784, 567986.0, 611764.0, 614752.0, 626144.0, 632326.0, 129553.35223324012, 130538.34730826285, 131457.34567561978, 132782.33608831893, 132903.0, 1142.965711028654, 1202.5009621007184, 1248.525560287085, 1272.6118533847266, 1287.8068289756611, 22396.888015559816, 22660.320190394315, 22882.199123030616, 22990.42523936915, 23164.536709265383, 64921.0, 65090.0, 65712.34287657062, 66065.33934660592, 66630.66684666545, 79713.0, 79873.6006319988, 80163.0, 81250.0, 82255.58872205601, 15574.0, 16142.515724528283, 16476.0, 16517.917410412872, 16572.337106516086, 23819.880900595384, 23999.0, 24141.879290603436, 24369.0, 24580.385490362885, 20103.798962010194, 20352.491187719832, 20499.0, 20506.58986820285, 20517.281895133598, 17809.73285400694, 17864.642707145525, 17936.19287132056, 18204.635907281514, 18504.81495185031, 20356.0, 20628.690569641767, 20750.0, 20790.376288711363, 20984.160633574487, 16088.195590220676, 16231.756523651919, 16293.429729959395, 16302.59243518874, 16326.918365408097, 19540.90229548843, 19862.801371986094, 19863.304784333057, 20186.293479728138, 20240.291589794288], "value": 13333.630468610314, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.597235760166, 1486.695227478367, 1491.0, 1523.6343277613369, 1525.786389905413, 17510.0, 18347.81652183478, 18352.0, 18353.44939651809, 18361.173747181376, 17743.201555929983, 17763.55591110223, 17846.10769461525, 17853.19660615272, 17921.103944802773, 2959.4525012872687, 3010.8042977206464, 3024.6370435547765, 3040.8783648654025, 3051.389722055587, 3035.150157955765, 3035.8482075896227, 3054.618172728409, 3056.205386599489, 3060.739837113848, 2981.0907673159677, 3023.9848800755967, 3036.6356037275445, 3045.6649768525554, 3054.816710997336, 2821.901233456819, 2876.381577960738, 2882.3658795065053, 2885.6970018148004, 2889.8410587417684, 2789.609454676347, 2812.2125804774696, 2816.2536927714173, 2818.8590570471392, 2826.7597254233415, 17059.232334544977, 17127.571810704707, 17188.65622687552, 17254.56863578408, 17306.0, 8535.914640853636, 8847.336449766293, 8857.689980850639, 8860.06969268224, 8864.157904999014, 5764.711764411804, 5829.5919285650025, 5954.374790647006, 6072.149899014142, 6100.298465676459, 2157.7410710714817, 2161.200355868323, 2187.704659870913, 2229.2277639276813, 2259.4690247791755, 28857.278568035756, 29942.85028574865, 31365.686343136505, 32294.192645183823, 32675.67324326726, 7881.566513841679, 7926.841463170705, 8131.390145739093, 8193.918060819435, 8524.14758524155, 24142.0, 24224.0, 24262.393440164138, 24269.393265168514, 24279.514409711708, 8997.190252877272, 9172.633094676139, 9202.217811485965, 9270.351075424656, 9330.066993300616, 7974.5215287082965, 7983.84032319362, 8251.546164960864, 8317.500949943023, 8322.042965058974, 6589.472842172615, 6590.406863382223, 6628.171478565179, 6642.269350371455, 6702.832429189211, 1845.953851153705, 1849.5653521422455, 1868.7757469103794, 1874.6906760384657, 1884.689026310671, 1017.2421545948316, 1030.1861529391847, 1035.699647102347, 1040.6097713357492, 1057.2652006855162, 9279.443233406017, 9350.90649093514, 9367.0, 9415.435073895589, 9415.811683766286, 828.6561077153035, 830.4892491117919, 832.6919039955255, 837.4975014991079, 840.4243093480985, 5474.370447398521, 5572.832815015556, 5620.213170156181, 5661.433856614306, 5688.658680479184, 24729.87635061813, 26413.73586264151, 26454.47091058168, 26465.735342646713, 26489.602655960178, 24201.63697544538, 25488.235352939442, 25720.742792572208, 25763.22710318656, 25834.224973250457, 11213.719657008476, 12833.807492887614, 12994.48022079125, 13362.732745345233, 13398.732025359439, 10905.672829815117, 10918.344899306067, 11002.449877505933, 11021.393823339793, 11030.172737044593, 21920.561588767818, 22757.203497878156, 22998.885005575536, 23132.537349252583, 23545.175918842757, 22706.772932270465, 22943.88528057349, 23694.0, 24208.51582968366, 24384.0, 12834.935825321187, 13242.933785331012, 13244.271565064015, 13265.0, 13267.203967761965, 16195.514134575982, 16264.837351626333, 16280.592985175464, 16380.918095409446, 16416.09711465881, 13088.80366794518, 13175.341232938506, 13326.466941322238, 13498.93250533741, 13742.587722368346, 12747.171433856769, 12851.0, 12865.906397956278, 12912.289824059766, 13081.149725268207, 10416.427096509462, 10562.155027597928, 10565.524551395052, 10572.36565806054, 10591.841122383325, 8861.60122794463, 8951.283897288331, 8983.281337492854, 9101.180893719596, 9205.815883682422, 8683.913160868564, 8792.692255771017, 8818.162274583905, 8862.468251904906, 8931.821363572562], "value": 7712.0801276082775, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [571.077709499159, 579.3135134865182, 595.1697382151898, 620.7020630097553, 629.9748010079597, 6399.488040956724, 6515.599146183569, 6528.543001989862, 6597.736090556384, 6602.1747281589805, 6453.774117905874, 6469.805905822833, 6481.319461456538, 6501.317361677026, 6503.90244146337, 5367.838964831061, 5400.621956463049, 5409.134538473845, 5412.188171774226, 5451.863703407407, 5163.664361816489, 5259.447757985414, 5259.500347466985, 5307.1243244864745, 5375.919361209565, 5134.589232861381, 5207.557357624606, 5226.216067589873, 5267.183586544092, 5281.498257665516, 5207.583393328525, 5210.791568337262, 5214.296070030536, 5223.503767142115, 5226.895462090756, 4692.741899195543, 4748.596369308613, 4790.8323208687525, 4796.304535842283, 4829.420469543677, 6470.158879345655, 6476.319986401454, 6480.0, 6518.315576864408, 6522.771702990372, 6064.484518815906, 6129.085432557603, 6204.627722336674, 6222.937770622327, 6240.344763799826, 6974.476914231453, 7077.3984211341585, 7077.71689132434, 7094.290570942916, 7111.4666400020205, 5128.1282182029145, 5333.8265581571995, 5364.678119312854, 5383.327084114486, 5391.649542779707, 7102.786916392516, 7177.461690373243, 7217.711291548384, 7252.166000909858, 7343.77968660941, 5490.3411590609385, 5508.724563771795, 5522.392536820947, 5541.639793413416, 5566.777328906879, 5555.833325000256, 5596.860078497989, 5603.243562119062, 5610.831675049755, 5661.405552417019, 6188.752449902044, 6191.071339299141, 6218.507558186003, 6222.160008398899, 6252.812415627538, 7057.470689698293, 7104.467164962545, 7121.89317160243, 7125.287471252833, 7130.964345178241, 1917.8465722742146, 1920.9807901920801, 1932.8936908470168, 1941.9708704369446, 1946.2701486942397, 1328.0836223006095, 1369.3564024908278, 1377.2493990775051, 1385.840628327735, 1395.4976208564908, 6572.11276477679, 6576.1122248496795, 6586.901196482057, 6608.471322294205, 6623.933760662428, 6991.475639326969, 7067.363937245673, 7068.151821781419, 7170.820729481805, 7172.6055066970775, 6535.934640653532, 6552.737890484327, 6578.144841170617, 6612.173478315211, 6629.204495460575, 3752.724073814916, 3786.6402691744242, 3815.2369526094335, 3822.2546603412625, 3830.4062870255157, 7293.9635301823155, 7381.88927166093, 7395.852082958419, 7410.851782964311, 7482.214367491444, 7318.34134927859, 7349.044624198927, 7361.926380736231, 7368.636802191611, 7440.330370266702, 7061.399781018671, 7167.175774785862, 7208.135023797073, 7238.746643867545, 7342.449316301192, 7042.908349205882, 7058.082449281561, 7060.364567188978, 7065.788026359218, 7077.150741911004, 6977.895331569929, 7067.752628657972, 7075.858482830417, 7087.22040575526, 7110.182329032227, 7370.705171793283, 7382.778516644509, 7415.703371865065, 7428.665710043169, 7461.328480436787, 5496.725163741877, 5499.597602611469, 5517.117261238182, 5518.33779946409, 5545.585875601696, 6805.795826125224, 6958.520739630185, 6971.65141742921, 7060.505764596429, 7074.540154889915, 6524.282328943717, 6790.25307216196, 6801.775680377579, 6824.215215250111, 6980.267071957372, 6734.158230221223, 6745.291744366967, 6815.568730566637, 6860.3139686031, 6860.348266914635, 6786.760369078093, 6800.863982720219, 6811.318868113149, 6811.4550835934, 6821.522493425413, 6777.322267773183, 6859.108315918898, 6937.236903940461, 6941.015363393789, 6951.756688515878, 6616.933830661632, 6632.436242919213, 6641.203055633355, 6719.4624430044505, 6758.357955994173], "value": 5462.003561824547, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [977.8044391121778, 1024.3700124423478, 1027.964021259256, 1040.115901483739, 1051.6476980211628, 21480.0, 21729.23947661832, 21798.89100554499, 21813.345599631997, 21821.563568728616, 19868.205271789113, 20060.297889573867, 20866.582668346626, 21010.474738131554, 21022.894885525588, 1068.7969285835686, 1074.5379486820664, 1080.060347497678, 1080.1412876762993, 1080.4057768227483, 1076.9730756731067, 1087.9564817407295, 1110.4836251143217, 1110.8555887734583, 1113.4822307626953, 1188.4295538141698, 1190.3512585640847, 1192.648168790209, 1192.9343886086263, 1194.3192380343207, 1173.8591369035728, 1174.477357575879, 1177.7703347847173, 1178.8113901775719, 1184.9289042657467, 864.7016779211162, 866.0733015673233, 866.5104216117936, 867.9783005424852, 868.2663149638545, 21869.67195492069, 22404.88797556018, 22573.661395079085, 22574.548509029726, 22613.321600352017, 23929.0, 24067.638985415233, 24328.756712432827, 24387.634185487233, 24479.26562203137, 18597.25610975559, 19049.238030478766, 19054.42836714901, 19110.71333929992, 19124.617507649768, 4053.7770422626745, 4130.690198235115, 4131.50421949368, 4132.070284186064, 4142.647874930634, 163184.18407908003, 166972.0, 169111.15444422944, 169888.0, 170598.0, 15513.0, 15556.766648500281, 15718.21408929549, 15750.291236894367, 15753.842461575467, 27163.185104446897, 27940.0, 28003.43993120167, 28047.158585242476, 28188.71811281902, 9490.525473726424, 9558.091981261769, 9593.616255349707, 9644.18024467914, 9786.657466988621, 4802.8799280018275, 4860.17377045896, 4867.440244371872, 4869.074875773592, 4873.00103478786, 6471.514636402195, 6513.12072870166, 6570.868582628416, 6580.341965803477, 6643.169603799525, 1166.259425264946, 1190.2620375367328, 1204.3195594489262, 1207.486818102303, 1208.7884620191608, 770.9884351734728, 781.6013832945239, 782.5891407011364, 792.9127795942557, 793.547677823635, 12433.316167610687, 13282.601521954357, 13408.932955335162, 14803.259837008107, 14824.3329050193, 776.6621519638975, 780.1730166024033, 781.0783275734688, 783.4241832253289, 793.746001279585, 6176.104464852571, 6208.782692605737, 6361.427471527492, 6402.263739669905, 6506.056621789814, 157508.0, 159450.0, 160311.19844400938, 160984.0, 161721.19139404464, 132499.0, 133384.0, 134844.60621575222, 135260.0, 139782.0, 113662.0, 116417.41791290989, 119256.0, 119738.0, 121655.0, 13961.930190348983, 14513.201773902536, 14517.78223326672, 14538.418463261774, 14654.853451465775, 54228.18657720216, 55014.724926375115, 55322.0, 55401.7229913864, 56308.15537766855, 96540.51729741307, 96965.5151724237, 97119.0, 97819.51090244504, 103600.0, 20918.581628367043, 20962.895185523976, 21328.78671213268, 21435.67846482273, 21536.353909382742, 23964.760352396253, 24612.50774984526, 24772.876135619208, 25082.372940675898, 25176.37059073538, 20611.0, 20658.0, 22023.22918697838, 22154.003069861574, 22654.546909061395, 20706.275280365116, 20816.0, 21276.468088297297, 21812.56374872462, 21998.89000554987, 21624.783752162908, 21813.23653672177, 21877.0, 22002.559948801256, 22020.559588808454, 14146.929265353607, 14156.292185390483, 14289.996702539194, 16655.50033498997, 16707.16464176762, 15954.521364359089, 16056.598585035468, 16285.511434656979, 16656.250468728693, 16675.49973500797], "value": 10679.123340754473, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1357.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 104.0, 105.0, 105.0, 105.0, 112.0, 108.0, 104.0, 105.0, 105.0], "value": 105.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 117.0, 111.0, 110.0, 112.0, 111.0, 115.0, 139.0, 115.0], "value": 115.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 163.0, 161.0, 161.0, 162.0, 162.0, 172.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 73.0, 73.0, 72.0, 71.0, 74.0, 72.0, 73.0, 75.0, 76.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 77.0, 77.0, 77.0, 78.0, 77.0, 78.0, 77.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 114.0, 113.0, 115.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 149.0, 148.0, 148.0, 150.0, 149.0, 148.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [42.0, 42.0, 42.0, 44.0, 44.0, 44.0, 41.0, 43.0, 42.0, 43.0], "value": 42.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [38.0, 39.0, 38.0, 38.0, 39.0, 38.0, 38.0, 38.0, 38.0, 37.0], "value": 38.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 76.0, 71.0, 69.0, 73.0, 70.0, 73.0, 79.0, 70.0, 69.0], "value": 72.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 98.0, 102.0, 103.0, 102.0, 104.0, 113.0, 104.0, 101.0, 107.0], "value": 103.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 145.0, 150.0, 150.0, 155.0, 154.0, 155.0, 145.0, 156.0, 152.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 58.0, 59.0, 61.0, 59.0, 59.0, 56.0, 57.0, 59.0, 62.0], "value": 58.7, "unit": "score"}]}]} 07:49:38 INFO - Return code: 0 07:49:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:49:38 INFO - # TBPL SUCCESS # 07:49:38 INFO - Running post-action listener: _package_coverage_data 07:49:38 INFO - Running post-action listener: _resource_record_post_action 07:49:38 INFO - [mozharness: 2017-10-10 14:49:38.759186Z] Finished run-tests step (success) 07:49:38 INFO - Running post-run listener: _resource_record_post_run 07:49:38 INFO - Total resource usage - Wall time: 1180s; CPU: 13.0%; Read bytes: 147456; Write bytes: 340316160; Read time: 52; Write time: 154788 07:49:38 INFO - TinderboxPrint: CPU usage
13.0% 07:49:38 INFO - TinderboxPrint: I/O read bytes / time
147,456 / 52 07:49:38 INFO - TinderboxPrint: I/O write bytes / time
340,316,160 / 154,788 07:49:38 INFO - TinderboxPrint: CPU idle
8,180.0 (86.9%) 07:49:38 INFO - TinderboxPrint: CPU user
1,179.8 (12.5%) 07:49:38 INFO - TinderboxPrint: Swap in / out
0 / 0 07:49:38 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 58572800; Read time: 0; Write time: 26100 07:49:38 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 07:49:38 INFO - run-tests - Wall time: 1165s; CPU: 13.0%; Read bytes: 147456; Write bytes: 273707008; Read time: 52; Write time: 127208 07:49:39 INFO - Running post-run listener: _upload_blobber_files 07:49:39 INFO - Blob upload gear active. 07:49:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:49:39 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 07:49:39 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'] 07:49:39 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 07:49:39 INFO - (blobuploader) - INFO - Open directory for files ... 07:49:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:49:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:49:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:40 INFO - (blobuploader) - INFO - Done attempting. 07:49:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:49:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:48 INFO - (blobuploader) - INFO - Done attempting. 07:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:49:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:49 INFO - (blobuploader) - INFO - Done attempting. 07:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:49:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:49:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:49:50 INFO - (blobuploader) - INFO - Done attempting. 07:49:50 INFO - (blobuploader) - INFO - Iteration through files over. 07:49:50 INFO - Return code: 0 07:49:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:49:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:49:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/956f322c959792e7ad7c5c8124146f9cf65cedb73d92877302aafbb81ea81df439374ccc6937eddd603dd5d0f1cd63dfd75a3c5185a4f294538573639f97e43b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2fae0e7f0afe9d3d1a85004b006b5772a98910c599b0b80523f3acfd4b74b879f315f351bd4b600aff7421f53879caa7519832186a91a6b22f088847defc3f86", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24bdfb0b963708e726f417fff36fc20e42585cc3e3772846ace116c7c7dd0b5c4fea583192e173f891bf822da7fc9b326b34c575bf4676e607497c6d97fa7a19", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5650208b2015383444fdb93c2004d1b1e537661d5fa1c97e4de0dbe2716072027375f5ed264549e4e1c4c4e021631a720dc0374de4104a28531ba978ecaa5899"} 07:49:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:49:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:49:50 INFO - Contents: 07:49:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/956f322c959792e7ad7c5c8124146f9cf65cedb73d92877302aafbb81ea81df439374ccc6937eddd603dd5d0f1cd63dfd75a3c5185a4f294538573639f97e43b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2fae0e7f0afe9d3d1a85004b006b5772a98910c599b0b80523f3acfd4b74b879f315f351bd4b600aff7421f53879caa7519832186a91a6b22f088847defc3f86", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24bdfb0b963708e726f417fff36fc20e42585cc3e3772846ace116c7c7dd0b5c4fea583192e173f891bf822da7fc9b326b34c575bf4676e607497c6d97fa7a19", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5650208b2015383444fdb93c2004d1b1e537661d5fa1c97e4de0dbe2716072027375f5ed264549e4e1c4c4e021631a720dc0374de4104a28531ba978ecaa5899"} 07:49:50 INFO - Running post-run listener: copy_logs_to_upload_dir 07:49:50 INFO - Copying logs to upload dir... 07:49:50 INFO - mkdir: /builds/slave/test/build/upload/logs 07:49:50 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.824017 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-10-10 07:49:50.480272) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-10 07:49:50.484211) ========= 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=db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691 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/956f322c959792e7ad7c5c8124146f9cf65cedb73d92877302aafbb81ea81df439374ccc6937eddd603dd5d0f1cd63dfd75a3c5185a4f294538573639f97e43b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2fae0e7f0afe9d3d1a85004b006b5772a98910c599b0b80523f3acfd4b74b879f315f351bd4b600aff7421f53879caa7519832186a91a6b22f088847defc3f86", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24bdfb0b963708e726f417fff36fc20e42585cc3e3772846ace116c7c7dd0b5c4fea583192e173f891bf822da7fc9b326b34c575bf4676e607497c6d97fa7a19", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5650208b2015383444fdb93c2004d1b1e537661d5fa1c97e4de0dbe2716072027375f5ed264549e4e1c4c4e021631a720dc0374de4104a28531ba978ecaa5899"} build_url:https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/IkAJlwb6TImMfvpHikmHVA/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/956f322c959792e7ad7c5c8124146f9cf65cedb73d92877302aafbb81ea81df439374ccc6937eddd603dd5d0f1cd63dfd75a3c5185a4f294538573639f97e43b", "resource-usage.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/2fae0e7f0afe9d3d1a85004b006b5772a98910c599b0b80523f3acfd4b74b879f315f351bd4b600aff7421f53879caa7519832186a91a6b22f088847defc3f86", "dromaeojs-e10s_raw.log": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/24bdfb0b963708e726f417fff36fc20e42585cc3e3772846ace116c7c7dd0b5c4fea583192e173f891bf822da7fc9b326b34c575bf4676e607497c6d97fa7a19", "perfherder-data.json": "https://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta-Non-PGO/sha512/5650208b2015383444fdb93c2004d1b1e537661d5fa1c97e4de0dbe2716072027375f5ed264549e4e1c4c4e021631a720dc0374de4104a28531ba978ecaa5899"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-10-10 07:49:50.514005) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:49:50.514344) ========= 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=db0483c52d987ecb441a263b000001ad-1507643624.574999-511667691 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004477 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-10-10 07:49:50.597982) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-10 07:49:50.598322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-10-10 07:49:50.598668) ========= ========= Total master_lag: 0.28 =========