builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0312 starttime: 1478549712.22 results: success (0) buildid: 20161107100027 builduid: e4631074dc6d45fbaf9f28f002de049d revision: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.219317) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.220084) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.220558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.248165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.248694) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DUWBYSgAYI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-07 12:15:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 48.2M=0s 2016-11-07 12:15:12 (48.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.508090 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.779724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.780019) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DUWBYSgAYI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.024919 ========= master_lag: 0.08 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:12.881389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 12:15:12.881699) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a1243da2fec4f351fa1fc5a2314f704f670fd8e8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev a1243da2fec4f351fa1fc5a2314f704f670fd8e8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DUWBYSgAYI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-07 12:15:12,969 truncating revision to first 12 chars 2016-11-07 12:15:12,969 Setting DEBUG logging. 2016-11-07 12:15:12,969 attempt 1/10 2016-11-07 12:15:12,969 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/a1243da2fec4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-07 12:15:14,102 unpacking tar archive at: mozilla-aurora-a1243da2fec4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.397849 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-07 12:15:14.301473) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:14.301813) ========= script_repo_revision: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:14.302240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:14.302515) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-07 12:15:14.320787) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-07 12:15:14.321152) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DUWBYSgAYI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:15:14 INFO - MultiFileLogger online at 20161107 12:15:14 in /builds/slave/test 12:15:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 12:15:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:15:14 INFO - {'append_to_log': False, 12:15:14 INFO - 'base_work_dir': '/builds/slave/test', 12:15:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 12:15:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:15:14 INFO - 'branch': 'Mozilla-Aurora', 12:15:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:15:14 INFO - 'config_files': ('talos/mac_config.py',), 12:15:14 INFO - 'default_actions': ('clobber', 12:15:14 INFO - 'read-buildbot-config', 12:15:14 INFO - 'download-and-extract', 12:15:14 INFO - 'populate-webroot', 12:15:14 INFO - 'create-virtualenv', 12:15:14 INFO - 'install', 12:15:14 INFO - 'run-tests'), 12:15:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:15:14 INFO - 'download_minidump_stackwalk': True, 12:15:14 INFO - 'download_symbols': 'ondemand', 12:15:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:15:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:15:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:15:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:15:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:15:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:15:14 INFO - 'installer_path': 'installer.exe', 12:15:14 INFO - 'log_level': 'info', 12:15:14 INFO - 'log_name': 'talos', 12:15:14 INFO - 'log_to_console': True, 12:15:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:15:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:15:14 INFO - 'opt_config_files': (), 12:15:14 INFO - 'pip_index': False, 12:15:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:14 INFO - 'cmd': ('bash', 12:15:14 INFO - '-c', 12:15:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:14 INFO - 'enabled': True, 12:15:14 INFO - 'halt_on_failure': False, 12:15:14 INFO - 'name': 'check_screen_resolution'},), 12:15:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:15:14 INFO - 'cmd': ('bash', 12:15:14 INFO - '-c', 12:15:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:15:14 INFO - 'enabled': True, 12:15:14 INFO - 'halt_on_failure': False, 12:15:14 INFO - 'name': 'check_screen_resolution'},), 12:15:14 INFO - 'run_cmd_checks_enabled': True, 12:15:14 INFO - 'sps_profile': False, 12:15:14 INFO - 'sps_profile_interval': 0, 12:15:14 INFO - 'suite': 'dromaeojs-e10s', 12:15:14 INFO - 'system_bits': '32', 12:15:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:15:14 INFO - 'title': 't-yosemite-r7-0312', 12:15:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:15:14 INFO - 'use_talos_json': True, 12:15:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:15:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:15:14 INFO - 'work_dir': 'build'} 12:15:14 INFO - [mozharness: 2016-11-07 20:15:14.520590Z] Running clobber step. 12:15:14 INFO - Running pre-action listener: _resource_record_pre_action 12:15:14 INFO - Running main action method: clobber 12:15:14 INFO - rmtree: /builds/slave/test/build 12:15:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:15:16 INFO - Running post-action listener: _resource_record_post_action 12:15:16 INFO - [mozharness: 2016-11-07 20:15:16.865212Z] Finished clobber step (success) 12:15:16 INFO - [mozharness: 2016-11-07 20:15:16.865391Z] Running read-buildbot-config step. 12:15:16 INFO - Running pre-action listener: _resource_record_pre_action 12:15:16 INFO - Running main action method: read_buildbot_config 12:15:16 INFO - Using buildbot properties: 12:15:16 INFO - { 12:15:16 INFO - "project": "", 12:15:16 INFO - "product": "firefox", 12:15:16 INFO - "script_repo_revision": "production", 12:15:16 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 12:15:16 INFO - "repository": "", 12:15:16 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 12:15:16 INFO - "buildid": "20161107100027", 12:15:16 INFO - "pgo_build": "False", 12:15:16 INFO - "basedir": "/builds/slave/test", 12:15:16 INFO - "buildnumber": 443, 12:15:16 INFO - "slavename": "t-yosemite-r7-0312", 12:15:16 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:15:16 INFO - "platform": "yosemite_r7", 12:15:16 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 12:15:16 INFO - "branch": "mozilla-aurora", 12:15:16 INFO - "repo_path": "releases/mozilla-aurora", 12:15:16 INFO - "revision": "a1243da2fec4f351fa1fc5a2314f704f670fd8e8", 12:15:16 INFO - "stage_platform": "macosx64", 12:15:16 INFO - "builduid": "e4631074dc6d45fbaf9f28f002de049d", 12:15:16 INFO - "slavebuilddir": "test" 12:15:16 INFO - } 12:15:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 12:15:16 INFO - Running post-action listener: _resource_record_post_action 12:15:16 INFO - [mozharness: 2016-11-07 20:15:16.868464Z] Finished read-buildbot-config step (success) 12:15:16 INFO - [mozharness: 2016-11-07 20:15:16.868577Z] Running download-and-extract step. 12:15:16 INFO - Running pre-action listener: _resource_record_pre_action 12:15:16 INFO - Running main action method: download_and_extract 12:15:16 INFO - mkdir: /builds/slave/test/build/tests 12:15:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:16 INFO - trying https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 12:15:16 INFO - Downloading https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:15:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 12:15:17 INFO - Downloaded 1199 bytes. 12:15:17 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 12:15:17 INFO - Using the following test package requirements: 12:15:17 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:15:17 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 12:15:17 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 12:15:17 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'jsshell-mac.zip'], 12:15:17 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 12:15:17 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 12:15:17 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 12:15:17 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 12:15:17 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 12:15:17 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 12:15:17 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 12:15:17 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 12:15:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:15:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:15:17 INFO - Fetch https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:15:18 INFO - Expected file size: 16423378 12:15:25 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 12:15:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 12:15:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 12:15:25 INFO - Fetch https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 12:15:26 INFO - Expected file size: 16423378 12:15:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 12:15:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 12:15:32 INFO - Fetch https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 12:15:33 INFO - Expected file size: 14414089 12:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:34 INFO - trying https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:15:34 INFO - Downloading https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 12:15:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 12:15:37 INFO - Downloaded 115464070 bytes. 12:15:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:15:37 INFO - mkdir: /builds/slave/test/properties 12:15:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:15:37 INFO - Writing to file /builds/slave/test/properties/build_url 12:15:37 INFO - Contents: 12:15:37 INFO - build_url:https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 12:15:38 INFO - Running post-action listener: _resource_record_post_action 12:15:38 INFO - Running post-action listener: set_extra_try_arguments 12:15:38 INFO - [mozharness: 2016-11-07 20:15:38.228041Z] Finished download-and-extract step (success) 12:15:38 INFO - [mozharness: 2016-11-07 20:15:38.228201Z] Running populate-webroot step. 12:15:38 INFO - Running pre-action listener: _resource_record_pre_action 12:15:38 INFO - Running main action method: populate_webroot 12:15:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:15:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:15:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:15:38 INFO - '--tppagecycles', 12:15:38 INFO - '7'], 12:15:38 INFO - 'tests': ['tsvgm']}}, 12:15:38 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:15:38 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:15:38 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:15:38 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:15:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:15:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['damp', 'tps']}, 12:15:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'tests': ['damp', 'tps']}, 12:15:38 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['dromaeo_dom']}, 12:15:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:15:38 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['basic_compositor_video']}, 12:15:38 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:15:38 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['a11yr', 12:15:38 INFO - 'ts_paint', 12:15:38 INFO - 'tpaint', 12:15:38 INFO - 'sessionrestore', 12:15:38 INFO - 'sessionrestore_no_auto_restore', 12:15:38 INFO - 'tabpaint']}, 12:15:38 INFO - 'other-e10s': {'tests': ['a11yr', 12:15:38 INFO - 'ts_paint', 12:15:38 INFO - 'tpaint', 12:15:38 INFO - 'sessionrestore', 12:15:38 INFO - 'sessionrestore_no_auto_restore', 12:15:38 INFO - 'tabpaint']}, 12:15:38 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:15:38 INFO - 'ts_paint', 12:15:38 INFO - 'tpaint', 12:15:38 INFO - 'sessionrestore', 12:15:38 INFO - 'sessionrestore_no_auto_restore', 12:15:38 INFO - 'tabpaint']}, 12:15:38 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:15:38 INFO - 'ts_paint', 12:15:38 INFO - 'tpaint', 12:15:38 INFO - 'sessionrestore', 12:15:38 INFO - 'sessionrestore_no_auto_restore', 12:15:38 INFO - 'tabpaint']}, 12:15:38 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['a11yr', 12:15:38 INFO - 'ts_paint', 12:15:38 INFO - 'tpaint', 12:15:38 INFO - 'sessionrestore', 12:15:38 INFO - 'sessionrestore_no_auto_restore', 12:15:38 INFO - 'tabpaint']}, 12:15:38 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['a11yr', 12:15:38 INFO - 'ts_paint', 12:15:38 INFO - 'tpaint', 12:15:38 INFO - 'sessionrestore', 12:15:38 INFO - 'sessionrestore_no_auto_restore', 12:15:38 INFO - 'tabpaint']}, 12:15:38 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['tsvgx', 12:15:38 INFO - 'tsvgr_opacity', 12:15:38 INFO - 'tart', 12:15:38 INFO - 'tscrollx', 12:15:38 INFO - 'cart']}, 12:15:38 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:15:38 INFO - 'tsvgr_opacity', 12:15:38 INFO - 'tart', 12:15:38 INFO - 'tscrollx', 12:15:38 INFO - 'cart']}, 12:15:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'talos_options': ['--disable-e10s'], 12:15:38 INFO - 'tests': ['tp5o']}, 12:15:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'tests': ['tp5o']}, 12:15:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'talos_options': ['--disable-e10s', 12:15:38 INFO - '--xperf_path', 12:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:38 INFO - 'tests': ['tp5n']}, 12:15:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:15:38 INFO - 'talos_options': ['--xperf_path', 12:15:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:15:38 INFO - 'tests': ['tp5n']}}, 12:15:38 INFO - 'talos.zip': {'path': '', 12:15:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:15:38 INFO - Running post-action listener: _resource_record_post_action 12:15:38 INFO - [mozharness: 2016-11-07 20:15:38.247239Z] Finished populate-webroot step (success) 12:15:38 INFO - [mozharness: 2016-11-07 20:15:38.247355Z] Running create-virtualenv step. 12:15:38 INFO - Running pre-action listener: _resource_record_pre_action 12:15:38 INFO - Running main action method: create_virtualenv 12:15:38 INFO - Creating virtualenv /builds/slave/test/build/venv 12:15:38 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:15:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:15:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:15:38 INFO - Using real prefix '/tools/python27' 12:15:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:15:39 INFO - Installing distribute.............................................................................................................................................................................................done. 12:15:41 INFO - Installing pip.................done. 12:15:41 INFO - Return code: 0 12:15:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:41 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:15:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:15:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:41 INFO - 'HOME': '/Users/cltbld', 12:15:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:41 INFO - 'LOGNAME': 'cltbld', 12:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:41 INFO - 'MOZ_NO_REMOTE': '1', 12:15:41 INFO - 'NO_EM_RESTART': '1', 12:15:41 INFO - 'PAGER': '/bin/cat', 12:15:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:41 INFO - 'PWD': '/builds/slave/test', 12:15:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:41 INFO - 'SHELL': '/bin/bash', 12:15:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:15:41 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:15:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:41 INFO - 'USER': 'cltbld', 12:15:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:41 INFO - 'XPC_FLAGS': '0x0', 12:15:41 INFO - 'XPC_SERVICE_NAME': '0', 12:15:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:42 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:15:42 INFO - Cleaning up... 12:15:42 INFO - Return code: 0 12:15:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:15:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:15:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:42 INFO - 'HOME': '/Users/cltbld', 12:15:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:42 INFO - 'LOGNAME': 'cltbld', 12:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:42 INFO - 'MOZ_NO_REMOTE': '1', 12:15:42 INFO - 'NO_EM_RESTART': '1', 12:15:42 INFO - 'PAGER': '/bin/cat', 12:15:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:42 INFO - 'PWD': '/builds/slave/test', 12:15:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:42 INFO - 'SHELL': '/bin/bash', 12:15:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:15:42 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:15:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:42 INFO - 'USER': 'cltbld', 12:15:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:42 INFO - 'XPC_FLAGS': '0x0', 12:15:42 INFO - 'XPC_SERVICE_NAME': '0', 12:15:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:42 INFO - Downloading/unpacking psutil>=3.1.1 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:15:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:15:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:46 INFO - Installing collected packages: psutil 12:15:46 INFO - Running setup.py install for psutil 12:15:46 INFO - building 'psutil._psutil_osx' extension 12:15:46 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 12:15:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 12:15:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 12:15:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 12:15:47 INFO - building 'psutil._psutil_posix' extension 12:15:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 12:15:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:15:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:15:47 INFO - ^ 12:15:47 INFO - 1 warning generated. 12:15:47 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 12:15:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:15:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:15:47 INFO - Successfully installed psutil 12:15:47 INFO - Cleaning up... 12:15:47 INFO - Return code: 0 12:15:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:47 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:15:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:15:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:47 INFO - 'HOME': '/Users/cltbld', 12:15:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:47 INFO - 'LOGNAME': 'cltbld', 12:15:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:47 INFO - 'MOZ_NO_REMOTE': '1', 12:15:47 INFO - 'NO_EM_RESTART': '1', 12:15:47 INFO - 'PAGER': '/bin/cat', 12:15:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:47 INFO - 'PWD': '/builds/slave/test', 12:15:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:47 INFO - 'SHELL': '/bin/bash', 12:15:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:15:47 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:15:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:47 INFO - 'USER': 'cltbld', 12:15:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:47 INFO - 'XPC_FLAGS': '0x0', 12:15:47 INFO - 'XPC_SERVICE_NAME': '0', 12:15:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:15: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 12:15: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 12:15:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15: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 12:15: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 12:15:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:15:50 INFO - Installing collected packages: mozsystemmonitor 12:15:50 INFO - Running setup.py install for mozsystemmonitor 12:15:50 INFO - Successfully installed mozsystemmonitor 12:15:50 INFO - Cleaning up... 12:15:50 INFO - Return code: 0 12:15:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:50 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:15:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:15:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:50 INFO - 'HOME': '/Users/cltbld', 12:15:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:50 INFO - 'LOGNAME': 'cltbld', 12:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:50 INFO - 'MOZ_NO_REMOTE': '1', 12:15:50 INFO - 'NO_EM_RESTART': '1', 12:15:50 INFO - 'PAGER': '/bin/cat', 12:15:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:50 INFO - 'PWD': '/builds/slave/test', 12:15:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:50 INFO - 'SHELL': '/bin/bash', 12:15:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:15:50 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:15:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:50 INFO - 'USER': 'cltbld', 12:15:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:50 INFO - 'XPC_FLAGS': '0x0', 12:15:50 INFO - 'XPC_SERVICE_NAME': '0', 12:15:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:50 INFO - Downloading/unpacking jsonschema==2.5.1 12:15:50 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 12:15:50 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 12:15:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:50 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 12:15:50 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 12:15:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:15:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:15:53 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 12:15:53 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 12:15:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:53 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 12:15:53 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 12:15:53 INFO - Downloading functools32-3.2.3-2.tar.gz 12:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:15:53 INFO - warning: no files found matching '*.txt' 12:15:53 INFO - no previously-included directories found matching 'build' 12:15:53 INFO - no previously-included directories found matching 'dist' 12:15:53 INFO - no previously-included directories found matching '.git*' 12:15:53 INFO - Installing collected packages: jsonschema, functools32 12:15:54 INFO - Running setup.py install for functools32 12:15:54 INFO - warning: no files found matching '*.txt' 12:15:54 INFO - no previously-included directories found matching 'build' 12:15:54 INFO - no previously-included directories found matching 'dist' 12:15:54 INFO - no previously-included directories found matching '.git*' 12:15:54 INFO - Successfully installed jsonschema functools32 12:15:54 INFO - Cleaning up... 12:15:54 INFO - Return code: 0 12:15:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:54 INFO - 'HOME': '/Users/cltbld', 12:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:54 INFO - 'LOGNAME': 'cltbld', 12:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:54 INFO - 'MOZ_NO_REMOTE': '1', 12:15:54 INFO - 'NO_EM_RESTART': '1', 12:15:54 INFO - 'PAGER': '/bin/cat', 12:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:54 INFO - 'PWD': '/builds/slave/test', 12:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:54 INFO - 'SHELL': '/bin/bash', 12:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:15:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:54 INFO - 'USER': 'cltbld', 12:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:54 INFO - 'XPC_FLAGS': '0x0', 12:15:54 INFO - 'XPC_SERVICE_NAME': '0', 12:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:15:54 INFO - Cleaning up... 12:15:54 INFO - Return code: 0 12:15:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:54 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:15:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:15:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:54 INFO - 'HOME': '/Users/cltbld', 12:15:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:54 INFO - 'LOGNAME': 'cltbld', 12:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:54 INFO - 'MOZ_NO_REMOTE': '1', 12:15:54 INFO - 'NO_EM_RESTART': '1', 12:15:54 INFO - 'PAGER': '/bin/cat', 12:15:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:54 INFO - 'PWD': '/builds/slave/test', 12:15:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:54 INFO - 'SHELL': '/bin/bash', 12:15:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:15:54 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:15:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:54 INFO - 'USER': 'cltbld', 12:15:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:54 INFO - 'XPC_FLAGS': '0x0', 12:15:54 INFO - 'XPC_SERVICE_NAME': '0', 12:15:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:54 INFO - Downloading/unpacking blobuploader==1.2.4 12:15: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 12:15: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 12:15:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15: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 12:15: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 12:15:57 INFO - Downloading blobuploader-1.2.4.tar.gz 12:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:15:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:15:57 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 12:15:57 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 12:15:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:57 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 12:15:57 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 12:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:15:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:15:58 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 12:15:58 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 12:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:15:58 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 12:15:58 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 12:15:58 INFO - Downloading docopt-0.6.1.tar.gz 12:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:15:58 INFO - Installing collected packages: blobuploader, requests, docopt 12:15:58 INFO - Running setup.py install for blobuploader 12:15:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:15:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:15:58 INFO - Running setup.py install for requests 12:15:59 INFO - Running setup.py install for docopt 12:15:59 INFO - Successfully installed blobuploader requests docopt 12:15:59 INFO - Cleaning up... 12:15:59 INFO - Return code: 0 12:15:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:15:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:15:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:15:59 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:15:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:15:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:15:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:15:59 INFO - 'HOME': '/Users/cltbld', 12:15:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:15:59 INFO - 'LOGNAME': 'cltbld', 12:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:15:59 INFO - 'MOZ_NO_REMOTE': '1', 12:15:59 INFO - 'NO_EM_RESTART': '1', 12:15:59 INFO - 'PAGER': '/bin/cat', 12:15:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:15:59 INFO - 'PWD': '/builds/slave/test', 12:15:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:15:59 INFO - 'SHELL': '/bin/bash', 12:15:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:15:59 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:15:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:15:59 INFO - 'USER': 'cltbld', 12:15:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:15:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:15:59 INFO - 'XPC_FLAGS': '0x0', 12:15:59 INFO - 'XPC_SERVICE_NAME': '0', 12:15:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:15:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-J6KgjO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:15:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-wuKYQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:15:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-jwj4XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:15:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:15:59 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-i4sFQh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-gP6_WQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-MH4Hqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-vI3EL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-WSmVVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-4GBCut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-nQHMOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-7RXnOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-37WxLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:00 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-vNE4Pk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-elTrU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-uIdZnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-mCmh0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:01 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-0gjKmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:01 INFO - Running setup.py install for manifestparser 12:16:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:01 INFO - Running setup.py install for mozcrash 12:16:01 INFO - Running setup.py install for mozdebug 12:16:01 INFO - Running setup.py install for mozdevice 12:16:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Running setup.py install for mozfile 12:16:02 INFO - Running setup.py install for mozhttpd 12:16:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Running setup.py install for mozinfo 12:16:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Running setup.py install for mozInstall 12:16:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Running setup.py install for mozleak 12:16:02 INFO - Running setup.py install for mozlog 12:16:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:02 INFO - Running setup.py install for moznetwork 12:16:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Running setup.py install for mozprocess 12:16:03 INFO - Running setup.py install for mozprofile 12:16:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Running setup.py install for mozrunner 12:16:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Running setup.py install for mozscreenshot 12:16:03 INFO - Running setup.py install for moztest 12:16:03 INFO - Running setup.py install for mozversion 12:16:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:03 INFO - Cleaning up... 12:16:03 INFO - Return code: 0 12:16:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:16:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:16:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:16:03 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:16:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:03 INFO - 'HOME': '/Users/cltbld', 12:16:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:03 INFO - 'LOGNAME': 'cltbld', 12:16:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:03 INFO - 'MOZ_NO_REMOTE': '1', 12:16:03 INFO - 'NO_EM_RESTART': '1', 12:16:03 INFO - 'PAGER': '/bin/cat', 12:16:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:03 INFO - 'PWD': '/builds/slave/test', 12:16:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:03 INFO - 'SHELL': '/bin/bash', 12:16:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:16:03 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:16:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:03 INFO - 'USER': 'cltbld', 12:16:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:03 INFO - 'XPC_FLAGS': '0x0', 12:16:03 INFO - 'XPC_SERVICE_NAME': '0', 12:16:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-z7aIT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:04 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)) 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ew30Wa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Xvm8eZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:04 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)) 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-aG8XKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-peoOyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:04 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)) 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CIVa2u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:04 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)) 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-scMo6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 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)) 12:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:04 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-US4I7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-H4iJo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:05 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-5AhI7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-ULzQud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:05 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Brwhh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-Wbc8MW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:05 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-AdeNFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-CP7kbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:05 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-VWXeR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 12:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:05 INFO - Running setup.py (path:/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/pip-pYob_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:06 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)) 12:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:06 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)) 12:16:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:06 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:06 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 12:16:06 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 12:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:06 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 12:16:06 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 12:16:08 INFO - Downloading blessings-1.6.tar.gz 12:16:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:08 INFO - Installing collected packages: blessings 12:16:08 INFO - Running setup.py install for blessings 12:16:08 INFO - Successfully installed blessings 12:16:08 INFO - Cleaning up... 12:16:08 INFO - Return code: 0 12:16:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:09 INFO - Reading from file tmpfile_stdout 12:16:09 INFO - Current package versions: 12:16:09 INFO - blessings == 1.6 12:16:09 INFO - blobuploader == 1.2.4 12:16:09 INFO - docopt == 0.6.1 12:16:09 INFO - functools32 == 3.2.3-2 12:16:09 INFO - jsonschema == 2.5.1 12:16:09 INFO - manifestparser == 1.1 12:16:09 INFO - mozInstall == 1.12 12:16:09 INFO - mozcrash == 0.17 12:16:09 INFO - mozdebug == 0.1 12:16:09 INFO - mozdevice == 0.48 12:16:09 INFO - mozfile == 1.2 12:16:09 INFO - mozhttpd == 0.7 12:16:09 INFO - mozinfo == 0.9 12:16:09 INFO - mozleak == 0.1 12:16:09 INFO - mozlog == 3.4 12:16:09 INFO - moznetwork == 0.27 12:16:09 INFO - mozprocess == 0.23 12:16:09 INFO - mozprofile == 0.28 12:16:09 INFO - mozrunner == 6.12 12:16:09 INFO - mozscreenshot == 0.1 12:16:09 INFO - mozsystemmonitor == 0.3 12:16:09 INFO - moztest == 0.7 12:16:09 INFO - mozversion == 1.4 12:16:09 INFO - psutil == 3.1.1 12:16:09 INFO - requests == 1.2.3 12:16:09 INFO - wsgiref == 0.1.2 12:16:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:16:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 12:16:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:09 INFO - 'HOME': '/Users/cltbld', 12:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:09 INFO - 'LOGNAME': 'cltbld', 12:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:09 INFO - 'MOZ_NO_REMOTE': '1', 12:16:09 INFO - 'NO_EM_RESTART': '1', 12:16:09 INFO - 'PAGER': '/bin/cat', 12:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:09 INFO - 'PWD': '/builds/slave/test', 12:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:09 INFO - 'SHELL': '/bin/bash', 12:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:16:09 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:09 INFO - 'USER': 'cltbld', 12:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:09 INFO - 'XPC_FLAGS': '0x0', 12:16:09 INFO - 'XPC_SERVICE_NAME': '0', 12:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 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)) 12:16:09 INFO - Cleaning up... 12:16:09 INFO - Return code: 0 12:16:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:09 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x108f9d490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108f13570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda71498cd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:16:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:16:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:09 INFO - 'HOME': '/Users/cltbld', 12:16:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:09 INFO - 'LOGNAME': 'cltbld', 12:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:09 INFO - 'MOZ_NO_REMOTE': '1', 12:16:09 INFO - 'NO_EM_RESTART': '1', 12:16:09 INFO - 'PAGER': '/bin/cat', 12:16:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:09 INFO - 'PWD': '/builds/slave/test', 12:16:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:09 INFO - 'SHELL': '/bin/bash', 12:16:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:16:09 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:16:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:09 INFO - 'USER': 'cltbld', 12:16:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:09 INFO - 'XPC_FLAGS': '0x0', 12:16:09 INFO - 'XPC_SERVICE_NAME': '0', 12:16:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:16:09 INFO - Cleaning up... 12:16:09 INFO - Return code: 0 12:16:09 INFO - Running post-action listener: _resource_record_post_action 12:16:09 INFO - Running post-action listener: _start_resource_monitoring 12:16:09 INFO - Starting resource monitoring. 12:16:09 INFO - [mozharness: 2016-11-07 20:16:09.730042Z] Finished create-virtualenv step (success) 12:16:09 INFO - [mozharness: 2016-11-07 20:16:09.731018Z] Running install step. 12:16:09 INFO - Running pre-action listener: _resource_record_pre_action 12:16:09 INFO - Running main action method: install 12:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:09 INFO - Reading from file tmpfile_stdout 12:16:09 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:10 INFO - Reading from file tmpfile_stdout 12:16:10 INFO - Output received: 12:16:10 INFO - Usage: mozinstall [options] installer 12:16:10 INFO - Options: 12:16:10 INFO - -h, --help show this help message and exit 12:16:10 INFO - -d DEST, --destination=DEST 12:16:10 INFO - Directory to install application into. [default: 12:16:10 INFO - "/builds/slave/test"] 12:16:10 INFO - --app=APP Application being installed. [default: firefox] 12:16:10 INFO - mkdir: /builds/slave/test/build/application 12:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 12:16:42 INFO - Reading from file tmpfile_stdout 12:16:42 INFO - Output received: 12:16:42 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 12:16:42 INFO - Running post-action listener: _resource_record_post_action 12:16:42 INFO - [mozharness: 2016-11-07 20:16:42.953259Z] Finished install step (success) 12:16:42 INFO - [mozharness: 2016-11-07 20:16:42.953420Z] Running run-tests step. 12:16:42 INFO - Running pre-action listener: _resource_record_pre_action 12:16:42 INFO - Running main action method: run_tests 12:16:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:16:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:16:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:16:42 INFO - 2016-11-07 12:16:42.968 screenresolution[1647:8856] starting screenresolution argv=screenresolution get 12:16:42 INFO - 2016-11-07 12:16:42.970 screenresolution[1647:8856] Display 0: 1600x1200x32@60 12:16:42 INFO - 2016-11-07 12:16:42.976 screenresolution[1648:8858] starting screenresolution argv=screenresolution list 12:16:42 INFO - Available Modes on Display 0 12:16:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:16:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:16:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:16:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:16:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:16:43 INFO - Intel Iris: 12:16:43 INFO - Chipset Model: Intel Iris 12:16:43 INFO - Type: GPU 12:16:43 INFO - Bus: Built-In 12:16:43 INFO - VRAM (Dynamic, Max): 1536 MB 12:16:43 INFO - Vendor: Intel (0x8086) 12:16:43 INFO - Device ID: 0x0a2e 12:16:43 INFO - Revision ID: 0x0009 12:16:43 INFO - Displays: 12:16:43 INFO - Display: 12:16:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:16:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:16:43 INFO - Display Serial Number: 1600x1200 60 12:16:43 INFO - Main Display: Yes 12:16:43 INFO - Mirror: Off 12:16:43 INFO - Online: Yes 12:16:43 INFO - Rotation: Supported 12:16:43 INFO - Return code: 0 12:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:43 INFO - Python 2.7.3 12:16:43 INFO - Return code: 0 12:16:43 INFO - grabbing minidump binary from tooltool 12:16:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 12:16:43 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/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 0x108db1d30>, '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 0x108c17db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x108da9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:43 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:16:43 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:16:43 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:16:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:43 INFO - Return code: 0 12:16:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:16:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:16:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 12:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0312 --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 12:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DUWBYSgAYI/Render', 12:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:16:43 INFO - 'HOME': '/Users/cltbld', 12:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:16:43 INFO - 'LOGNAME': 'cltbld', 12:16:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:43 INFO - 'MOZ_NO_REMOTE': '1', 12:16:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:43 INFO - 'NO_EM_RESTART': '1', 12:16:43 INFO - 'PAGER': '/bin/cat', 12:16:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:43 INFO - 'PWD': '/builds/slave/test', 12:16:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:16:43 INFO - 'SHELL': '/bin/bash', 12:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners', 12:16:43 INFO - 'TMPDIR': '/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/', 12:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:16:43 INFO - 'USER': 'cltbld', 12:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:43 INFO - 'XPC_FLAGS': '0x0', 12:16:43 INFO - 'XPC_SERVICE_NAME': '0', 12:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:16:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0312', '--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 12:16:43 INFO - mozversion application_buildid: 20161107100027 12:16:43 INFO - mozversion application_changeset: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 12:16:43 INFO - mozversion application_display_name: FirefoxDeveloperEdition 12:16:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:43 INFO - mozversion application_name: Firefox 12:16:43 INFO - mozversion application_remotingname: firefox-dev 12:16:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:43 INFO - mozversion application_vendor: Mozilla 12:16:43 INFO - mozversion application_version: 51.0a2 12:16:43 INFO - mozversion platform_buildid: 20161107100027 12:16:43 INFO - mozversion platform_changeset: a1243da2fec4f351fa1fc5a2314f704f670fd8e8 12:16:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 12:16:43 INFO - mozversion platform_version: 51.0a2 12:16:43 INFO - using testdate: 1478549803 12:16:43 INFO - actual date: 1478549803 12:16:43 INFO - starting webserver on 'localhost:49278' 12:16:43 INFO - SUITE-START | Running 2 tests 12:16:43 INFO - TEST-START | dromaeo_css 12:16:43 INFO - operating with platform_type : mac_ 12:16:43 INFO - Initialising browser for dromaeo_css test... 12:16:43 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpl92_5x/profile http://localhost:49278/getInfo.html) 12:16:46 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 12:16:46 INFO - PROCESS | 1658 | colorDepth:24 12:16:46 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 12:16:46 INFO - PROCESS | 1658 | __metrics 12:16:46 ERROR - PROCESS | 1658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 12:16:46 INFO - TEST-INFO | 1658: exit 0 12:16:46 INFO - Browser initialized. 12:16:46 INFO - Running cycle 1/1 for dromaeo_css test... 12:16:46 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpl92_5x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:16:59 INFO - PROCESS | 1662 | RSS: Main: 225366016 12:16:59 INFO - PROCESS | 1662 | 12:17:48 INFO - PROCESS | 1662 | 1478549868853 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:20:01 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 12:20:02 INFO - PROCESS | 1662 | RSS: Main: 237215744 12:20:02 INFO - PROCESS | 1662 | 12:23:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 12:23:05 INFO - PROCESS | 1662 | RSS: Main: 247222272 12:23:05 INFO - PROCESS | 1662 | 12:26:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 12:26:08 INFO - PROCESS | 1662 | RSS: Main: 251789312 12:26:08 INFO - PROCESS | 1662 | 12:29:10 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 12:29:10 INFO - PROCESS | 1662 | RSS: Main: 253087744 12:29:10 INFO - PROCESS | 1662 | 12:32:13 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 12:32:14 INFO - PROCESS | 1662 | RSS: Main: 258174976 12:32:14 INFO - PROCESS | 1662 | 12:35:16 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 12:35:17 INFO - PROCESS | 1662 | RSS: Main: 259940352 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | __start_tp_report 12:35:17 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 12:35:17 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 12:35:17 INFO - PROCESS | 1662 | |i|pagename|runs| 12:35:17 INFO - PROCESS | 1662 | |0;dojo.html;3112.9844350778244;3462.2902305027474;3466.58400991881;3474.965250347497;3504.0363899927534;5906.852328691785;5933.050711886099;5964.612300200495;5969.940300596998;5976.611520251192;5937.287525496947;5995.580309378345;6043.00290452076;6044.879102417949;6047.092936059593;5336.786528538863;5375.220593014011;5421.159720243349;5454.53636440903;5467.7424192435765;5421.674699518022;5427.674339539621;5446.537044351235;5446.564274858021;5448;5321.574274058066;5344.652597581145;5431.972840135813;5432.75552600134;5492.890142197154;5363.9463605363835;5365.03429382711;5375.274337964363;5393.59548033897;5435.782568697247;5297.735113244323;5326.893462130735;5361.008213480519;5396.865078373072;5416.4312747161375;5758.3665796762325;5937.495312898409;5959.612625179349;5983.760649574012;6017.458428741435;4727.787249573777;5075.619328550337;5614.410486898858;6162.137300777895;6252.468540174091;6270.153529273535;6277.811665650038;6360.459360954324;6363.7454501819875;6376.936230637727;6029.788957386558;6058.485028772559;6073.5748497604745;6079.05774604937;6100.481459075984;5490.258815059996;5721.256236689203;6422.357764223634;6485.221773387129;6540.0189971503705;6254;6257.624542527463;6260.342664020303;6266.216722909637;6271.717772700239;6209.751609935643;6211.472024877936;6280.623162610258;6368.808935731936;6391.520635952229;5310.8141215057285;5972.835297117021;6246.812595622138;6267.871783079089;6275.466585340298;5556.499915007588;6263.655498947511;6272.18461599989;6274.309825919146;6288.213973253343;4970.329005584272;5029.497050294941;5050;5072.391313042459;5084.034033533617;3821.9426708599394;4421.801018954155;4423.380726698265;4440.4227450431235;4497.572730590588;5802.709864506758;5844.211031510692;5849.94150058494;5857.26784151981;5878.853028674232;6223.222097237845;6255.311915689271;6288.779892703734;6292.276388215414;6294.118823364733;5947.732352044169;6038.607490513103;6094.664793436404;6105.511559075263;6115.51416190291;5510.9448905511235;5526.696031718214;5589.692566908859;5595.888082238333;5599.888002239933;6525.2169739631545;6554.901676474857;6554.9672251639395;6579.046038324512;6591.736330546724;6184.81445556634;6227.408396202353;6227.501799856092;6260.248770147611;6278.340774218641;5555.833325000256;6514.57655252407;6526.9020964686515;6573.5398522103;6574.638394888327;5305.708186049805;6304.810855674337;6319.494440444661;6331.810045698637;6334.8733025338315;6069.2110025696375;6221;6270.435660790551;6287.905681414691;6370.267419246846;6068.241469816273;6252.249730032425;6255.218097737783;6278.058291256348;6296.496280297657;6183.443490085914;6266.717997690023;6274.996000639876;6276.058591211355;6280.340564240872;6032.245969253843;6079.848003799941;6125.173101631222;6234.688265586612;6242.063690446469;6106.551676171979;6116.480099191618;6136.171616831849;6195.752169913153;6198.0702894566175;5981.431763982415;6011.458968692838;6025.276966764016;6028.4272994065495;6056.57603967718 12:35:17 INFO - PROCESS | 1662 | |1;ext.html;477.54394553201695;480.5842945851837;489.93385892904445;496.23331952133947;497.4900726755078;39835;41724.37413438801;41779.58220417799;41930;41953.37069943946;43207.3518897216;43666.78166609162;43731.12537749251;43754.68735937919;43771;8423.747287581382;9770.85343719843;9937.701868943943;9941.453220072894;9944.6519371822;8355.456895301817;9819.116279534841;9904.306698531105;9924.90075099247;9934;9559.757231559888;9919.652812151577;9955.452450115241;9964.750881227956;9966.601335946554;8426.620802063891;8919.821603567925;9903;9934.503274836301;9945.453000084992;9817.361871478332;9878.802423951553;9915.405075695482;9919.603215871357;9926.95766944475;41607.37588936168;41793;41942.58057419417;42073.94815129616;42075.36886946698;3397.5073614325784;3419.81191034493;3527.0829584308008;3572.964270357289;4038.757674539537;29978.400431991457;30802.845985770153;31723.52414713781;31890.521642175387;32213.838930805432;3195.6005499312587;3239.1254361322544;3280.96719032809;3290.7860989035876;3355.2450698592866;452131.73934130446;535851;537592;537825;538278;33559.32881342409;62090;62534;62748.68625656843;62835.371646283864;33671.4949275761;34519.4822077669;35616.28767424689;35663.82168089143;35699;15328.386864525517;15457.227138643022;15519.379224831106;15519.5344139676;15530.9223453882;12768.680782980315;13118.147320424141;13122.212667239995;13168;13183.736325273441;7520.6239688015385;7781.844363112706;7826.334761545332;7829.843403132019;7838.059432868093;3076.7077127672837;3204.086835251942;3272.443684573628;3278.5901762279714;3299.290652509722;913.5204017890661;949.586929685589;959.1990687775645;1025.29254814178;1106.7620461600795;28900.855495722386;29499.55750663699;30474.085777426713;30952;31009.844950775103;874.9737507874773;889.7286327670123;993.3592832622918;1045.1951996962296;1077.369738702852;15651.295691693902;16116.919415402848;16187;16275.91862040706;16306.67386652284;713578;725222;728789;729432;729767;59052.81894362174;59477.70261148667;59549.70225148933;59692.70153649204;59708.70145649244;1371.3417559571462;1371.6502291915697;1394.714083612857;1405.8594140586065;1407.1627381707663;26095.73904260933;27420.314492137855;28150.71849281481;30711.385772284877;31153.376932461677;51641.967160655826;56630.433695664164;58448;58539.414605853395;60697;544700;546992;550198;551755;553173;44316.778416107714;44341.66974990755;44378.55621443744;44924.55075449204;44936.55063449324;40829.18341633091;41279.1744165109;45685.77157114193;50176.749116254185;50563;39991.600083999954;40468.59531404766;40548.594514055665;40644.1871162581;41773.74678759642;40016.59983400129;40316.7984160089;41205.793971029954;41247.175056499305;41465.96335091647;39059.41410878782;39576;39616.60383396129;39826.60173398345;41591.16817663569;32315.51526727148;34695.13262168466;35255.64744352524;35368.292634147685;35461.64538354584;21944.45138871477;25641.23076307714;25891;25943.74056259489;26316.342091447103 12:35:17 INFO - PROCESS | 1662 | |2;jquery.html;318.16799070430824;369.2246282806106;372.41902631894254;377.13635774077363;396.05145676105707;19473.805261947375;19983.20067197312;20575.074121664522;21112.83879386631;21375.57248855022;19925.40223793285;20327.28854490093;20382.592348153026;20811;20842.270520531783;5341.278927344817;5810.535157187425;5928.822135335925;5982.4316689914385;6082.300535438415;5875.500582450497;5964.522838172958;5967.671778052206;5973.074173503114;5978.312494063173;5673.290838645169;5873.647581145124;5927.555433342495;5933.821985340447;5971.761129554812;5898.997170481007;5932.644041357489;5937.67342796146;5938.079597662348;5975.462208401243;5029.974850125763;5075;5208.843734687927;5210.348706411699;5223.817166399158;23207.88396058009;24725.50548989028;24772.876135619386;24994.625080623806;25043.49913001748;2425.0784701813373;2508.5610018246916;2901.9274518137217;3066.3100802319523;3150.5116706910467;14604;14904.031237969497;15189.696206075927;15424.22878856064;15830.28763705636;1824.9780123131088;1844.6679597672414;1862.7671541057368;1915.3104882242383;1920.3566805120302;72778.9083163753;84433.88915277105;90967;107761.46119269353;111239.44380278127;10437.739056523647;10639.627613033506;10848.837267440995;10908.672739817817;11077.612283570197;13365.799513007312;13479.86520134786;13480.730385392433;13500.729985400238;13512.864871351358;7248.637568121573;8521.403501754818;8761.693340733043;8769.912300877037;8860.556972151368;8827.205551500267;8958.910410895938;8966.68616598416;9027.819443611223;9152.725418237464;5575.4424557544735;6574.441172500391;6588.374104460068;6675.165604299463;6688.130543029375;1819.9636007280046;1846.5568263616635;1857.1178690122083;1864.4127099963468;1872.1201035513286;877.9780505487414;899.1053901368181;926.36081104038;1002.1081237698309;1078.1751959750798;20867.269645562334;21574.676379854314;21789.891050544647;21872.343829685135;21896.671549926763;920.8894932607996;962.8411312133419;967.4292167621137;976.8876579193342;1009.8485227215976;10951.83572246417;11410.144239182095;11433.371164585862;11510.654680359603;11534.538618455335;623053.8847305734;625172;654915;660277;668044;108369;138813;143130.28434857758;145458;150947;1000.7147962830559;1021.8211812932707;1072.6084978982772;1074.7796701676139;1077.6389909380289;15065;18812.811871881655;19123.617527649647;19152.712709309093;19188.328408505637;56625;57172.71413642905;57847;58721;59271.703641481516;76977;81434;82121.58939205266;82891;83214.33571328661;7953.952371721204;7963.562004089831;8079.474834135763;8272.17278272168;8313.875291870505;11174.88825111771;12656.746865062463;12713.80929286043;12870.871291286967;12987.480500779862;9060.773480663036;10611.787764244826;10727.570897164025;11017.394043327695;11090.001899829054;10735.355878647306;10868.239223254297;10947;11074.169437292074;11081.778364432828;10472.790544189225;11155.49800258974;11193.888061119611;11344.149188811038;11589.478473468882;7641;7684.193159718373;7722.18917013728;7997.680092796456;8064.35485161174;7536.773896783106;10354.430506322225;10904;11048.558057677603;11225 12:35:17 INFO - PROCESS | 1662 | |3;mootools.html;1432.7779194224895;1504.9398024079037;1716.0990479998;1856;1860.6929856573665;7075.46933979951;8044.879326810103;8453.704120355782;9074.001859795417;9086.818263634723;8517.914820851789;8816.986046604643;8826.293896488281;8932.33007524435;8944.105589441053;2361.1263832382;2412.2883749293915;2412.8190385721055;2414.1791790791126;2421.467277199022;2388.7133543974746;2388.9761102389016;2416.395901024744;2420.6490058941445;2425.19968410425;2399.940001499968;2410.3974006498374;2411.2043025801445;2416.3838221253645;2416.7220769611545;1855.415544103603;2118.1633254864396;2147.807966578548;2336.287432333146;2384.630382290739;1924.7978962208906;2385.3798012516695;2389.044382247115;2392.12687369109;2394.0902457066204;8555.529445880475;8873.689420870238;8944.150305720947;8956.955215223883;8960.059193784624;4653.86038418848;5252.501012403815;5375.682957675394;5384.91922621161;5395.5953303502;3037.559553864677;3503.4569641705575;3627.3289441453153;3718.888433347004;3726.087108658396;926.2543652359848;1066.3388699006666;1112.1547623805966;1122.4948773052079;1131.298594871185;11814;11855.288682679067;11904.880951190464;11923.94038029813;11927.940360298144;4644.628429725613;4723.45680246776;4844.685095468783;4845.176320025604;4865.9026819463415;8819.735407937773;9326.487043212688;10206.336588121896;10221.540030698488;10239.027292407209;5345.812896548602;5346.705931173823;5373.9731301343245;5378.1663842104535;5381.7578208980685;4404.691671583022;4514.34541991416;4551.408316918845;4917.631177661689;4924.285978533093;3397.8810741623925;3996.780177090288;4086.734362266443;4114.0948991221885;4122.876313710593;1309.4369421148806;1319.0502837956656;1320.465211589308;1328.0703507544565;1331.5339631129027;768.2125821033374;869.7129947117436;888.4846788862444;921.8110287391069;939.6664184214642;5751.252337196138;5790.189373487715;5959.4934430573885;6149.354317796657;6152.384761523901;892.9374943754004;954.2938225712923;971.5093877591771;979.8922118566952;992.7468495533593;3857.6528112470014;3899.805009749558;3932.4887764590994;4008.238434697398;4115.279826030433;10460.52927618259;10919.563217471372;10932.890671093346;10935.398553079656;10944.015038646401;9540.33217674756;10557.41638754193;10884.40135792539;10889.782204355868;10895.182861285277;6912.930870691229;7433.256674332523;8213.425060245845;8350.70772522971;8379.37154713399;4293.0984493256765;5819.185314056121;5966.791162309299;5995.220621319375;5998.25021872266;9937.801243975224;9969.800603987735;10042.598296068367;10173.033561811617;10195.949020254851;9861.852072219066;9932.602695892083;10178.236632252463;10480.842787358044;10549.630762923261;6639.933600663931;6856.211535673461;6986.54587451814;7127.287271273039;7252.601106938958;6669.699863506057;8307.460015098999;8482.618282177193;8584.442011269248;8612.440191387539;6809.285025072296;7681.270279323679;7712.8457430852195;7731.6520756567215;7759;7374.483786134919;7466.514676546007;7475.0656167979005;7603.239676032353;7606.391488681003;7074;7179.641017949186;7184.856302873809;7189.964050179716;7192.280771922975;4896.069746748107;4921.581665558468;4973.801047958186;4993.550580447777;5094.312267843942;5064.974675126601;5069.138246498178;5155.252488389237;5167.689938603696;5169.431362550041 12:35:17 INFO - PROCESS | 1662 | |4;prototype.html;266.969298530669;298.4597877841108;307.82300177397997;311.4254200999157;313.20133659169113;4694.967107236411;4947.356843610326;5522.834314970552;5557.944420555793;5611.859703507414;4443.711158774678;4921.680090794096;5314.362276526813;5397.649152805065;5415.323084614423;3536.080619039049;4125.97937010316;4184.8535301264465;4194.412782210493;4218.599233072869;3884.4173373993845;3990.422984836387;4192.664586833062;4199.249491583018;4209.621563816449;3421.589409270891;4145.440365550658;4169.812358443862;4178.6448151907125;4179.763826352902;3928.096537796323;4157.812898419564;4163.97918010411;4169.3954376615375;4173.3114036184;3429.936719616902;3627.4014787560022;3630.4009838376637;3631.2011357501306;3650.1239702471216;4526.864194074183;4959.7768100435205;5197.506236907526;5298.748032086348;5308.601854860863;4098.729393887875;4690.038542098861;4791.736454495001;4793.784279707422;4819.759012049419;5414.810481633124;5768.278965129359;5801.970990145022;5825.689219925525;5896.6437719324795;3091.9690803091908;3292.308615190813;3856.3444214483607;3982.6216509431556;4020.7386519876113;5957.6127551709;5991.221141251609;6001.609895356788;6021.1269365942135;6067.575269731121;3392.762506624562;3731.8880433587037;3736.9723326085;4019.748940593277;4070.1656160487028;3894.3768996960353;4079.4288799568085;4129.855455059059;4133.81397837098;4146.714518499275;4741.525847415231;4770.332153498513;4778.546038126373;4793.664443488992;4798.352222449995;5401.541583772359;5467.753951072212;5829.387914269026;5869.647821130746;5879.970600146972;1296.8962483001337;1302.9413676384586;1328.6779654243896;1376.064276292111;1382.9377678004514;926.1525703980917;941.5010044676333;946.8579713043099;953.4851180362526;962.9855552166723;5411.431799661058;5414;5414.35027796667;5420.671935375858;5437.13005919051;4776.355192049029;5438.3473983121485;5895.94104058954;5918.171455996164;5939.316978547436;5184.429712731597;5222.150355739107;5294.743732604421;5328.946710532845;5363.410024897258;2465.4452748131525;2583.509133264674;2590.3394634368115;2632.6182703507884;2634.868256587163;4158.480189976253;4432.335149727567;4857.138574833016;5093.719845408464;5149;4572.3827283317;4972.975135124374;5029.371328583927;5054.898902022012;5099.36257967754;4531.3882625845745;4713.670043097019;5116.641835071509;5193.376794784499;5207.661502002434;4614.630829533562;4941.184704523714;4977.900441991213;5009.699418034929;5040.4455509894615;4159.313713237282;4517.209488339593;4849.636277279147;5755.338136114233;5895.29256489224;4904.337914381513;6124.29570599369;6185.4536365908525;6259.649543567177;6270;3511.3328467591077;3846.8845934622004;3915.5301363835383;3969.7022723296445;3979.2240513100824;5693.953734751888;5699.748599303169;5861.413858614104;6015.57890947647;6116.204893363834;4752.3584316116885;4848.466668666514;5217.165253559412;5258.842234732964;5903.822885313448;5313.309269794902;5854.590178687451;5867.823965280878;5905.881882362242;5920.674362910081;4649.883752906205;4775.379200703886;5045.924311135409;5109.948900510947;5696.487316141567;5704.657720536781;5770.874679437469;5800.1589769484035;5847.26909136358;5894.11388355722;4752.287156926489;4991.9500804991485;5721.113227449752;5724.771009159587;5741.196232527533 12:35:17 INFO - PROCESS | 1662 | |5;yui.html;682.0928165539832;733.5012191709635;778.5717855179649;787.4566549081134;807.3904202327244;15120.24398780062;15847.128407937587;15891.761623575656;15901.443449479271;15922.920385398085;14151.716965660706;14164.929175354135;14169.71660566788;14185.78721319181;14225.857741422582;656.2190992718673;680.251723104586;817.284875733733;817.6320655704942;839.9874001889976;858.0647094666812;858.0775666158873;858.3948316436897;859.2653281444369;859.6303589456531;908.1690253418114;911.0297533127198;912.6668765900432;913.2511340700628;913.2648218184358;879.9252063574539;898;904.3082042237694;905.5789058087988;910.008091180613;657.4937298280345;665.0456594786449;673.0442771264816;676.6075676107846;677.5088061155672;14437.422503099864;14619.926900365537;15022.399104035825;15039.172845493493;15053.623659408493;11530.481128349244;12062.879371206263;14658.193799341032;14700.191489468076;14831.629209269746;9663.130318271318;9841.261905357127;11549.94225028878;11982.880171198263;12072.818907716392;3759.0978165240144;3759.6804271636943;3873.7288389812725;3885.9028524286837;4009.3384591542654;122940.38529807383;126406;128554.3572282142;135532.32233838865;135662;9185.908140918506;10954.671359859218;11496.252743571642;11508.251963622337;11532.192746507832;20369.287074952306;23211.883940580527;23391.883040585028;23433.88283058574;23437.41406464818;8012.79968000793;8167.469114507538;8223.465474744122;8374.995000599967;8457.703980360659;4448.844290449819;4495.955040449619;4517;4610.884727881829;4640.69835460694;3640.0171953572917;3658.213484100878;3769.1707824278615;3861.9613803861603;4046.291898917678;703.2475251480969;724.6340597998083;737.133867705444;742.7140550887947;745.7843714745039;550.4028129479559;582.8338923406809;616.6146158650844;661.3089321658878;681.3629256645053;7709.807254818675;9263.490508021989;9326.95336523313;9650.324477286522;9707.271954603433;546.7211722021798;586.2905883880467;611.2237458427771;643.4016364780799;687.2337343861658;4507.774611269423;4680.9297860532115;4749.168895443284;4796.496367881322;4798.95201047985;148223;150856;153161;160408;161990.190049049;127075;132854.00718989223;135672.32163839118;138249;139059;98160.50919745499;111664;117887;120060.39969800095;124126.13810792845;8790.033096359522;9041.23149532297;9139.38756579;9216.755737975287;9252.53737313145;58096.709516452145;63302.36697632965;64147;64378;64808.02787958278;82633;92756.53621731848;101229.49385253027;102250;102267;11634.76730465403;11700.531978720755;11901.76196476083;12022.88932830012;12416;13106.934465327993;13301.334933253493;13427.395767190304;13536.661583460493;13829.239391833546;12378;13294.933525332312;13606.591802245948;14193;14643.341049652578;13522.12106213093;13625.591232263048;13817.170969741848;14283;14740.11559306445;13902.721945561234;14176.645583860485;14408.495702650356;14499.637509062359;14559.854401456274;9187.678431254873;11185;11206.159538034843;11208.27146235492;11889.405529723306;11249.71875703114;11636.88363116358;11815.468303926173;11959.162858599815;11975.461104250155 12:35:17 INFO - PROCESS | 1662 | __end_tp_report 12:35:17 INFO - PROCESS | 1662 | __start_cc_report 12:35:17 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,369 12:35:17 INFO - PROCESS | 1662 | __end_cc_report 12:35:17 INFO - PROCESS | 1662 | __startTimestamp1478550917162__endTimestamp 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | ------- Summary: start ------- 12:35:17 INFO - PROCESS | 1662 | Number of tests: 6 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | [#0] dojo.html Cycles:165 Average:5833.65 Median:6047.09 stddev:656.12 (10.9%) stddev-sans-first:622.45 12:35:17 INFO - PROCESS | 1662 | Values: 3113.0 3462.3 3466.6 3475.0 3504.0 5906.9 5933.1 5964.6 5969.9 5976.6 5937.3 5995.6 6043.0 6044.9 6047.1 5336.8 5375.2 5421.2 5454.5 5467.7 5421.7 5427.7 5446.5 5446.6 5448.0 5321.6 5344.7 5432.0 5432.8 5492.9 5363.9 5365.0 5375.3 5393.6 5435.8 5297.7 5326.9 5361.0 5396.9 5416.4 5758.4 5937.5 5959.6 5983.8 6017.5 4727.8 5075.6 5614.4 6162.1 6252.5 6270.2 6277.8 6360.5 6363.7 6376.9 6029.8 6058.5 6073.6 6079.1 6100.5 5490.3 5721.3 6422.4 6485.2 6540.0 6254.0 6257.6 6260.3 6266.2 6271.7 6209.8 6211.5 6280.6 6368.8 6391.5 5310.8 5972.8 6246.8 6267.9 6275.5 5556.5 6263.7 6272.2 6274.3 6288.2 4970.3 5029.5 5050.0 5072.4 5084.0 3821.9 4421.8 4423.4 4440.4 4497.6 5802.7 5844.2 5849.9 5857.3 5878.9 6223.2 6255.3 6288.8 6292.3 6294.1 5947.7 6038.6 6094.7 6105.5 6115.5 5510.9 5526.7 5589.7 5595.9 5599.9 6525.2 6554.9 6555.0 6579.0 6591.7 6184.8 6227.4 6227.5 6260.2 6278.3 5555.8 6514.6 6526.9 6573.5 6574.6 5305.7 6304.8 6319.5 6331.8 6334.9 6069.2 6221.0 6270.4 6287.9 6370.3 6068.2 6252.2 6255.2 6278.1 6296.5 6183.4 6266.7 6275.0 6276.1 6280.3 6032.2 6079.8 6125.2 6234.7 6242.1 6106.6 6116.5 6136.2 6195.8 6198.1 5981.4 6011.5 6025.3 6028.4 6056.6 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | [#1] ext.html Cycles:180 Average:72415.18 Median:41786.29 stddev:162273.38 (388.3%) stddev-sans-first:162638.72 12:35:17 INFO - PROCESS | 1662 | Values: 477.5 480.6 489.9 496.2 497.5 39835.0 41724.4 41779.6 41930.0 41953.4 43207.4 43666.8 43731.1 43754.7 43771.0 8423.7 9770.9 9937.7 9941.5 9944.7 8355.5 9819.1 9904.3 9924.9 9934.0 9559.8 9919.7 9955.5 9964.8 9966.6 8426.6 8919.8 9903.0 9934.5 9945.5 9817.4 9878.8 9915.4 9919.6 9927.0 41607.4 41793.0 41942.6 42073.9 42075.4 3397.5 3419.8 3527.1 3573.0 4038.8 29978.4 30802.8 31723.5 31890.5 32213.8 3195.6 3239.1 3281.0 3290.8 3355.2 452131.7 535851.0 537592.0 537825.0 538278.0 33559.3 62090.0 62534.0 62748.7 62835.4 33671.5 34519.5 35616.3 35663.8 35699.0 15328.4 15457.2 15519.4 15519.5 15530.9 12768.7 13118.1 13122.2 13168.0 13183.7 7520.6 7781.8 7826.3 7829.8 7838.1 3076.7 3204.1 3272.4 3278.6 3299.3 913.5 949.6 959.2 1025.3 1106.8 28900.9 29499.6 30474.1 30952.0 31009.8 875.0 889.7 993.4 1045.2 1077.4 15651.3 16116.9 16187.0 16275.9 16306.7 713578.0 725222.0 728789.0 729432.0 729767.0 59052.8 59477.7 59549.7 59692.7 59708.7 1371.3 1371.7 1394.7 1405.9 1407.2 26095.7 27420.3 28150.7 30711.4 31153.4 51642.0 56630.4 58448.0 58539.4 60697.0 544700.0 546992.0 550198.0 551755.0 553173.0 44316.8 44341.7 44378.6 44924.6 44936.6 40829.2 41279.2 45685.8 50176.7 50563.0 39991.6 40468.6 40548.6 40644.2 41773.7 40016.6 40316.8 41205.8 41247.2 41466.0 39059.4 39576.0 39616.6 39826.6 41591.2 32315.5 34695.1 35255.6 35368.3 35461.6 21944.5 25641.2 25891.0 25943.7 26316.3 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | [#2] jquery.html Cycles:180 Average:36283.37 Median:24749.19 stddev:107364.79 (433.8%) stddev-sans-first:107632.01 12:35:17 INFO - PROCESS | 1662 | Values: 318.2 369.2 372.4 377.1 396.1 19473.8 19983.2 20575.1 21112.8 21375.6 19925.4 20327.3 20382.6 20811.0 20842.3 5341.3 5810.5 5928.8 5982.4 6082.3 5875.5 5964.5 5967.7 5973.1 5978.3 5673.3 5873.6 5927.6 5933.8 5971.8 5899.0 5932.6 5937.7 5938.1 5975.5 5030.0 5075.0 5208.8 5210.3 5223.8 23207.9 24725.5 24772.9 24994.6 25043.5 2425.1 2508.6 2901.9 3066.3 3150.5 14604.0 14904.0 15189.7 15424.2 15830.3 1825.0 1844.7 1862.8 1915.3 1920.4 72778.9 84433.9 90967.0 107761.5 111239.4 10437.7 10639.6 10848.8 10908.7 11077.6 13365.8 13479.9 13480.7 13500.7 13512.9 7248.6 8521.4 8761.7 8769.9 8860.6 8827.2 8958.9 8966.7 9027.8 9152.7 5575.4 6574.4 6588.4 6675.2 6688.1 1820.0 1846.6 1857.1 1864.4 1872.1 878.0 899.1 926.4 1002.1 1078.2 20867.3 21574.7 21789.9 21872.3 21896.7 920.9 962.8 967.4 976.9 1009.8 10951.8 11410.1 11433.4 11510.7 11534.5 623053.9 625172.0 654915.0 660277.0 668044.0 108369.0 138813.0 143130.3 145458.0 150947.0 1000.7 1021.8 1072.6 1074.8 1077.6 15065.0 18812.8 19123.6 19152.7 19188.3 56625.0 57172.7 57847.0 58721.0 59271.7 76977.0 81434.0 82121.6 82891.0 83214.3 7954.0 7963.6 8079.5 8272.2 8313.9 11174.9 12656.7 12713.8 12870.9 12987.5 9060.8 10611.8 10727.6 11017.4 11090.0 10735.4 10868.2 10947.0 11074.2 11081.8 10472.8 11155.5 11193.9 11344.1 11589.5 7641.0 7684.2 7722.2 7997.7 8064.4 7536.8 10354.4 10904.0 11048.6 11225.0 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | [#3] mootools.html Cycles:180 Average:5700.25 Median:4949.04 stddev:3206.45 (64.8%) stddev-sans-first:3199.41 12:35:17 INFO - PROCESS | 1662 | Values: 1432.8 1504.9 1716.1 1856.0 1860.7 7075.5 8044.9 8453.7 9074.0 9086.8 8517.9 8817.0 8826.3 8932.3 8944.1 2361.1 2412.3 2412.8 2414.2 2421.5 2388.7 2389.0 2416.4 2420.6 2425.2 2399.9 2410.4 2411.2 2416.4 2416.7 1855.4 2118.2 2147.8 2336.3 2384.6 1924.8 2385.4 2389.0 2392.1 2394.1 8555.5 8873.7 8944.2 8957.0 8960.1 4653.9 5252.5 5375.7 5384.9 5395.6 3037.6 3503.5 3627.3 3718.9 3726.1 926.3 1066.3 1112.2 1122.5 1131.3 11814.0 11855.3 11904.9 11923.9 11927.9 4644.6 4723.5 4844.7 4845.2 4865.9 8819.7 9326.5 10206.3 10221.5 10239.0 5345.8 5346.7 5374.0 5378.2 5381.8 4404.7 4514.3 4551.4 4917.6 4924.3 3397.9 3996.8 4086.7 4114.1 4122.9 1309.4 1319.1 1320.5 1328.1 1331.5 768.2 869.7 888.5 921.8 939.7 5751.3 5790.2 5959.5 6149.4 6152.4 892.9 954.3 971.5 979.9 992.7 3857.7 3899.8 3932.5 4008.2 4115.3 10460.5 10919.6 10932.9 10935.4 10944.0 9540.3 10557.4 10884.4 10889.8 10895.2 6912.9 7433.3 8213.4 8350.7 8379.4 4293.1 5819.2 5966.8 5995.2 5998.3 9937.8 9969.8 10042.6 10173.0 10195.9 9861.9 9932.6 10178.2 10480.8 10549.6 6639.9 6856.2 6986.5 7127.3 7252.6 6669.7 8307.5 8482.6 8584.4 8612.4 6809.3 7681.3 7712.8 7731.7 7759.0 7374.5 7466.5 7475.1 7603.2 7606.4 7074.0 7179.6 7184.9 7190.0 7192.3 4896.1 4921.6 4973.8 4993.6 5094.3 5065.0 5069.1 5155.3 5167.7 5169.4 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | [#4] prototype.html Cycles:180 Average:4516.73 Median:4931.43 stddev:1389.72 (28.2%) stddev-sans-first:1356.51 12:35:17 INFO - PROCESS | 1662 | Values: 267.0 298.5 307.8 311.4 313.2 4695.0 4947.4 5522.8 5557.9 5611.9 4443.7 4921.7 5314.4 5397.6 5415.3 3536.1 4126.0 4184.9 4194.4 4218.6 3884.4 3990.4 4192.7 4199.2 4209.6 3421.6 4145.4 4169.8 4178.6 4179.8 3928.1 4157.8 4164.0 4169.4 4173.3 3429.9 3627.4 3630.4 3631.2 3650.1 4526.9 4959.8 5197.5 5298.7 5308.6 4098.7 4690.0 4791.7 4793.8 4819.8 5414.8 5768.3 5802.0 5825.7 5896.6 3092.0 3292.3 3856.3 3982.6 4020.7 5957.6 5991.2 6001.6 6021.1 6067.6 3392.8 3731.9 3737.0 4019.7 4070.2 3894.4 4079.4 4129.9 4133.8 4146.7 4741.5 4770.3 4778.5 4793.7 4798.4 5401.5 5467.8 5829.4 5869.6 5880.0 1296.9 1302.9 1328.7 1376.1 1382.9 926.2 941.5 946.9 953.5 963.0 5411.4 5414.0 5414.4 5420.7 5437.1 4776.4 5438.3 5895.9 5918.2 5939.3 5184.4 5222.2 5294.7 5328.9 5363.4 2465.4 2583.5 2590.3 2632.6 2634.9 4158.5 4432.3 4857.1 5093.7 5149.0 4572.4 4973.0 5029.4 5054.9 5099.4 4531.4 4713.7 5116.6 5193.4 5207.7 4614.6 4941.2 4977.9 5009.7 5040.4 4159.3 4517.2 4849.6 5755.3 5895.3 4904.3 6124.3 6185.5 6259.6 6270.0 3511.3 3846.9 3915.5 3969.7 3979.2 5694.0 5699.7 5861.4 6015.6 6116.2 4752.4 4848.5 5217.2 5258.8 5903.8 5313.3 5854.6 5867.8 5905.9 5920.7 4649.9 4775.4 5045.9 5109.9 5696.5 5704.7 5770.9 5800.2 5847.3 5894.1 4752.3 4992.0 5721.1 5724.8 5741.2 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - PROCESS | 1662 | [#5] yui.html Cycles:180 Average:26002.14 Median:3759.39 stddev:42364.06 (1126.9%) stddev-sans-first:42440.24 12:35:17 INFO - PROCESS | 1662 | Values: 682.1 733.5 778.6 787.5 807.4 15120.2 15847.1 15891.8 15901.4 15922.9 14151.7 14164.9 14169.7 14185.8 14225.9 656.2 680.3 817.3 817.6 840.0 858.1 858.1 858.4 859.3 859.6 908.2 911.0 912.7 913.3 913.3 879.9 898.0 904.3 905.6 910.0 657.5 665.0 673.0 676.6 677.5 14437.4 14619.9 15022.4 15039.2 15053.6 11530.5 12062.9 14658.2 14700.2 14831.6 9663.1 9841.3 11549.9 11982.9 12072.8 3759.1 3759.7 3873.7 3885.9 4009.3 122940.4 126406.0 128554.4 135532.3 135662.0 9185.9 10954.7 11496.3 11508.3 11532.2 20369.3 23211.9 23391.9 23433.9 23437.4 8012.8 8167.5 8223.5 8375.0 8457.7 4448.8 4496.0 4517.0 4610.9 4640.7 3640.0 3658.2 3769.2 3862.0 4046.3 703.2 724.6 737.1 742.7 745.8 550.4 582.8 616.6 661.3 681.4 7709.8 9263.5 9327.0 9650.3 9707.3 546.7 586.3 611.2 643.4 687.2 4507.8 4680.9 4749.2 4796.5 4799.0 148223.0 150856.0 153161.0 160408.0 161990.2 127075.0 132854.0 135672.3 138249.0 139059.0 98160.5 111664.0 117887.0 120060.4 124126.1 8790.0 9041.2 9139.4 9216.8 9252.5 58096.7 63302.4 64147.0 64378.0 64808.0 82633.0 92756.5 101229.5 102250.0 102267.0 11634.8 11700.5 11901.8 12022.9 12416.0 13106.9 13301.3 13427.4 13536.7 13829.2 12378.0 13294.9 13606.6 14193.0 14643.3 13522.1 13625.6 13817.2 14283.0 14740.1 13902.7 14176.6 14408.5 14499.6 14559.9 9187.7 11185.0 11206.2 11208.3 11889.4 11249.7 11636.9 11815.5 11959.2 11975.5 12:35:17 INFO - PROCESS | 1662 | -------- Summary: end -------- 12:35:17 INFO - PROCESS | 1662 | 12:35:17 INFO - TEST-INFO | 1662: exit 0 12:35:17 INFO - TEST-OK | dromaeo_css | took 1114188ms 12:35:17 INFO - TEST-START | kraken 12:35:17 INFO - operating with platform_type : mac_ 12:35:17 INFO - Initialising browser for kraken test... 12:35:17 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpcW1UGC/profile http://localhost:49278/getInfo.html) 12:35:20 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 12:35:20 INFO - PROCESS | 1671 | colorDepth:24 12:35:20 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 12:35:20 INFO - PROCESS | 1671 | __metrics 12:35:20 ERROR - PROCESS | 1671 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 12:35:21 INFO - TEST-INFO | 1671: exit 0 12:35:21 INFO - Browser initialized. 12:35:21 INFO - Running cycle 1/1 for kraken test... 12:35:21 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/tmpcW1UGC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:33 INFO - PROCESS | 1673 | RSS: Main: 225550336 12:35:33 INFO - PROCESS | 1673 | 12:35:36 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:36 INFO - PROCESS | 1673 | RSS: Main: 237801472 12:35:36 INFO - PROCESS | 1673 | 12:35:39 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 12:35:40 INFO - PROCESS | 1673 | RSS: Main: 245272576 12:35:40 INFO - PROCESS | 1673 | 12:35:43 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 12:35:44 INFO - PROCESS | 1673 | RSS: Main: 248864768 12:35:44 INFO - PROCESS | 1673 | 12:35:46 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 12:35:46 INFO - PROCESS | 1673 | RSS: Main: 249860096 12:35:46 INFO - PROCESS | 1673 | 12:35:48 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:49 INFO - PROCESS | 1673 | RSS: Main: 250650624 12:35:49 INFO - PROCESS | 1673 | 12:35:52 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:52 INFO - PROCESS | 1673 | RSS: Main: 251437056 12:35:52 INFO - PROCESS | 1673 | 12:35:55 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 12:35:56 INFO - PROCESS | 1673 | RSS: Main: 251392000 12:35:56 INFO - PROCESS | 1673 | 12:35:59 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 12:36:00 INFO - PROCESS | 1673 | RSS: Main: 251920384 12:36:00 INFO - PROCESS | 1673 | 12:36:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:02 INFO - PROCESS | 1673 | RSS: Main: 251105280 12:36:02 INFO - PROCESS | 1673 | 12:36:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:04 INFO - PROCESS | 1673 | RSS: Main: 251154432 12:36:04 INFO - PROCESS | 1673 | 12:36:07 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:07 INFO - PROCESS | 1673 | RSS: Main: 251109376 12:36:07 INFO - PROCESS | 1673 | 12:36:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:11 INFO - PROCESS | 1673 | RSS: Main: 251617280 12:36:11 INFO - PROCESS | 1673 | 12:36:14 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:15 INFO - PROCESS | 1673 | RSS: Main: 251592704 12:36:15 INFO - PROCESS | 1673 | 12:36:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 12:36:17 INFO - PROCESS | 1673 | RSS: Main: 253382656 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | __start_tp_report 12:36:17 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 12:36:17 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 12:36:17 INFO - PROCESS | 1673 | |i|pagename|runs| 12:36:17 INFO - PROCESS | 1673 | |0;ai-astar;106;122;116;115;118;117;116;114;115;117 12:36:17 INFO - PROCESS | 1673 | |1;audio-beat-detection;156;130;105;165;99;103;122;129;179;143 12:36:17 INFO - PROCESS | 1673 | |2;audio-dft;195;199;193;199;198;196;193;196;230;195 12:36:17 INFO - PROCESS | 1673 | |3;audio-fft;82;59;57;86;65;50;61;79;107;82 12:36:17 INFO - PROCESS | 1673 | |4;audio-oscillator;86;69;89;73;70;72;100;69;71;86 12:36:17 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;121;131;89;94;89;86;138;133;88;88 12:36:17 INFO - PROCESS | 1673 | |6;imaging-darkroom;95;130;151;131;96;101;97;95;95;96 12:36:17 INFO - PROCESS | 1673 | |7;imaging-desaturate;80;148;136;127;90;93;94;92;91;92 12:36:17 INFO - PROCESS | 1673 | |8;json-parse-financial;56;57;58;58;60;59;60;57;59;61 12:36:17 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;68;75;67;80;96;69;72;69;73;71 12:36:17 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;69;82;77;75;73;94;108;104;85;88 12:36:17 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;144;157;145;145;148;158;163;159;173;140 12:36:17 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;166;170;199;240;231;225;166;163;163;170 12:36:17 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;67;70;66;67;69;66;68;67;67;69 12:36:17 INFO - PROCESS | 1673 | __end_tp_report 12:36:17 INFO - PROCESS | 1673 | __start_cc_report 12:36:17 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,966 12:36:17 INFO - PROCESS | 1673 | __end_cc_report 12:36:17 INFO - PROCESS | 1673 | __startTimestamp1478550977126__endTimestamp 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | ------- Summary: start ------- 12:36:17 INFO - PROCESS | 1673 | Number of tests: 14 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:115.60 Median:116.50 stddev:4.03 (3.5%) stddev-sans-first:2.35 12:36:17 INFO - PROCESS | 1673 | Values: 106.0 122.0 116.0 115.0 118.0 117.0 116.0 114.0 115.0 117.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:133.10 Median:149.50 stddev:27.40 (18.3%) stddev-sans-first:27.78 12:36:17 INFO - PROCESS | 1673 | Values: 156.0 130.0 105.0 165.0 99.0 103.0 122.0 129.0 179.0 143.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:199.40 Median:197.00 stddev:10.97 (5.6%) stddev-sans-first:11.52 12:36:17 INFO - PROCESS | 1673 | Values: 195.0 199.0 193.0 199.0 198.0 196.0 193.0 196.0 230.0 195.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:72.80 Median:72.00 stddev:17.36 (24.1%) stddev-sans-first:18.09 12:36:17 INFO - PROCESS | 1673 | Values: 82.0 59.0 57.0 86.0 65.0 50.0 61.0 79.0 107.0 82.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:78.50 Median:72.50 stddev:10.89 (15.0%) stddev-sans-first:11.20 12:36:17 INFO - PROCESS | 1673 | Values: 86.0 69.0 89.0 73.0 70.0 72.0 100.0 69.0 71.0 86.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:105.70 Median:88.00 stddev:22.04 (25.0%) stddev-sans-first:22.67 12:36:17 INFO - PROCESS | 1673 | Values: 121.0 131.0 89.0 94.0 89.0 86.0 138.0 133.0 88.0 88.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:108.70 Median:95.00 stddev:20.61 (21.7%) stddev-sans-first:21.25 12:36:17 INFO - PROCESS | 1673 | Values: 95.0 130.0 151.0 131.0 96.0 101.0 97.0 95.0 95.0 96.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:104.30 Median:91.50 stddev:23.42 (25.6%) stddev-sans-first:23.14 12:36:17 INFO - PROCESS | 1673 | Values: 80.0 148.0 136.0 127.0 90.0 93.0 94.0 92.0 91.0 92.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:58.50 Median:59.00 stddev:1.58 (2.7%) stddev-sans-first:1.39 12:36:17 INFO - PROCESS | 1673 | Values: 56.0 57.0 58.0 58.0 60.0 59.0 60.0 57.0 59.0 61.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:74.00 Median:72.50 stddev:8.63 (11.9%) stddev-sans-first:8.87 12:36:17 INFO - PROCESS | 1673 | Values: 68.0 75.0 67.0 80.0 96.0 69.0 72.0 69.0 73.0 71.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:79.50 stddev:13.13 (16.5%) stddev-sans-first:12.49 12:36:17 INFO - PROCESS | 1673 | Values: 69.0 82.0 77.0 75.0 73.0 94.0 108.0 104.0 85.0 88.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:153.20 Median:157.50 stddev:10.43 (6.6%) stddev-sans-first:10.52 12:36:17 INFO - PROCESS | 1673 | Values: 144.0 157.0 145.0 145.0 148.0 158.0 163.0 159.0 173.0 140.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:184.50 stddev:31.43 (17.0%) stddev-sans-first:32.19 12:36:17 INFO - PROCESS | 1673 | Values: 166.0 170.0 199.0 240.0 231.0 225.0 166.0 163.0 163.0 170.0 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 12:36:17 INFO - PROCESS | 1673 | Values: 67.0 70.0 66.0 67.0 69.0 66.0 68.0 67.0 67.0 69.0 12:36:17 INFO - PROCESS | 1673 | -------- Summary: end -------- 12:36:17 INFO - PROCESS | 1673 | 12:36:17 INFO - TEST-INFO | 1673: exit 0 12:36:17 INFO - TEST-OK | kraken | took 60176ms 12:36:17 INFO - SUITE-END | took 1174s 12:36:18 INFO - Completed test suite (00:19:34) 12:36:18 INFO - javascript benchmark 12:36:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7378.782119179703, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3112.9844350778244, 3462.2902305027474, 3466.58400991881, 3474.965250347497, 3504.0363899927534, 5906.852328691785, 5933.050711886099, 5964.612300200495, 5969.940300596998, 5976.611520251192, 5937.287525496947, 5995.580309378345, 6043.00290452076, 6044.879102417949, 6047.092936059593, 5336.786528538863, 5375.220593014011, 5421.159720243349, 5454.53636440903, 5467.7424192435765, 5421.674699518022, 5427.674339539621, 5446.537044351235, 5446.564274858021, 5448.0, 5321.574274058066, 5344.652597581145, 5431.972840135813, 5432.75552600134, 5492.890142197154, 5363.9463605363835, 5365.03429382711, 5375.274337964363, 5393.59548033897, 5435.782568697247, 5297.735113244323, 5326.893462130735, 5361.008213480519, 5396.865078373072, 5416.4312747161375, 5758.3665796762325, 5937.495312898409, 5959.612625179349, 5983.760649574012, 6017.458428741435, 4727.787249573777, 5075.619328550337, 5614.410486898858, 6162.137300777895, 6252.468540174091, 6270.153529273535, 6277.811665650038, 6360.459360954324, 6363.7454501819875, 6376.936230637727, 6029.788957386558, 6058.485028772559, 6073.5748497604745, 6079.05774604937, 6100.481459075984, 5490.258815059996, 5721.256236689203, 6422.357764223634, 6485.221773387129, 6540.0189971503705, 6254.0, 6257.624542527463, 6260.342664020303, 6266.216722909637, 6271.717772700239, 6209.751609935643, 6211.472024877936, 6280.623162610258, 6368.808935731936, 6391.520635952229, 5310.8141215057285, 5972.835297117021, 6246.812595622138, 6267.871783079089, 6275.466585340298, 5556.499915007588, 6263.655498947511, 6272.18461599989, 6274.309825919146, 6288.213973253343, 4970.329005584272, 5029.497050294941, 5050.0, 5072.391313042459, 5084.034033533617, 3821.9426708599394, 4421.801018954155, 4423.380726698265, 4440.4227450431235, 4497.572730590588, 5802.709864506758, 5844.211031510692, 5849.94150058494, 5857.26784151981, 5878.853028674232, 6223.222097237845, 6255.311915689271, 6288.779892703734, 6292.276388215414, 6294.118823364733, 5947.732352044169, 6038.607490513103, 6094.664793436404, 6105.511559075263, 6115.51416190291, 5510.9448905511235, 5526.696031718214, 5589.692566908859, 5595.888082238333, 5599.888002239933, 6525.2169739631545, 6554.901676474857, 6554.9672251639395, 6579.046038324512, 6591.736330546724, 6184.81445556634, 6227.408396202353, 6227.501799856092, 6260.248770147611, 6278.340774218641, 5555.833325000256, 6514.57655252407, 6526.9020964686515, 6573.5398522103, 6574.638394888327, 5305.708186049805, 6304.810855674337, 6319.494440444661, 6331.810045698637, 6334.8733025338315, 6069.2110025696375, 6221.0, 6270.435660790551, 6287.905681414691, 6370.267419246846, 6068.241469816273, 6252.249730032425, 6255.218097737783, 6278.058291256348, 6296.496280297657, 6183.443490085914, 6266.717997690023, 6274.996000639876, 6276.058591211355, 6280.340564240872, 6032.245969253843, 6079.848003799941, 6125.173101631222, 6234.688265586612, 6242.063690446469, 6106.551676171979, 6116.480099191618, 6136.171616831849, 6195.752169913153, 6198.0702894566175, 5981.431763982415, 6011.458968692838, 6025.276966764016, 6028.4272994065495, 6056.57603967718], "value": 5792.866235781332, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [477.54394553201695, 480.5842945851837, 489.93385892904445, 496.23331952133947, 497.4900726755078, 39835.0, 41724.37413438801, 41779.58220417799, 41930.0, 41953.37069943946, 43207.3518897216, 43666.78166609162, 43731.12537749251, 43754.68735937919, 43771.0, 8423.747287581382, 9770.85343719843, 9937.701868943943, 9941.453220072894, 9944.6519371822, 8355.456895301817, 9819.116279534841, 9904.306698531105, 9924.90075099247, 9934.0, 9559.757231559888, 9919.652812151577, 9955.452450115241, 9964.750881227956, 9966.601335946554, 8426.620802063891, 8919.821603567925, 9903.0, 9934.503274836301, 9945.453000084992, 9817.361871478332, 9878.802423951553, 9915.405075695482, 9919.603215871357, 9926.95766944475, 41607.37588936168, 41793.0, 41942.58057419417, 42073.94815129616, 42075.36886946698, 3397.5073614325784, 3419.81191034493, 3527.0829584308008, 3572.964270357289, 4038.757674539537, 29978.400431991457, 30802.845985770153, 31723.52414713781, 31890.521642175387, 32213.838930805432, 3195.6005499312587, 3239.1254361322544, 3280.96719032809, 3290.7860989035876, 3355.2450698592866, 452131.73934130446, 535851.0, 537592.0, 537825.0, 538278.0, 33559.32881342409, 62090.0, 62534.0, 62748.68625656843, 62835.371646283864, 33671.4949275761, 34519.4822077669, 35616.28767424689, 35663.82168089143, 35699.0, 15328.386864525517, 15457.227138643022, 15519.379224831106, 15519.5344139676, 15530.9223453882, 12768.680782980315, 13118.147320424141, 13122.212667239995, 13168.0, 13183.736325273441, 7520.6239688015385, 7781.844363112706, 7826.334761545332, 7829.843403132019, 7838.059432868093, 3076.7077127672837, 3204.086835251942, 3272.443684573628, 3278.5901762279714, 3299.290652509722, 913.5204017890661, 949.586929685589, 959.1990687775645, 1025.29254814178, 1106.7620461600795, 28900.855495722386, 29499.55750663699, 30474.085777426713, 30952.0, 31009.844950775103, 874.9737507874773, 889.7286327670123, 993.3592832622918, 1045.1951996962296, 1077.369738702852, 15651.295691693902, 16116.919415402848, 16187.0, 16275.91862040706, 16306.67386652284, 713578.0, 725222.0, 728789.0, 729432.0, 729767.0, 59052.81894362174, 59477.70261148667, 59549.70225148933, 59692.70153649204, 59708.70145649244, 1371.3417559571462, 1371.6502291915697, 1394.714083612857, 1405.8594140586065, 1407.1627381707663, 26095.73904260933, 27420.314492137855, 28150.71849281481, 30711.385772284877, 31153.376932461677, 51641.967160655826, 56630.433695664164, 58448.0, 58539.414605853395, 60697.0, 544700.0, 546992.0, 550198.0, 551755.0, 553173.0, 44316.778416107714, 44341.66974990755, 44378.55621443744, 44924.55075449204, 44936.55063449324, 40829.18341633091, 41279.1744165109, 45685.77157114193, 50176.749116254185, 50563.0, 39991.600083999954, 40468.59531404766, 40548.594514055665, 40644.1871162581, 41773.74678759642, 40016.59983400129, 40316.7984160089, 41205.793971029954, 41247.175056499305, 41465.96335091647, 39059.41410878782, 39576.0, 39616.60383396129, 39826.60173398345, 41591.16817663569, 32315.51526727148, 34695.13262168466, 35255.64744352524, 35368.292634147685, 35461.64538354584, 21944.45138871477, 25641.23076307714, 25891.0, 25943.74056259489, 26316.342091447103], "value": 19275.165110952817, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.16799070430824, 369.2246282806106, 372.41902631894254, 377.13635774077363, 396.05145676105707, 19473.805261947375, 19983.20067197312, 20575.074121664522, 21112.83879386631, 21375.57248855022, 19925.40223793285, 20327.28854490093, 20382.592348153026, 20811.0, 20842.270520531783, 5341.278927344817, 5810.535157187425, 5928.822135335925, 5982.4316689914385, 6082.300535438415, 5875.500582450497, 5964.522838172958, 5967.671778052206, 5973.074173503114, 5978.312494063173, 5673.290838645169, 5873.647581145124, 5927.555433342495, 5933.821985340447, 5971.761129554812, 5898.997170481007, 5932.644041357489, 5937.67342796146, 5938.079597662348, 5975.462208401243, 5029.974850125763, 5075.0, 5208.843734687927, 5210.348706411699, 5223.817166399158, 23207.88396058009, 24725.50548989028, 24772.876135619386, 24994.625080623806, 25043.49913001748, 2425.0784701813373, 2508.5610018246916, 2901.9274518137217, 3066.3100802319523, 3150.5116706910467, 14604.0, 14904.031237969497, 15189.696206075927, 15424.22878856064, 15830.28763705636, 1824.9780123131088, 1844.6679597672414, 1862.7671541057368, 1915.3104882242383, 1920.3566805120302, 72778.9083163753, 84433.88915277105, 90967.0, 107761.46119269353, 111239.44380278127, 10437.739056523647, 10639.627613033506, 10848.837267440995, 10908.672739817817, 11077.612283570197, 13365.799513007312, 13479.86520134786, 13480.730385392433, 13500.729985400238, 13512.864871351358, 7248.637568121573, 8521.403501754818, 8761.693340733043, 8769.912300877037, 8860.556972151368, 8827.205551500267, 8958.910410895938, 8966.68616598416, 9027.819443611223, 9152.725418237464, 5575.4424557544735, 6574.441172500391, 6588.374104460068, 6675.165604299463, 6688.130543029375, 1819.9636007280046, 1846.5568263616635, 1857.1178690122083, 1864.4127099963468, 1872.1201035513286, 877.9780505487414, 899.1053901368181, 926.36081104038, 1002.1081237698309, 1078.1751959750798, 20867.269645562334, 21574.676379854314, 21789.891050544647, 21872.343829685135, 21896.671549926763, 920.8894932607996, 962.8411312133419, 967.4292167621137, 976.8876579193342, 1009.8485227215976, 10951.83572246417, 11410.144239182095, 11433.371164585862, 11510.654680359603, 11534.538618455335, 623053.8847305734, 625172.0, 654915.0, 660277.0, 668044.0, 108369.0, 138813.0, 143130.28434857758, 145458.0, 150947.0, 1000.7147962830559, 1021.8211812932707, 1072.6084978982772, 1074.7796701676139, 1077.6389909380289, 15065.0, 18812.811871881655, 19123.617527649647, 19152.712709309093, 19188.328408505637, 56625.0, 57172.71413642905, 57847.0, 58721.0, 59271.703641481516, 76977.0, 81434.0, 82121.58939205266, 82891.0, 83214.33571328661, 7953.952371721204, 7963.562004089831, 8079.474834135763, 8272.17278272168, 8313.875291870505, 11174.88825111771, 12656.746865062463, 12713.80929286043, 12870.871291286967, 12987.480500779862, 9060.773480663036, 10611.787764244826, 10727.570897164025, 11017.394043327695, 11090.001899829054, 10735.355878647306, 10868.239223254297, 10947.0, 11074.169437292074, 11081.778364432828, 10472.790544189225, 11155.49800258974, 11193.888061119611, 11344.149188811038, 11589.478473468882, 7641.0, 7684.193159718373, 7722.18917013728, 7997.680092796456, 8064.35485161174, 7536.773896783106, 10354.430506322225, 10904.0, 11048.558057677603, 11225.0], "value": 9772.970407595254, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1432.7779194224895, 1504.9398024079037, 1716.0990479998, 1856.0, 1860.6929856573665, 7075.46933979951, 8044.879326810103, 8453.704120355782, 9074.001859795417, 9086.818263634723, 8517.914820851789, 8816.986046604643, 8826.293896488281, 8932.33007524435, 8944.105589441053, 2361.1263832382, 2412.2883749293915, 2412.8190385721055, 2414.1791790791126, 2421.467277199022, 2388.7133543974746, 2388.9761102389016, 2416.395901024744, 2420.6490058941445, 2425.19968410425, 2399.940001499968, 2410.3974006498374, 2411.2043025801445, 2416.3838221253645, 2416.7220769611545, 1855.415544103603, 2118.1633254864396, 2147.807966578548, 2336.287432333146, 2384.630382290739, 1924.7978962208906, 2385.3798012516695, 2389.044382247115, 2392.12687369109, 2394.0902457066204, 8555.529445880475, 8873.689420870238, 8944.150305720947, 8956.955215223883, 8960.059193784624, 4653.86038418848, 5252.501012403815, 5375.682957675394, 5384.91922621161, 5395.5953303502, 3037.559553864677, 3503.4569641705575, 3627.3289441453153, 3718.888433347004, 3726.087108658396, 926.2543652359848, 1066.3388699006666, 1112.1547623805966, 1122.4948773052079, 1131.298594871185, 11814.0, 11855.288682679067, 11904.880951190464, 11923.94038029813, 11927.940360298144, 4644.628429725613, 4723.45680246776, 4844.685095468783, 4845.176320025604, 4865.9026819463415, 8819.735407937773, 9326.487043212688, 10206.336588121896, 10221.540030698488, 10239.027292407209, 5345.812896548602, 5346.705931173823, 5373.9731301343245, 5378.1663842104535, 5381.7578208980685, 4404.691671583022, 4514.34541991416, 4551.408316918845, 4917.631177661689, 4924.285978533093, 3397.8810741623925, 3996.780177090288, 4086.734362266443, 4114.0948991221885, 4122.876313710593, 1309.4369421148806, 1319.0502837956656, 1320.465211589308, 1328.0703507544565, 1331.5339631129027, 768.2125821033374, 869.7129947117436, 888.4846788862444, 921.8110287391069, 939.6664184214642, 5751.252337196138, 5790.189373487715, 5959.4934430573885, 6149.354317796657, 6152.384761523901, 892.9374943754004, 954.2938225712923, 971.5093877591771, 979.8922118566952, 992.7468495533593, 3857.6528112470014, 3899.805009749558, 3932.4887764590994, 4008.238434697398, 4115.279826030433, 10460.52927618259, 10919.563217471372, 10932.890671093346, 10935.398553079656, 10944.015038646401, 9540.33217674756, 10557.41638754193, 10884.40135792539, 10889.782204355868, 10895.182861285277, 6912.930870691229, 7433.256674332523, 8213.425060245845, 8350.70772522971, 8379.37154713399, 4293.0984493256765, 5819.185314056121, 5966.791162309299, 5995.220621319375, 5998.25021872266, 9937.801243975224, 9969.800603987735, 10042.598296068367, 10173.033561811617, 10195.949020254851, 9861.852072219066, 9932.602695892083, 10178.236632252463, 10480.842787358044, 10549.630762923261, 6639.933600663931, 6856.211535673461, 6986.54587451814, 7127.287271273039, 7252.601106938958, 6669.699863506057, 8307.460015098999, 8482.618282177193, 8584.442011269248, 8612.440191387539, 6809.285025072296, 7681.270279323679, 7712.8457430852195, 7731.6520756567215, 7759.0, 7374.483786134919, 7466.514676546007, 7475.0656167979005, 7603.239676032353, 7606.391488681003, 7074.0, 7179.641017949186, 7184.856302873809, 7189.964050179716, 7192.280771922975, 4896.069746748107, 4921.581665558468, 4973.801047958186, 4993.550580447777, 5094.312267843942, 5064.974675126601, 5069.138246498178, 5155.252488389237, 5167.689938603696, 5169.431362550041], "value": 4586.9784341597115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [266.969298530669, 298.4597877841108, 307.82300177397997, 311.4254200999157, 313.20133659169113, 4694.967107236411, 4947.356843610326, 5522.834314970552, 5557.944420555793, 5611.859703507414, 4443.711158774678, 4921.680090794096, 5314.362276526813, 5397.649152805065, 5415.323084614423, 3536.080619039049, 4125.97937010316, 4184.8535301264465, 4194.412782210493, 4218.599233072869, 3884.4173373993845, 3990.422984836387, 4192.664586833062, 4199.249491583018, 4209.621563816449, 3421.589409270891, 4145.440365550658, 4169.812358443862, 4178.6448151907125, 4179.763826352902, 3928.096537796323, 4157.812898419564, 4163.97918010411, 4169.3954376615375, 4173.3114036184, 3429.936719616902, 3627.4014787560022, 3630.4009838376637, 3631.2011357501306, 3650.1239702471216, 4526.864194074183, 4959.7768100435205, 5197.506236907526, 5298.748032086348, 5308.601854860863, 4098.729393887875, 4690.038542098861, 4791.736454495001, 4793.784279707422, 4819.759012049419, 5414.810481633124, 5768.278965129359, 5801.970990145022, 5825.689219925525, 5896.6437719324795, 3091.9690803091908, 3292.308615190813, 3856.3444214483607, 3982.6216509431556, 4020.7386519876113, 5957.6127551709, 5991.221141251609, 6001.609895356788, 6021.1269365942135, 6067.575269731121, 3392.762506624562, 3731.8880433587037, 3736.9723326085, 4019.748940593277, 4070.1656160487028, 3894.3768996960353, 4079.4288799568085, 4129.855455059059, 4133.81397837098, 4146.714518499275, 4741.525847415231, 4770.332153498513, 4778.546038126373, 4793.664443488992, 4798.352222449995, 5401.541583772359, 5467.753951072212, 5829.387914269026, 5869.647821130746, 5879.970600146972, 1296.8962483001337, 1302.9413676384586, 1328.6779654243896, 1376.064276292111, 1382.9377678004514, 926.1525703980917, 941.5010044676333, 946.8579713043099, 953.4851180362526, 962.9855552166723, 5411.431799661058, 5414.0, 5414.35027796667, 5420.671935375858, 5437.13005919051, 4776.355192049029, 5438.3473983121485, 5895.94104058954, 5918.171455996164, 5939.316978547436, 5184.429712731597, 5222.150355739107, 5294.743732604421, 5328.946710532845, 5363.410024897258, 2465.4452748131525, 2583.509133264674, 2590.3394634368115, 2632.6182703507884, 2634.868256587163, 4158.480189976253, 4432.335149727567, 4857.138574833016, 5093.719845408464, 5149.0, 4572.3827283317, 4972.975135124374, 5029.371328583927, 5054.898902022012, 5099.36257967754, 4531.3882625845745, 4713.670043097019, 5116.641835071509, 5193.376794784499, 5207.661502002434, 4614.630829533562, 4941.184704523714, 4977.900441991213, 5009.699418034929, 5040.4455509894615, 4159.313713237282, 4517.209488339593, 4849.636277279147, 5755.338136114233, 5895.29256489224, 4904.337914381513, 6124.29570599369, 6185.4536365908525, 6259.649543567177, 6270.0, 3511.3328467591077, 3846.8845934622004, 3915.5301363835383, 3969.7022723296445, 3979.2240513100824, 5693.953734751888, 5699.748599303169, 5861.413858614104, 6015.57890947647, 6116.204893363834, 4752.3584316116885, 4848.466668666514, 5217.165253559412, 5258.842234732964, 5903.822885313448, 5313.309269794902, 5854.590178687451, 5867.823965280878, 5905.881882362242, 5920.674362910081, 4649.883752906205, 4775.379200703886, 5045.924311135409, 5109.948900510947, 5696.487316141567, 5704.657720536781, 5770.874679437469, 5800.1589769484035, 5847.26909136358, 5894.11388355722, 4752.287156926489, 4991.9500804991485, 5721.113227449752, 5724.771009159587, 5741.196232527533], "value": 4077.9114167939856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [682.0928165539832, 733.5012191709635, 778.5717855179649, 787.4566549081134, 807.3904202327244, 15120.24398780062, 15847.128407937587, 15891.761623575656, 15901.443449479271, 15922.920385398085, 14151.716965660706, 14164.929175354135, 14169.71660566788, 14185.78721319181, 14225.857741422582, 656.2190992718673, 680.251723104586, 817.284875733733, 817.6320655704942, 839.9874001889976, 858.0647094666812, 858.0775666158873, 858.3948316436897, 859.2653281444369, 859.6303589456531, 908.1690253418114, 911.0297533127198, 912.6668765900432, 913.2511340700628, 913.2648218184358, 879.9252063574539, 898.0, 904.3082042237694, 905.5789058087988, 910.008091180613, 657.4937298280345, 665.0456594786449, 673.0442771264816, 676.6075676107846, 677.5088061155672, 14437.422503099864, 14619.926900365537, 15022.399104035825, 15039.172845493493, 15053.623659408493, 11530.481128349244, 12062.879371206263, 14658.193799341032, 14700.191489468076, 14831.629209269746, 9663.130318271318, 9841.261905357127, 11549.94225028878, 11982.880171198263, 12072.818907716392, 3759.0978165240144, 3759.6804271636943, 3873.7288389812725, 3885.9028524286837, 4009.3384591542654, 122940.38529807383, 126406.0, 128554.3572282142, 135532.32233838865, 135662.0, 9185.908140918506, 10954.671359859218, 11496.252743571642, 11508.251963622337, 11532.192746507832, 20369.287074952306, 23211.883940580527, 23391.883040585028, 23433.88283058574, 23437.41406464818, 8012.79968000793, 8167.469114507538, 8223.465474744122, 8374.995000599967, 8457.703980360659, 4448.844290449819, 4495.955040449619, 4517.0, 4610.884727881829, 4640.69835460694, 3640.0171953572917, 3658.213484100878, 3769.1707824278615, 3861.9613803861603, 4046.291898917678, 703.2475251480969, 724.6340597998083, 737.133867705444, 742.7140550887947, 745.7843714745039, 550.4028129479559, 582.8338923406809, 616.6146158650844, 661.3089321658878, 681.3629256645053, 7709.807254818675, 9263.490508021989, 9326.95336523313, 9650.324477286522, 9707.271954603433, 546.7211722021798, 586.2905883880467, 611.2237458427771, 643.4016364780799, 687.2337343861658, 4507.774611269423, 4680.9297860532115, 4749.168895443284, 4796.496367881322, 4798.95201047985, 148223.0, 150856.0, 153161.0, 160408.0, 161990.190049049, 127075.0, 132854.00718989223, 135672.32163839118, 138249.0, 139059.0, 98160.50919745499, 111664.0, 117887.0, 120060.39969800095, 124126.13810792845, 8790.033096359522, 9041.23149532297, 9139.38756579, 9216.755737975287, 9252.53737313145, 58096.709516452145, 63302.36697632965, 64147.0, 64378.0, 64808.02787958278, 82633.0, 92756.53621731848, 101229.49385253027, 102250.0, 102267.0, 11634.76730465403, 11700.531978720755, 11901.76196476083, 12022.88932830012, 12416.0, 13106.934465327993, 13301.334933253493, 13427.395767190304, 13536.661583460493, 13829.239391833546, 12378.0, 13294.933525332312, 13606.591802245948, 14193.0, 14643.341049652578, 13522.12106213093, 13625.591232263048, 13817.170969741848, 14283.0, 14740.11559306445, 13902.721945561234, 14176.645583860485, 14408.495702650356, 14499.637509062359, 14559.854401456274, 9187.678431254873, 11185.0, 11206.159538034843, 11208.27146235492, 11889.405529723306, 11249.71875703114, 11636.88363116358, 11815.468303926173, 11959.162858599815, 11975.461104250155], "value": 7906.432186085404, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1546.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 122.0, 116.0, 115.0, 118.0, 117.0, 116.0, 114.0, 115.0, 117.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 130.0, 105.0, 165.0, 99.0, 103.0, 122.0, 129.0, 179.0, 143.0], "value": 133.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 199.0, 193.0, 199.0, 198.0, 196.0, 193.0, 196.0, 230.0, 195.0], "value": 199.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 57.0, 86.0, 65.0, 50.0, 61.0, 79.0, 107.0, 82.0], "value": 72.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 89.0, 73.0, 70.0, 72.0, 100.0, 69.0, 71.0, 86.0], "value": 78.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 131.0, 89.0, 94.0, 89.0, 86.0, 138.0, 133.0, 88.0, 88.0], "value": 105.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 130.0, 151.0, 131.0, 96.0, 101.0, 97.0, 95.0, 95.0, 96.0], "value": 108.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 148.0, 136.0, 127.0, 90.0, 93.0, 94.0, 92.0, 91.0, 92.0], "value": 104.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 58.0, 58.0, 60.0, 59.0, 60.0, 57.0, 59.0, 61.0], "value": 58.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 75.0, 67.0, 80.0, 96.0, 69.0, 72.0, 69.0, 73.0, 71.0], "value": 74.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 82.0, 77.0, 75.0, 73.0, 94.0, 108.0, 104.0, 85.0, 88.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 157.0, 145.0, 145.0, 148.0, 158.0, 163.0, 159.0, 173.0, 140.0], "value": 153.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 170.0, 199.0, 240.0, 231.0, 225.0, 166.0, 163.0, 163.0, 170.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 70.0, 66.0, 67.0, 69.0, 66.0, 68.0, 67.0, 67.0, 69.0], "value": 67.6, "unit": "score"}]}]} 12:36:18 INFO - Return code: 0 12:36:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:36:18 ERROR - # TBPL SUCCESS # 12:36:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:36:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:36:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:36:18 INFO - 2016-11-07 12:36:18.446 screenresolution[1678:11948] starting screenresolution argv=screenresolution get 12:36:18 INFO - 2016-11-07 12:36:18.449 screenresolution[1678:11948] Display 0: 1600x1200x32@60 12:36:18 INFO - 2016-11-07 12:36:18.455 screenresolution[1679:11951] starting screenresolution argv=screenresolution list 12:36:18 INFO - Available Modes on Display 0 12:36:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:36:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:36:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:36:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:36:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:36:18 INFO - Intel Iris: 12:36:18 INFO - Chipset Model: Intel Iris 12:36:18 INFO - Type: GPU 12:36:18 INFO - Bus: Built-In 12:36:18 INFO - VRAM (Dynamic, Max): 1536 MB 12:36:18 INFO - Vendor: Intel (0x8086) 12:36:18 INFO - Device ID: 0x0a2e 12:36:18 INFO - Revision ID: 0x0009 12:36:18 INFO - Displays: 12:36:18 INFO - Display: 12:36:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:36:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:36:18 INFO - Display Serial Number: 1600x1200 60 12:36:18 INFO - Main Display: Yes 12:36:18 INFO - Mirror: Off 12:36:18 INFO - Online: Yes 12:36:18 INFO - Rotation: Supported 12:36:18 INFO - Return code: 0 12:36:18 INFO - Running post-action listener: _resource_record_post_action 12:36:18 INFO - [mozharness: 2016-11-07 20:36:18.689347Z] Finished run-tests step (success) 12:36:18 INFO - Running post-run listener: _resource_record_post_run 12:36:18 INFO - Total resource usage - Wall time: 1208s; CPU: 54.0%; Read bytes: 32259072; Write bytes: 669260800; Read time: 196; Write time: 1960 12:36:18 INFO - TinderboxPrint: CPU usage
54.1% 12:36:18 INFO - TinderboxPrint: I/O read bytes / time
32,259,072 / 196 12:36:18 INFO - TinderboxPrint: I/O write bytes / time
669,260,800 / 1,960 12:36:18 INFO - TinderboxPrint: CPU idle
2,216.5 (45.9%) 12:36:18 INFO - TinderboxPrint: CPU system
974.2 (20.2%) 12:36:18 INFO - TinderboxPrint: CPU user
1,643.1 (34.0%) 12:36:18 INFO - TinderboxPrint: Swap in / out
391,647,232 / 0 12:36:18 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 362873344; Write bytes: 357725696; Read time: 28997; Write time: 749 12:36:18 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 29203456; Write bytes: 301168128; Read time: 173; Write time: 1174 12:36:19 INFO - Running post-run listener: _upload_blobber_files 12:36:19 INFO - Blob upload gear active. 12:36:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:36:19 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 12:36:19 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:36:19 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:36:19 INFO - (blobuploader) - INFO - Open directory for files ... 12:36:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:36:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:21 INFO - (blobuploader) - INFO - Done attempting. 12:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:36:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:36:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:21 INFO - (blobuploader) - INFO - Done attempting. 12:36:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:36:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:36:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:36:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:36:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:36:24 INFO - (blobuploader) - INFO - Done attempting. 12:36:24 INFO - (blobuploader) - INFO - Iteration through files over. 12:36:24 INFO - Return code: 0 12:36:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:36:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:36:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70d92a61ffa1d6a42e73a09cbbb10a7b3183b353cd9f856c2e010b67745ff80a9a88392250288c938325dbb23c9a942ac2477cb8728e53d92bf5a1120f24d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/497ce007936ee4f76a3716632da249858b4ab416e8266e87d8a302af7902b86ff0647ae01f80ace484dc6363aa432b2b753454c67fcffddf620c78a87a85df48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba004e7dec870e0a544cd304834054ac5351e586497490e4ff4858d0a91f4c2d1ebf7271a876727392a46104648fff82a6d412af3aac0c81e0876578020aff44"} 12:36:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:36:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:36:24 INFO - Contents: 12:36:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70d92a61ffa1d6a42e73a09cbbb10a7b3183b353cd9f856c2e010b67745ff80a9a88392250288c938325dbb23c9a942ac2477cb8728e53d92bf5a1120f24d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/497ce007936ee4f76a3716632da249858b4ab416e8266e87d8a302af7902b86ff0647ae01f80ace484dc6363aa432b2b753454c67fcffddf620c78a87a85df48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba004e7dec870e0a544cd304834054ac5351e586497490e4ff4858d0a91f4c2d1ebf7271a876727392a46104648fff82a6d412af3aac0c81e0876578020aff44"} 12:36:24 INFO - Running post-run listener: copy_logs_to_upload_dir 12:36:24 INFO - Copying logs to upload dir... 12:36:24 INFO - mkdir: /builds/slave/test/build/upload/logs 12:36:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.228501 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-11-07 12:36:24.586657) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:24.590241) ========= 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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DUWBYSgAYI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70d92a61ffa1d6a42e73a09cbbb10a7b3183b353cd9f856c2e010b67745ff80a9a88392250288c938325dbb23c9a942ac2477cb8728e53d92bf5a1120f24d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/497ce007936ee4f76a3716632da249858b4ab416e8266e87d8a302af7902b86ff0647ae01f80ace484dc6363aa432b2b753454c67fcffddf620c78a87a85df48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba004e7dec870e0a544cd304834054ac5351e586497490e4ff4858d0a91f4c2d1ebf7271a876727392a46104648fff82a6d412af3aac0c81e0876578020aff44"} build_url:https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010945 build_url: 'https://queue.taskcluster.net/v1/task/f6JTiVNeSe-9t0I_umZ3Vg/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8b70d92a61ffa1d6a42e73a09cbbb10a7b3183b353cd9f856c2e010b67745ff80a9a88392250288c938325dbb23c9a942ac2477cb8728e53d92bf5a1120f24d0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/497ce007936ee4f76a3716632da249858b4ab416e8266e87d8a302af7902b86ff0647ae01f80ace484dc6363aa432b2b753454c67fcffddf620c78a87a85df48", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ba004e7dec870e0a544cd304834054ac5351e586497490e4ff4858d0a91f4c2d1ebf7271a876727392a46104648fff82a6d412af3aac0c81e0876578020aff44"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:24.622515) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:24.622910) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DUWBYSgAYI/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.dhSQbQJmvk/Listeners TMPDIR=/var/folders/kx/2q83flzx3dn01nvjsllhhyd000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005111 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-07 12:36:24.671774) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 12:36:24.672108) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-07 12:36:24.672439) ========= ========= Total master_lag: 0.22 =========