builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0003 starttime: 1477017693.8 results: success (0) buildid: 20161020182249 builduid: a0906d9c6e794385bb19908152f00519 revision: 3a45c899d5015ba64e1cdbe206687951561e6fca ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:33.800021) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:33.800743) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:33.801185) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:33.826697) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:33.827001) ========= 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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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-10-20 19:41:33-- 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% 140M=0s 2016-10-20 19:41:33 (140 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137005 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:33.989334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:33.989935) ========= 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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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.027666 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:34.041638) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 19:41:34.042469) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 3a45c899d5015ba64e1cdbe206687951561e6fca --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 3a45c899d5015ba64e1cdbe206687951561e6fca --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.e9PbF4fY07/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.lZ8MG7zA9f/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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-10-20 19:41:34,121 truncating revision to first 12 chars 2016-10-20 19:41:34,122 Setting DEBUG logging. 2016-10-20 19:41:34,122 attempt 1/10 2016-10-20 19:41:34,122 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/3a45c899d501?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 19:41:35,246 unpacking tar archive at: mozilla-aurora-3a45c899d501/testing/mozharness/ program finished with exit code 0 elapsedTime=1.406215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-20 19:41:35.472673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:35.473094) ========= script_repo_revision: 3a45c899d5015ba64e1cdbe206687951561e6fca ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:35.473528) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:35.473942) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 19:41:35.493497) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-20 19:41:35.493935) ========= /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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:41:35 INFO - MultiFileLogger online at 20161020 19:41:35 in /builds/slave/test 19:41:35 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 19:41:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:41:35 INFO - {'append_to_log': False, 19:41:35 INFO - 'base_work_dir': '/builds/slave/test', 19:41:35 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 19:41:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:41:35 INFO - 'branch': 'Mozilla-Aurora', 19:41:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:41:35 INFO - 'config_files': ('talos/mac_config.py',), 19:41:35 INFO - 'default_actions': ('clobber', 19:41:35 INFO - 'read-buildbot-config', 19:41:35 INFO - 'download-and-extract', 19:41:35 INFO - 'populate-webroot', 19:41:35 INFO - 'create-virtualenv', 19:41:35 INFO - 'install', 19:41:35 INFO - 'run-tests'), 19:41:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:41:35 INFO - 'download_minidump_stackwalk': True, 19:41:35 INFO - 'download_symbols': 'ondemand', 19:41:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:41:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:41:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:41:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:41:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:41:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:41:35 INFO - 'installer_path': 'installer.exe', 19:41:35 INFO - 'log_level': 'info', 19:41:35 INFO - 'log_name': 'talos', 19:41:35 INFO - 'log_to_console': True, 19:41:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:41:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:41:35 INFO - 'opt_config_files': (), 19:41:35 INFO - 'pip_index': False, 19:41:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:41:35 INFO - 'cmd': ('bash', 19:41:35 INFO - '-c', 19:41:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:41:35 INFO - 'enabled': True, 19:41:35 INFO - 'halt_on_failure': False, 19:41:35 INFO - 'name': 'check_screen_resolution'},), 19:41:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:41:35 INFO - 'cmd': ('bash', 19:41:35 INFO - '-c', 19:41:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:41:35 INFO - 'enabled': True, 19:41:35 INFO - 'halt_on_failure': False, 19:41:35 INFO - 'name': 'check_screen_resolution'},), 19:41:35 INFO - 'run_cmd_checks_enabled': True, 19:41:35 INFO - 'sps_profile': False, 19:41:35 INFO - 'sps_profile_interval': 0, 19:41:35 INFO - 'suite': 'dromaeojs-e10s', 19:41:35 INFO - 'system_bits': '32', 19:41:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:41:35 INFO - 'title': 't-yosemite-r7-0003', 19:41:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:41:35 INFO - 'use_talos_json': True, 19:41:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:41:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:41:35 INFO - 'work_dir': 'build'} 19:41:35 INFO - [mozharness: 2016-10-21 02:41:35.708573Z] Running clobber step. 19:41:35 INFO - Running pre-action listener: _resource_record_pre_action 19:41:35 INFO - Running main action method: clobber 19:41:35 INFO - rmtree: /builds/slave/test/build 19:41:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:41:37 INFO - Running post-action listener: _resource_record_post_action 19:41:37 INFO - [mozharness: 2016-10-21 02:41:37.944750Z] Finished clobber step (success) 19:41:37 INFO - [mozharness: 2016-10-21 02:41:37.944894Z] Running read-buildbot-config step. 19:41:37 INFO - Running pre-action listener: _resource_record_pre_action 19:41:37 INFO - Running main action method: read_buildbot_config 19:41:37 INFO - Using buildbot properties: 19:41:37 INFO - { 19:41:37 INFO - "project": "", 19:41:37 INFO - "product": "firefox", 19:41:37 INFO - "script_repo_revision": "production", 19:41:37 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 19:41:37 INFO - "repository": "", 19:41:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 19:41:37 INFO - "buildid": "20161020182249", 19:41:37 INFO - "pgo_build": "False", 19:41:37 INFO - "basedir": "/builds/slave/test", 19:41:37 INFO - "buildnumber": 10, 19:41:37 INFO - "slavename": "t-yosemite-r7-0003", 19:41:37 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 19:41:37 INFO - "platform": "yosemite_r7", 19:41:37 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 19:41:37 INFO - "branch": "mozilla-aurora", 19:41:37 INFO - "repo_path": "releases/mozilla-aurora", 19:41:37 INFO - "revision": "3a45c899d5015ba64e1cdbe206687951561e6fca", 19:41:37 INFO - "stage_platform": "macosx64", 19:41:37 INFO - "builduid": "a0906d9c6e794385bb19908152f00519", 19:41:37 INFO - "slavebuilddir": "test" 19:41:37 INFO - } 19:41:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 19:41:37 INFO - Running post-action listener: _resource_record_post_action 19:41:37 INFO - [mozharness: 2016-10-21 02:41:37.948163Z] Finished read-buildbot-config step (success) 19:41:37 INFO - [mozharness: 2016-10-21 02:41:37.948296Z] Running download-and-extract step. 19:41:37 INFO - Running pre-action listener: _resource_record_pre_action 19:41:37 INFO - Running main action method: download_and_extract 19:41:37 INFO - mkdir: /builds/slave/test/build/tests 19:41:37 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')]} 19:41:37 INFO - trying https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 19:41:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/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 19:41:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/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 19:41:39 INFO - Downloaded 1199 bytes. 19:41:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 19:41:39 INFO - Using the following test package requirements: 19:41:39 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:41:39 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 19:41:39 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 19:41:39 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'jsshell-mac.zip'], 19:41:39 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 19:41:39 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 19:41:39 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 19:41:39 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 19:41:39 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 19:41:39 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 19:41:39 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 19:41:39 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 19:41:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:41:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:41:39 INFO - Fetch https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:41:39 INFO - Expected file size: 16436371 19:41:46 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 19:41:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 19:41:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 19:41:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 19:41:47 INFO - Expected file size: 16436371 19:41:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 19:41:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 19:41:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 19:41:54 INFO - Expected file size: 14414081 19:41:55 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')]} 19:41:55 INFO - trying https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:41:55 INFO - Downloading https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 19:41:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/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 19:41:58 INFO - Downloaded 115424387 bytes. 19:41:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:41:58 INFO - mkdir: /builds/slave/test/properties 19:41:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:41:58 INFO - Writing to file /builds/slave/test/properties/build_url 19:41:58 INFO - Contents: 19:41:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 19:41:59 INFO - Running post-action listener: _resource_record_post_action 19:41:59 INFO - Running post-action listener: set_extra_try_arguments 19:41:59 INFO - [mozharness: 2016-10-21 02:41:59.261442Z] Finished download-and-extract step (success) 19:41:59 INFO - [mozharness: 2016-10-21 02:41:59.261577Z] Running populate-webroot step. 19:41:59 INFO - Running pre-action listener: _resource_record_pre_action 19:41:59 INFO - Running main action method: populate_webroot 19:41:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:41:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:41:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:41:59 INFO - '--tppagecycles', 19:41:59 INFO - '7'], 19:41:59 INFO - 'tests': ['tsvgm']}}, 19:41:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:41:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:41:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:41:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:41:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:41:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:41:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['damp', 'tps']}, 19:41:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'tests': ['damp', 'tps']}, 19:41:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['dromaeo_dom']}, 19:41:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:41:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['basic_compositor_video']}, 19:41:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:41:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['a11yr', 19:41:59 INFO - 'ts_paint', 19:41:59 INFO - 'tpaint', 19:41:59 INFO - 'sessionrestore', 19:41:59 INFO - 'sessionrestore_no_auto_restore', 19:41:59 INFO - 'tabpaint']}, 19:41:59 INFO - 'other-e10s': {'tests': ['a11yr', 19:41:59 INFO - 'ts_paint', 19:41:59 INFO - 'tpaint', 19:41:59 INFO - 'sessionrestore', 19:41:59 INFO - 'sessionrestore_no_auto_restore', 19:41:59 INFO - 'tabpaint']}, 19:41:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:41:59 INFO - 'ts_paint', 19:41:59 INFO - 'tpaint', 19:41:59 INFO - 'sessionrestore', 19:41:59 INFO - 'sessionrestore_no_auto_restore', 19:41:59 INFO - 'tabpaint']}, 19:41:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:41:59 INFO - 'ts_paint', 19:41:59 INFO - 'tpaint', 19:41:59 INFO - 'sessionrestore', 19:41:59 INFO - 'sessionrestore_no_auto_restore', 19:41:59 INFO - 'tabpaint']}, 19:41:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['a11yr', 19:41:59 INFO - 'ts_paint', 19:41:59 INFO - 'tpaint', 19:41:59 INFO - 'sessionrestore', 19:41:59 INFO - 'sessionrestore_no_auto_restore', 19:41:59 INFO - 'tabpaint']}, 19:41:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['a11yr', 19:41:59 INFO - 'ts_paint', 19:41:59 INFO - 'tpaint', 19:41:59 INFO - 'sessionrestore', 19:41:59 INFO - 'sessionrestore_no_auto_restore', 19:41:59 INFO - 'tabpaint']}, 19:41:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['tsvgx', 19:41:59 INFO - 'tsvgr_opacity', 19:41:59 INFO - 'tart', 19:41:59 INFO - 'tscrollx', 19:41:59 INFO - 'cart']}, 19:41:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:41:59 INFO - 'tsvgr_opacity', 19:41:59 INFO - 'tart', 19:41:59 INFO - 'tscrollx', 19:41:59 INFO - 'cart']}, 19:41:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'talos_options': ['--disable-e10s'], 19:41:59 INFO - 'tests': ['tp5o']}, 19:41:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'tests': ['tp5o']}, 19:41:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'talos_options': ['--disable-e10s', 19:41:59 INFO - '--xperf_path', 19:41:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:41:59 INFO - 'tests': ['tp5n']}, 19:41:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:41:59 INFO - 'talos_options': ['--xperf_path', 19:41:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:41:59 INFO - 'tests': ['tp5n']}}, 19:41:59 INFO - 'talos.zip': {'path': '', 19:41:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:41:59 INFO - Running post-action listener: _resource_record_post_action 19:41:59 INFO - [mozharness: 2016-10-21 02:41:59.280690Z] Finished populate-webroot step (success) 19:41:59 INFO - [mozharness: 2016-10-21 02:41:59.280820Z] Running create-virtualenv step. 19:41:59 INFO - Running pre-action listener: _resource_record_pre_action 19:41:59 INFO - Running main action method: create_virtualenv 19:41:59 INFO - Creating virtualenv /builds/slave/test/build/venv 19:41:59 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 19:41:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:41:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:41:59 INFO - Using real prefix '/tools/python27' 19:41:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:42:00 INFO - Installing distribute.............................................................................................................................................................................................done. 19:42:03 INFO - Installing pip.................done. 19:42:03 INFO - Return code: 0 19:42:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:42: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')]} 19:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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')]} 19:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:03 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:03 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 19:42:03 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 19:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:03 INFO - 'HOME': '/Users/cltbld', 19:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:03 INFO - 'LOGNAME': 'cltbld', 19:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:03 INFO - 'MOZ_NO_REMOTE': '1', 19:42:03 INFO - 'NO_EM_RESTART': '1', 19:42:03 INFO - 'PAGER': '/bin/cat', 19:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:03 INFO - 'PWD': '/builds/slave/test', 19:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:03 INFO - 'SHELL': '/bin/bash', 19:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:03 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:03 INFO - 'USER': 'cltbld', 19:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:03 INFO - 'XPC_FLAGS': '0x0', 19:42:03 INFO - 'XPC_SERVICE_NAME': '0', 19:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:03 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 19:42:03 INFO - Cleaning up... 19:42:03 INFO - Return code: 0 19:42:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:42: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')]} 19:42:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42: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')]} 19:42:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:03 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:03 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 19:42:03 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 19:42:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:03 INFO - 'HOME': '/Users/cltbld', 19:42:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:03 INFO - 'LOGNAME': 'cltbld', 19:42:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:03 INFO - 'MOZ_NO_REMOTE': '1', 19:42:03 INFO - 'NO_EM_RESTART': '1', 19:42:03 INFO - 'PAGER': '/bin/cat', 19:42:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:03 INFO - 'PWD': '/builds/slave/test', 19:42:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:03 INFO - 'SHELL': '/bin/bash', 19:42:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:03 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:03 INFO - 'USER': 'cltbld', 19:42:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:03 INFO - 'XPC_FLAGS': '0x0', 19:42:03 INFO - 'XPC_SERVICE_NAME': '0', 19:42:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:03 INFO - Downloading/unpacking psutil>=3.1.1 19:42:03 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 19:42:03 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 19:42:03 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 19:42:03 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 19:42:03 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 19:42:03 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 19:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:42:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:42:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:42:07 INFO - Installing collected packages: psutil 19:42:07 INFO - Running setup.py install for psutil 19:42:07 INFO - building 'psutil._psutil_osx' extension 19:42:07 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 19:42:07 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 19:42:07 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 19:42:07 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 19:42:08 INFO - building 'psutil._psutil_posix' extension 19:42:08 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 19:42:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:42:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:42:08 INFO - ^ 19:42:08 INFO - 1 warning generated. 19:42:08 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 19:42:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:42:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:42:08 INFO - Successfully installed psutil 19:42:08 INFO - Cleaning up... 19:42:08 INFO - Return code: 0 19:42:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:42:08 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')]} 19:42:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:08 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')]} 19:42:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:08 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:08 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 19:42:08 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 19:42:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:08 INFO - 'HOME': '/Users/cltbld', 19:42:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:08 INFO - 'LOGNAME': 'cltbld', 19:42:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:08 INFO - 'MOZ_NO_REMOTE': '1', 19:42:08 INFO - 'NO_EM_RESTART': '1', 19:42:08 INFO - 'PAGER': '/bin/cat', 19:42:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:08 INFO - 'PWD': '/builds/slave/test', 19:42:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:08 INFO - 'SHELL': '/bin/bash', 19:42:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:08 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:08 INFO - 'USER': 'cltbld', 19:42:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:08 INFO - 'XPC_FLAGS': '0x0', 19:42:08 INFO - 'XPC_SERVICE_NAME': '0', 19:42:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:42:08 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 19:42:08 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 19:42:08 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 19:42:08 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 19:42:08 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 19:42:08 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 19:42:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:42:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:42:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:42:11 INFO - Installing collected packages: mozsystemmonitor 19:42:11 INFO - Running setup.py install for mozsystemmonitor 19:42:11 INFO - Successfully installed mozsystemmonitor 19:42:11 INFO - Cleaning up... 19:42:11 INFO - Return code: 0 19:42:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:42:11 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')]} 19:42:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:11 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')]} 19:42:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:11 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:11 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 19:42:11 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 19:42:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:11 INFO - 'HOME': '/Users/cltbld', 19:42:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:11 INFO - 'LOGNAME': 'cltbld', 19:42:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:11 INFO - 'MOZ_NO_REMOTE': '1', 19:42:11 INFO - 'NO_EM_RESTART': '1', 19:42:11 INFO - 'PAGER': '/bin/cat', 19:42:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:11 INFO - 'PWD': '/builds/slave/test', 19:42:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:11 INFO - 'SHELL': '/bin/bash', 19:42:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:11 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:11 INFO - 'USER': 'cltbld', 19:42:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:11 INFO - 'XPC_FLAGS': '0x0', 19:42:11 INFO - 'XPC_SERVICE_NAME': '0', 19:42:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:11 INFO - Downloading/unpacking jsonschema==2.5.1 19:42:11 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 19:42:11 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 19:42:11 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 19:42:11 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 19:42:11 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 19:42:11 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 19:42:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:42:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:42:14 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 19:42:14 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 19:42:14 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 19:42:14 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 19:42:14 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 19:42:14 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 19:42:14 INFO - Downloading functools32-3.2.3-2.tar.gz 19:42:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:42:14 INFO - warning: no files found matching '*.txt' 19:42:14 INFO - no previously-included directories found matching 'build' 19:42:14 INFO - no previously-included directories found matching 'dist' 19:42:14 INFO - no previously-included directories found matching '.git*' 19:42:14 INFO - Installing collected packages: jsonschema, functools32 19:42:14 INFO - Running setup.py install for functools32 19:42:14 INFO - warning: no files found matching '*.txt' 19:42:14 INFO - no previously-included directories found matching 'build' 19:42:14 INFO - no previously-included directories found matching 'dist' 19:42:14 INFO - no previously-included directories found matching '.git*' 19:42:14 INFO - Successfully installed jsonschema functools32 19:42:14 INFO - Cleaning up... 19:42:15 INFO - Return code: 0 19:42:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:42:15 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')]} 19:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:15 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')]} 19:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:15 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:15 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 19:42:15 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 19:42:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:15 INFO - 'HOME': '/Users/cltbld', 19:42:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:15 INFO - 'LOGNAME': 'cltbld', 19:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:15 INFO - 'MOZ_NO_REMOTE': '1', 19:42:15 INFO - 'NO_EM_RESTART': '1', 19:42:15 INFO - 'PAGER': '/bin/cat', 19:42:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:15 INFO - 'PWD': '/builds/slave/test', 19:42:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:15 INFO - 'SHELL': '/bin/bash', 19:42:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:15 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:15 INFO - 'USER': 'cltbld', 19:42:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:15 INFO - 'XPC_FLAGS': '0x0', 19:42:15 INFO - 'XPC_SERVICE_NAME': '0', 19:42:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:42:15 INFO - Cleaning up... 19:42:15 INFO - Return code: 0 19:42:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:42:15 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')]} 19:42:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:15 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')]} 19:42:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:15 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:15 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 19:42:15 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 19:42:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:15 INFO - 'HOME': '/Users/cltbld', 19:42:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:15 INFO - 'LOGNAME': 'cltbld', 19:42:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:15 INFO - 'MOZ_NO_REMOTE': '1', 19:42:15 INFO - 'NO_EM_RESTART': '1', 19:42:15 INFO - 'PAGER': '/bin/cat', 19:42:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:15 INFO - 'PWD': '/builds/slave/test', 19:42:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:15 INFO - 'SHELL': '/bin/bash', 19:42:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:15 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:15 INFO - 'USER': 'cltbld', 19:42:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:15 INFO - 'XPC_FLAGS': '0x0', 19:42:15 INFO - 'XPC_SERVICE_NAME': '0', 19:42:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:15 INFO - Downloading/unpacking blobuploader==1.2.4 19:42:15 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 19:42:15 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 19:42:15 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 19:42:15 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 19:42:15 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 19:42:15 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 19:42:18 INFO - Downloading blobuploader-1.2.4.tar.gz 19:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:42:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:42:18 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 19:42:18 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 19:42:18 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 19:42:18 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 19:42:18 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 19:42:18 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 19:42:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:42:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:42:18 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 19:42:18 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 19:42:18 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 19:42:18 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 19:42:18 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 19:42:18 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 19:42:19 INFO - Downloading docopt-0.6.1.tar.gz 19:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:42:19 INFO - Installing collected packages: blobuploader, requests, docopt 19:42:19 INFO - Running setup.py install for blobuploader 19:42:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:42:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:42:19 INFO - Running setup.py install for requests 19:42:20 INFO - Running setup.py install for docopt 19:42:20 INFO - Successfully installed blobuploader requests docopt 19:42:20 INFO - Cleaning up... 19:42:20 INFO - Return code: 0 19:42:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:42:20 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')]} 19:42:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:20 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')]} 19:42:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:20 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:20 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 19:42:20 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 19:42:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:20 INFO - 'HOME': '/Users/cltbld', 19:42:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:20 INFO - 'LOGNAME': 'cltbld', 19:42:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:20 INFO - 'MOZ_NO_REMOTE': '1', 19:42:20 INFO - 'NO_EM_RESTART': '1', 19:42:20 INFO - 'PAGER': '/bin/cat', 19:42:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:20 INFO - 'PWD': '/builds/slave/test', 19:42:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:20 INFO - 'SHELL': '/bin/bash', 19:42:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:20 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:20 INFO - 'USER': 'cltbld', 19:42:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:20 INFO - 'XPC_FLAGS': '0x0', 19:42:20 INFO - 'XPC_SERVICE_NAME': '0', 19:42:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:42:20 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-oeDXQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:42:20 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-MI8FJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:42:20 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-OymClm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:42:20 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-PW1HaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:42:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:42:20 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-Ws8vPt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-8r5vos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-CWjEhG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-GySwea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-EIgHvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-TFCWki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-7cabgW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-C55qEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-tiWvol-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-ZqT0BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:42:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:21 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-Yy01BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:42:22 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-T9G6_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:42:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:42:22 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-Gr3FpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:42:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:42:22 INFO - Running setup.py install for manifestparser 19:42:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:42:22 INFO - Running setup.py install for mozcrash 19:42:22 INFO - Running setup.py install for mozdebug 19:42:22 INFO - Running setup.py install for mozdevice 19:42:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:42:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:42:22 INFO - Running setup.py install for mozfile 19:42:23 INFO - Running setup.py install for mozhttpd 19:42:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Running setup.py install for mozinfo 19:42:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Running setup.py install for mozInstall 19:42:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Running setup.py install for mozleak 19:42:23 INFO - Running setup.py install for mozlog 19:42:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Running setup.py install for moznetwork 19:42:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:42:23 INFO - Running setup.py install for mozprocess 19:42:24 INFO - Running setup.py install for mozprofile 19:42:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:42:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:42:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:42:24 INFO - Running setup.py install for mozrunner 19:42:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:42:24 INFO - Running setup.py install for mozscreenshot 19:42:24 INFO - Running setup.py install for moztest 19:42:24 INFO - Running setup.py install for mozversion 19:42:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:42:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:42:24 INFO - Cleaning up... 19:42:24 INFO - Return code: 0 19:42:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:42:24 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')]} 19:42:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:24 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')]} 19:42:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:24 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:24 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 19:42:24 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 19:42:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:24 INFO - 'HOME': '/Users/cltbld', 19:42:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:24 INFO - 'LOGNAME': 'cltbld', 19:42:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:24 INFO - 'MOZ_NO_REMOTE': '1', 19:42:24 INFO - 'NO_EM_RESTART': '1', 19:42:24 INFO - 'PAGER': '/bin/cat', 19:42:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:24 INFO - 'PWD': '/builds/slave/test', 19:42:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:24 INFO - 'SHELL': '/bin/bash', 19:42:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:24 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:24 INFO - 'USER': 'cltbld', 19:42:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:24 INFO - 'XPC_FLAGS': '0x0', 19:42:24 INFO - 'XPC_SERVICE_NAME': '0', 19:42:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-tcOnjJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:42:25 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)) 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-3bZ9K9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:42:25 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)) 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-k8y479-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:42:25 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)) 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-DZ42Jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:42:25 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)) 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-14k1Ke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:42:25 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)) 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-detvoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:42:25 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)) 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-3D3NA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:42:25 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)) 19:42:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:42:25 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-hjqhku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-EzBEOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-wyFdlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-ZxxpTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-Gbqw3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-RLk5uy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-v5v5Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-clFP8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-o7ClvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:42:26 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)) 19:42:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:42:26 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-1hiXpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:42:26 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)) 19:42:26 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)) 19:42:26 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)) 19:42:26 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)) 19:42:26 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)) 19:42:26 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)) 19:42:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:42:26 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 19:42:26 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 19:42:26 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 19:42:26 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 19:42:26 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 19:42:26 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 19:42:29 INFO - Downloading blessings-1.6.tar.gz 19:42:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:42:29 INFO - Installing collected packages: blessings 19:42:29 INFO - Running setup.py install for blessings 19:42:29 INFO - Successfully installed blessings 19:42:29 INFO - Cleaning up... 19:42:29 INFO - Return code: 0 19:42:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:42:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:42:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:42:30 INFO - Reading from file tmpfile_stdout 19:42:30 INFO - Current package versions: 19:42:30 INFO - blessings == 1.6 19:42:30 INFO - blobuploader == 1.2.4 19:42:30 INFO - docopt == 0.6.1 19:42:30 INFO - functools32 == 3.2.3-2 19:42:30 INFO - jsonschema == 2.5.1 19:42:30 INFO - manifestparser == 1.1 19:42:30 INFO - mozInstall == 1.12 19:42:30 INFO - mozcrash == 0.17 19:42:30 INFO - mozdebug == 0.1 19:42:30 INFO - mozdevice == 0.48 19:42:30 INFO - mozfile == 1.2 19:42:30 INFO - mozhttpd == 0.7 19:42:30 INFO - mozinfo == 0.9 19:42:30 INFO - mozleak == 0.1 19:42:30 INFO - mozlog == 3.4 19:42:30 INFO - moznetwork == 0.27 19:42:30 INFO - mozprocess == 0.23 19:42:30 INFO - mozprofile == 0.28 19:42:30 INFO - mozrunner == 6.12 19:42:30 INFO - mozscreenshot == 0.1 19:42:30 INFO - mozsystemmonitor == 0.3 19:42:30 INFO - moztest == 0.7 19:42:30 INFO - mozversion == 1.4 19:42:30 INFO - psutil == 3.1.1 19:42:30 INFO - requests == 1.2.3 19:42:30 INFO - wsgiref == 0.1.2 19:42:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:42:30 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')]} 19:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:30 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')]} 19:42:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:30 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:30 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 19:42:30 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 19:42:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:30 INFO - 'HOME': '/Users/cltbld', 19:42:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:30 INFO - 'LOGNAME': 'cltbld', 19:42:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:30 INFO - 'MOZ_NO_REMOTE': '1', 19:42:30 INFO - 'NO_EM_RESTART': '1', 19:42:30 INFO - 'PAGER': '/bin/cat', 19:42:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:30 INFO - 'PWD': '/builds/slave/test', 19:42:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:30 INFO - 'SHELL': '/bin/bash', 19:42:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:30 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:30 INFO - 'USER': 'cltbld', 19:42:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:30 INFO - 'XPC_FLAGS': '0x0', 19:42:30 INFO - 'XPC_SERVICE_NAME': '0', 19:42:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 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)) 19:42:30 INFO - Cleaning up... 19:42:30 INFO - Return code: 0 19:42:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:42:30 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')]} 19:42:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:31 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')]} 19:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:42:31 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 0x10f245490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1bb570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffd32c99d50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, '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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 19:42:31 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 19:42:31 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 19:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:42:31 INFO - 'HOME': '/Users/cltbld', 19:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:42:31 INFO - 'LOGNAME': 'cltbld', 19:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:42:31 INFO - 'MOZ_NO_REMOTE': '1', 19:42:31 INFO - 'NO_EM_RESTART': '1', 19:42:31 INFO - 'PAGER': '/bin/cat', 19:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:42:31 INFO - 'PWD': '/builds/slave/test', 19:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:42:31 INFO - 'SHELL': '/bin/bash', 19:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:42:31 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:42:31 INFO - 'USER': 'cltbld', 19:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:42:31 INFO - 'XPC_FLAGS': '0x0', 19:42:31 INFO - 'XPC_SERVICE_NAME': '0', 19:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:42:31 INFO - Cleaning up... 19:42:31 INFO - Return code: 0 19:42:31 INFO - Running post-action listener: _resource_record_post_action 19:42:31 INFO - Running post-action listener: _start_resource_monitoring 19:42:31 INFO - Starting resource monitoring. 19:42:31 INFO - [mozharness: 2016-10-21 02:42:31.461314Z] Finished create-virtualenv step (success) 19:42:31 INFO - [mozharness: 2016-10-21 02:42:31.462327Z] Running install step. 19:42:31 INFO - Running pre-action listener: _resource_record_pre_action 19:42:31 INFO - Running main action method: install 19:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:42:31 INFO - Reading from file tmpfile_stdout 19:42:31 INFO - Detecting whether we're running mozinstall >=1.0... 19:42:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:42:31 INFO - Reading from file tmpfile_stdout 19:42:31 INFO - Output received: 19:42:31 INFO - Usage: mozinstall [options] installer 19:42:31 INFO - Options: 19:42:31 INFO - -h, --help show this help message and exit 19:42:31 INFO - -d DEST, --destination=DEST 19:42:31 INFO - Directory to install application into. [default: 19:42:31 INFO - "/builds/slave/test"] 19:42:31 INFO - --app=APP Application being installed. [default: firefox] 19:42:31 INFO - mkdir: /builds/slave/test/build/application 19:42:31 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'] 19:42:31 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 19:43:03 INFO - Reading from file tmpfile_stdout 19:43:03 INFO - Output received: 19:43:03 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 19:43:03 INFO - Running post-action listener: _resource_record_post_action 19:43:03 INFO - [mozharness: 2016-10-21 02:43:03.837879Z] Finished install step (success) 19:43:03 INFO - [mozharness: 2016-10-21 02:43:03.838008Z] Running run-tests step. 19:43:03 INFO - Running pre-action listener: _resource_record_pre_action 19:43:03 INFO - Running main action method: run_tests 19:43:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:43:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:43:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:43:03 INFO - 2016-10-20 19:43:03.851 screenresolution[1637:7349] starting screenresolution argv=screenresolution get 19:43:03 INFO - 2016-10-20 19:43:03.853 screenresolution[1637:7349] Display 0: 1600x1200x32@60 19:43:03 INFO - 2016-10-20 19:43:03.858 screenresolution[1638:7351] starting screenresolution argv=screenresolution list 19:43:03 INFO - Available Modes on Display 0 19:43:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:43:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:43:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:43:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:43:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:43:04 INFO - Intel Iris: 19:43:04 INFO - Chipset Model: Intel Iris 19:43:04 INFO - Type: GPU 19:43:04 INFO - Bus: Built-In 19:43:04 INFO - VRAM (Dynamic, Max): 1536 MB 19:43:04 INFO - Vendor: Intel (0x8086) 19:43:04 INFO - Device ID: 0x0a2e 19:43:04 INFO - Revision ID: 0x0009 19:43:04 INFO - Displays: 19:43:04 INFO - Display: 19:43:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:43:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:43:04 INFO - Display Serial Number: 1600x1200 60 19:43:04 INFO - Main Display: Yes 19:43:04 INFO - Mirror: Off 19:43:04 INFO - Online: Yes 19:43:04 INFO - Rotation: Supported 19:43:04 INFO - Return code: 0 19:43:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:43:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:43:04 INFO - Python 2.7.3 19:43:04 INFO - Return code: 0 19:43:04 INFO - grabbing minidump binary from tooltool 19:43:04 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')]} 19:43:04 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 0x10f059d30>, '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 0x10eebfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f051b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:43:04 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 19:43:04 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 19:43:04 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 19:43:04 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:43:04 INFO - Return code: 0 19:43:04 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:43:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:43:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:43:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:43:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:43:04 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/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 19:43:04 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/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0003 --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 19:43:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.e9PbF4fY07/Render', 19:43:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:43:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:43:04 INFO - 'HOME': '/Users/cltbld', 19:43:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:43:04 INFO - 'LOGNAME': 'cltbld', 19:43:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:43:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:43:04 INFO - 'MOZ_NO_REMOTE': '1', 19:43:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:43:04 INFO - 'NO_EM_RESTART': '1', 19:43:04 INFO - 'PAGER': '/bin/cat', 19:43:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:43:04 INFO - 'PWD': '/builds/slave/test', 19:43:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:43:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:43:04 INFO - 'SHELL': '/bin/bash', 19:43:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.lZ8MG7zA9f/Listeners', 19:43:04 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 19:43:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:43:04 INFO - 'USER': 'cltbld', 19:43:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:43:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:43:04 INFO - 'XPC_FLAGS': '0x0', 19:43:04 INFO - 'XPC_SERVICE_NAME': '0', 19:43:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:43:04 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/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 19:43:04 INFO - mozversion application_buildid: 20161020182249 19:43:04 INFO - mozversion application_changeset: 3a45c899d5015ba64e1cdbe206687951561e6fca 19:43:04 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:43:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:43:04 INFO - mozversion application_name: Firefox 19:43:04 INFO - mozversion application_remotingname: firefox-dev 19:43:04 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:43:04 INFO - mozversion application_vendor: Mozilla 19:43:04 INFO - mozversion application_version: 51.0a2 19:43:04 INFO - mozversion platform_buildid: 20161020182249 19:43:04 INFO - mozversion platform_changeset: 3a45c899d5015ba64e1cdbe206687951561e6fca 19:43:04 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:43:04 INFO - mozversion platform_version: 51.0a2 19:43:04 INFO - using testdate: 1477017784 19:43:04 INFO - actual date: 1477017784 19:43:04 INFO - starting webserver on 'localhost:49266' 19:43:04 INFO - SUITE-START | Running 2 tests 19:43:04 INFO - TEST-START | dromaeo_css 19:43:04 INFO - operating with platform_type : mac_ 19:43:04 INFO - Initialising browser for dromaeo_css test... 19:43:04 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmpSfmX9U/profile http://localhost:49266/getInfo.html) 19:43:07 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 19:43:07 INFO - PROCESS | 1648 | colorDepth:24 19:43:07 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 19:43:07 INFO - PROCESS | 1648 | __metrics 19:43:07 ERROR - PROCESS | 1648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 19:43:07 INFO - TEST-INFO | 1648: exit 0 19:43:07 INFO - Browser initialized. 19:43:07 INFO - Running cycle 1/1 for dromaeo_css test... 19:43:07 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmpSfmX9U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:43:19 INFO - PROCESS | 1650 | RSS: Main: 225406976 19:43:19 INFO - PROCESS | 1650 | 19:44:09 INFO - PROCESS | 1650 | 1477017849457 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] 19:46:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 19:46:22 INFO - PROCESS | 1650 | RSS: Main: 237117440 19:46:22 INFO - PROCESS | 1650 | 19:49:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 19:49:25 INFO - PROCESS | 1650 | RSS: Main: 248926208 19:49:25 INFO - PROCESS | 1650 | 19:52:26 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 19:52:27 INFO - PROCESS | 1650 | RSS: Main: 251359232 19:52:27 INFO - PROCESS | 1650 | 19:55:29 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 19:55:30 INFO - PROCESS | 1650 | RSS: Main: 251686912 19:55:30 INFO - PROCESS | 1650 | 19:58:32 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 19:58:33 INFO - PROCESS | 1650 | RSS: Main: 256212992 19:58:33 INFO - PROCESS | 1650 | 20:01:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 20:01:36 INFO - PROCESS | 1650 | RSS: Main: 257896448 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | __start_tp_report 20:01:36 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 20:01:36 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 20:01:36 INFO - PROCESS | 1650 | |i|pagename|runs| 20:01:36 INFO - PROCESS | 1650 | |0;dojo.html;2807.929801754956;3319.419598489365;3329.0012996101177;3330.8834190803295;3343.5820522434688;5421.349438067433;5423.701696406696;5471.589630777693;5476.7535460904255;5534;5458.972705136469;5500.092484740023;5510.448955104487;5522.723863806804;5533.6956467394275;5039.874003149914;5055.266986286986;5109.208072748711;5124.231365295198;5159;5057.9494205057845;5107.69353838769;5124.103281925667;5140.203268493371;5149.897002059956;4999.32509111269;5043.344365232515;5113.642045056848;5115.820946266881;5116.002379535992;5029.3964724232965;5094.3886733591835;5095.184770436731;5117.923231151536;5145.84562463123;4999.275105109775;5069.822556210552;5078.26365177051;5082.872928176788;5115.411727651331;4964.726940018298;5309.946900531023;5421.756020979065;5452.809151679712;5614.9438505615235;4757.286407038937;5868.76524939002;5935.465808077251;5996.550258730569;6079.300880398767;6097.20736304282;6102.176206212149;6110.052941794029;6111.419415155553;6130.938690613081;5604.355499117612;5644.971775141098;5650.858728531778;5653.886922261614;5659.490645841894;4917.286993385939;5393.164059570773;5837.854053648693;6060.363661815534;6127;5894.557908156906;5916.497097746654;5945.821625351246;5966.791162309299;6003.0695242237525;5191.870203244949;5992.850178745566;6060.303065147476;6061.242344706911;6071.3928607139815;5817.825465236049;5862.5896187267335;5927;5954.910676339859;5956;6000.849978750479;6048.758049677964;6068.908966365508;6070.453659170696;6091.177691011657;3845.884693438927;4282.8222238884555;4435.112977404532;4781.521847815191;4815.061063092733;3629.7277704172293;4093.1199792044854;4229.217594744982;4274.764887931132;4322.37325587788;5043.646944713835;5051.747412629354;5598.776048958078;5639.971800141055;5680.034394153004;4925.581325587294;4968;6004.219451471281;6040.879182416327;6066.726997285133;5047.570956468741;5469.535089517435;5517.503424691797;5607.8598035048635;5684.431556844283;4430.800613972315;5233.973830130825;5235.476452354734;5276.36683597963;5300.09898317287;6192.318844927145;6197.783077592263;6199.3490683478485;6221.9377806222265;6225.1907252057845;5920.259967504062;5967.985442474876;5971.164037034731;6008.849778755566;6109.358517355614;6109.969450152721;6163.84590385244;6183.598066125687;6192.566520343533;6196.721147548281;5923.614965027259;5953.523718102628;5962.582619216787;5971.193888825127;5999.190109335358;5917.37867523921;5933;6033.366496517802;6035.245594300713;6041.607295525952;5699.430056994267;5883.0881213411985;5910.852228694317;5955.076963070731;5998.940010599838;5883.558733094949;5892.263467066617;5909.91135132982;5938.257717785277;5939.970300148644;4542.954570454253;5577.247071645276;5713.9714301429885;5754.108113242454;5769.653820770599;5694.117411801178;5797.623154494944;5827.621204621686;5866.560007999503;5905.173275741486;5652.519535839499;5690.118031705092;5699.2590963174525;5701.657900525982;5732.57005724564 20:01:36 INFO - PROCESS | 1650 | |1;ext.html;467.5534864204684;473.38696388177306;497.8449996009255;516.0994065355953;529.4784637132424;37130.443043354375;40823.795881020626;40838.97902552434;43082.784586077025;43236.13527729452;41674;42088.52690155845;42108.157836843246;42186.578134218646;42228.788856055755;9833.11501964823;9976.551055202497;10024.74938126549;10040.548175332127;10056.547455364525;9791.510424478784;9872.45701486418;9880.703578892644;9886.752831179207;9952.950235248814;9886.258530610234;9886.9505652472;9896.257780666443;9923.503824808768;9930.10629043386;9547.567864820263;9817.214622830192;9871.259655525828;9875.90124098757;9897.35667181631;9234.86147707785;9889.109980101824;9905.504724763732;9913.553890074963;9960.551775170063;40687.38968915468;41004;41010.179796404205;41054.58945410538;41146.58853411458;2643;3023.7753709747585;3126.937461250785;3431.1422144463886;3577.928441431183;25786.613200802003;27472.45055098907;29789;30173.0948071556;30507.08478745619;2630.3424143964007;3083.4449799036165;3128.03031060372;3153.952690709641;3165.7625678074005;406393.96803015796;407880;410972;413267;414819.999999997;61578.69210653918;61689.07466388008;61858.381416185264;61867;62444.37555624476;27205.455890882073;33910;34569.30861382758;35999.82000090035;36043;16546.83453165453;16610.003399796053;16671.166441677866;16749.83250167507;16780.32878684839;12885.742285154245;12893.226406415644;12898.097133200774;12934.159279646792;12968.546100886613;19206.807931920783;19232.03839808032;19234.03829808504;19248.037598120318;19332.8066719331;6733.764318248838;7252.492325537267;7921.049474063034;8202.220789025152;8274.338052955749;864.9264812491009;868.9204186345049;973.7662960889336;985.3987270685137;1111.5387114347616;23762;25577.360565986;27641.308967275578;30832.53751193734;31058.068257952298;783.1298291760747;951.4206417347309;1001.7195185348114;1059.1579694143174;1099.7140743406771;12135.5145794169;15090.471833485995;15102.39590416393;15200.315985780666;15414.537563873102;600368;601902;605086;609390;609622;54105.45894541083;54496.45503544993;54828.90342193213;54867.725661372235;54961.725191373785;1370.869767372098;1371.7050834070724;1390.8261467316788;1391.3460673483446;1395.539471974246;28068.578971315037;28937.7106228935;29081.85459072691;29103.85448072746;29631.85184074152;48686.26970595515;49264.75367623139;49378.75310623424;49411;49425.75287123541;554499;561634;564817;564976;565972;25826;26010.08964686227;26031.349216269744;26112.8694356527;26137.869310654085;37848.86453406402;39843.80078099591;44650.55349446464;45121.77439112784;45238.321425177994;36031.63968360283;36175.914722558366;37562.2487550242;38090.80954595209;39253.41119883147;31184.440777960557;37410.43884341683;37789.244215116094;38477.038074047254;38936.41595376015;36788;37052.81473592615;37447.43828842515;37540;37555.06112347213;32259.35481290408;33304.666953330154;33305.50041749327;33638.15904602405;34033;25309.493810123327;25383;25486.82247637991;25683.743162568135;25821.6126758095 20:01:36 INFO - PROCESS | 1650 | |2;jquery.html;346.27455480767793;384.3504477433136;386.7988645904131;390.8671051842373;409.3470913892341;18871.339503117393;20333.694994575057;20423.387298381072;20619.484512887168;20649.690254646193;20031.397488200946;20369.694454583194;20749;20900.8954955225;20995.055222514984;3691.8338674759702;4978.303037574742;5188.740562971855;5907.936571417144;6091.908621370683;6030.185924900148;6115.113308570255;6124.785632502863;6140.171076904606;6140.324564297946;5822.243108395903;6080.331163572026;6164.383561643845;6172.074188871683;6219.471344935686;6095.634261944298;6184.196054512907;6199.225096862892;6225.906611400833;6252.531060170482;5860.560457965669;6073.3622969588;6075.179850720185;6084.847878803021;6093.542984276152;13315.134516256412;17146.57133571658;20561.691574626242;25776.871115644488;25969;1860.7860096088987;2211.977880221193;2213.546223024276;2889;3016.668166501683;9748.463834489101;9859.605615775361;10047.799044019152;10363.740906477398;10428.89571104287;1884.679604467244;1900.5818719881604;1907.4754442528276;1925.1817977359706;1947.0946010105226;122718;125715;126435.36782316121;128523;128924.35537822345;11423.942880285545;11710.180287379972;11825.645230643095;11827.822582661267;11920.821187682192;14562;14636.926815365856;14667.706645867023;14685.926570367294;14871.851281487263;8637.784055398539;8651.870221946676;8707.172818582225;8780.692675756318;8796.824063518694;7244.275572442819;8213.507189568645;8695.913040869636;8711.303095752324;8822.338324625678;4474.060447306102;4504.954950450519;4595.632349412039;4612.815487380467;4649;1681.4031018988328;1926.6435709393807;1950.6781381072249;2013.3255359454747;2015.3147929703678;842.1578421578422;852.9744107676779;883.8364902493059;989.6981420666766;1025.738436698637;20523.384298471068;21249.256276030264;21384.251551195634;21521;21635;871.285545852395;941.1294552538874;951.0822056715303;957.4686049242737;959.4195511715451;10086.697399078039;11169;11193.10455163585;11221.775564488664;11347.319160850375;528100;531529.3423532858;540868;554163;608417;100060;104534;122773;128430.35784821016;128759;820.4584973917305;951;965.748905284617;972.2027937091658;973.8149751547184;18296.085195740427;18791.812081879005;18958.526036848638;18984.52538686544;19118.617627647647;55449.72275138598;55649;56073.43926560682;57629.71185144047;57860.71069644793;65263.67368163129;74481.62759186169;77118.91524338964;80102.79845802434;83588.58205708933;7968.402369822171;8045.155258697752;8248.175182481704;8297.419180657296;8338.791530211793;8906.73279801607;11710.180287379802;12444.253344798979;12450.626481205578;13170.934145329595;11412.972832445119;11432.828507572227;11492.94253528727;11569.132315076571;11727.237729547553;8703.869441958503;10085.848712269175;11082;11288.717782055513;11509.424528773696;10846.895283589261;11469.369184694922;11711.238769479956;11827.881721182677;11916.702082448008;8324;8356.958215208884;8368;8435.704750333709;8444.957775211331;10965.342079475256;11103.555857765921;11355.886441135814;11385.829212561985;11801.763964720829 20:01:36 INFO - PROCESS | 1650 | |3;mootools.html;1500.722366362223;1536.731072062389;1733.921973511192;1802.9549261268457;1852.8888266703998;8041.195880411956;8330.541820199887;8526.488410695354;9064.320175986812;9092.909070909289;8575.228229459348;8901.109889011095;8920.866187007185;8982.730518084452;9005.009448960609;2355.6702061711376;2374.964375534368;2382.2019623426086;2386.2721869829693;2389.498205376873;2382.5115851250453;2418.3712234818986;2427.599446091393;2434.184548176363;2443.389152711822;2408.51829634073;2419.8669073200967;2428.5142971405703;2433.2092070077206;2434.415740222352;2387.403149212697;2396.4488167721347;2403.8677872716994;2409.229046705046;2425.175440350272;2387.3554140382175;2402.25530085674;2410.8794560271917;2410.987945060281;2412.300432874464;8468.872966905501;8491.490510569385;9003.864942025875;9072.138146876036;9099.909000909973;5259.684418934876;5479.424660410639;5504.779808807642;5511.366192887829;5519.641223320471;3532.876349327787;3625.8368373422995;3656.7257455690665;3672.320620685182;3698.9630103699155;1048.391932679052;1072.083368719749;1081.3079629037422;1095.901368876805;1108.8613923259593;9340.439573625605;9855.408675479493;11135.832962505569;11728;11881.287122772661;4115.32097203958;4645.117427688729;4696.835610753607;4917.5082491751255;4950.653454258239;10060.899391006142;10163.288569800043;10170.389776613427;10173.186145108373;10206.744831379276;5481.780728770885;5484.451554844563;5489.917651235235;5490.80782172622;5492.148716948879;4441.511433742286;4599.586037256663;4800.495947925418;4929.457759646436;5013.598912087097;4035.8587449439715;4037.1118353962083;4127.814248358831;4133.1940271647345;4157.355609880473;1168.3982748884162;1298.8375404013543;1314.2377421095741;1331.301066939845;1339.055965544289;697.1912581405545;905.8686490458847;923.1599244687302;928.8606708993569;933.9673111441067;5821.679807610622;5864.765409383577;5967.492763115097;6052.6671033092725;6122.295935967331;441.9248727716296;990.980180396388;1003.9498025098716;1011.4032720694826;1056.6090546497692;3882.5340959085092;3967.6032396760093;4015.9478796114577;4060.3503439449546;4102.077032667686;10248.948755256326;10873;10928.617498387519;10943.616973405893;10947.233693641529;10543.789124217472;10867.45662716861;10875.510602022929;10926.945365273123;10971.286866353661;6787.490938179656;8433.03020152678;8437;8472.65330194582;8506.702265420805;5749.338826034892;5817.069268916953;5863.973804584266;5884.6469211847425;5936.990711578956;10014;10117.291789574954;10187.490625468845;10263.332883362558;10301.896981030093;9914.107730304018;10543.736406589589;10555.736106597396;10558.419286938984;10585.788284234119;6627.204735431779;6820.590764554143;6995.265497122932;7128.108986376703;7264.527805692613;8412.579371031547;8561.22948934574;8654.870176947225;8660.696875609576;8668.609912554077;7574.545527268381;7680.769576912701;7733.419993500623;7835.882461763192;7850.4112191587;7422.888656670262;7473.364763995121;7547.245275472409;7647.732329368446;7648.541087534766;7065.293470652894;7190.928090719026;7195.352418282379;7203.495755297288;7230.6384680766805;4304.332828411601;4337.089211265544;4363.759993200404;5002.2496625506465;5084.847454576221;4033.9596604033586;4195.916081678289;4994.350734404649;5185.377754669464;5264.947350526599 20:01:36 INFO - PROCESS | 1650 | |4;prototype.html;259.74934188508087;297.2790981868967;301.641047153887;306.7898489534669;311.08851066375513;4298.441202643652;4440.822367105316;5105;5329.626926115174;5338.67967921925;4103.261412945669;4808.903821923559;5084.466295924334;5208.869778255536;5241.737913104339;3710.7402481826284;4059.3302105152616;4061.1877624475223;4067.9389809152885;4075.3886916962547;3757.7557458765227;4018.276710192164;4064.979675101635;4067.4712287402594;4075.612816782416;3345.059865278145;3942.7634341939574;3943.4084887266854;3957.515931525678;3966.7223294369405;3304.107890869464;3441.0537102296817;3785.8296376663116;3984.7409918355215;4018.1160144768105;3433.866823948091;3439.1574064354395;3439.9212704629217;3444.2422667013466;3448.8792892248903;4151.418801367811;4797.057191837312;5056.898862022776;5106.872328191787;5122.974385128088;4177.373393990895;4520.960179158812;4524.886877828048;4533.2746760518485;4542.343413552089;4528.415054730818;5486.780528778844;5490.80782172626;5523.8066667666435;5554.306386253137;3588.946165807515;3753.230587729509;3758.542141230075;3759.8156580677;3770;4612.953870461286;4797.568218860284;4868.634852386085;5715.885682286373;5758.596898217126;3634.2913131939545;3806.8286927088348;3814.4659747635355;3816.46569480273;3840.1743625120735;3244.383567122239;3551.786892786441;3682.4660424238336;3892.8832135035996;3907.5310962684093;3671.52270204877;3731.8134093295225;4018.678505719535;4431.246688063037;4463.888402789891;5489.176623506426;5527.613067085265;5548.917960997647;5571.4150014248735;5572.442755724395;1010.4392062405435;1041.9791604167874;1255.8116282557507;1283.9229646221256;1318.1432069155126;709.8260926073145;753.6081237756335;870.9679030349057;892.6920212526668;894.8367122740411;4925.064237794808;5136.666116702402;5198.740062996835;5234.345706786652;5269.973650131725;5180;5316.893662126736;5606.495415412633;5622.775088996476;5661.801836935688;4377.430933978562;4770.689905156223;5153.3815942087185;5220.321358223407;5229.790808367698;2934.457125431802;2940.603018592463;3017.125033740235;3020.8338541379994;3025.7125573070525;5060.493950604984;5962.493188078975;5966.925953328356;6002.759889604455;6019.4883434908525;4843.885906241584;4860.708357498562;5660.575456840671;5873.4126587340925;5934.3175534814045;5315.707636079976;5789.363170051291;5888.5289176865745;6018.879622407615;6020.471402011166;5399.757010934439;5699.572532060195;5716.571257155813;5720.914186287126;5752.252207213036;4265.91468170641;5120.4111527174855;5133.998870220271;5679.77280908759;5691.231683722644;5893.941060589511;5997.280326360865;6012.6392416455155;6026.487748541423;6057.818265451867;3669.422148476074;3683.963160368362;3806.62961333914;3835.328817456878;3863.304605170984;5316.840494785162;5448.809291674773;5704.258446401941;5717.7141142941855;5729.684867332337;4985.825496107764;5440.93244567062;5562.554995600423;5605.831825045255;5619.606627536034;5571.66570005801;5579;5586.162075688517;5609.523190528851;5631.2960879890015;4742.529815757126;5213.582913366846;5440.646357986877;5458.789190377904;5516.558675305886;5041.949580504148;5204.843854684365;5581.972090139523;5589.289194740466;5601.467860553241;4739.59713424349;4762.976185119191;4915.139850526072;5448.536874365724;5473.31583552056 20:01:36 INFO - PROCESS | 1650 | |5;yui.html;677.3565113142514;704.1514974455781;760.5550752809606;785.6189747972229;801.4990630855717;15109.697806043872;15484.225788710575;15496.845031549681;15498.922505387485;15566;11192.776144477126;12493.68765780856;13971.58085257444;14069.296535173251;14080.929595352034;681.6012632609917;700.2997002997002;836.7406104107715;851.8168593752342;866.7096522664915;834.5034704350932;850.5109562001843;853.6585365853646;854.4531499840107;859.6647307550061;910.6311943662827;910.713125365511;913.3515204204989;915.450729562264;916.6516723645005;898.4025622960723;904.8959369672506;905.9275257979378;908.2280061947358;912.5938957164065;621.860081481663;664.0835646807424;675.8344205669642;680.0479328939475;682.8497730499332;14557.344919478543;14663.41346346145;14718.116912985255;14755.040922340013;14764.557063288119;14532.418703251857;14540.563783086418;14570.92714536431;14578.489752858704;14620.488282910048;11533.711657208552;11755.823662645067;11792.23350482216;11941.044716422752;12007.45966431504;3783.4324851272254;3842.4044273137706;3879.495665563487;3900.609939006105;3969.3847453644444;92538;117066;126075;126934.36532817369;127044;9047.140521650434;10644.733881653021;10905.83641245382;11190.216684832147;11378.487968041292;21442.892785536285;21493.462663433227;21540.56918861614;21557.78442215589;21597.46006349854;7922.445428820042;8043.758687239392;8181.959090204511;8308.169183081643;8455.069942306342;4379.890502737393;4463.531329210451;4525.728456292567;4682.1338052460405;4731.455882573479;3513.1568423578155;3634.309481198564;3662.7436079474714;3662.8901132966053;3676.0993556578273;657.5397221944658;660.3825423229296;662.1987395251703;677.9864402712017;684.4319215051495;601.1823919469518;644.9806505804834;660.9438197753245;686;686.1286166568431;8904.376693631384;9657.672412071437;9686.854697179548;9820.558074886505;9908.702738917844;669.1635455680399;673.2829536543566;673.4578664175287;675.3179288918129;684.6234570985938;4240.385144154142;4562.817487300537;4564.885877853014;4585.830613193681;4687.273472611751;100165;126462.51531135202;143032;151013.48986510214;162619;109367.35948960773;130065;132688;137483;141687;75122;101516.99999999852;106662;108435;108592;8652.996375552206;9212.677556285498;9598.520073996133;10185.541650625888;10211.897881021094;60798.69600651968;62238.37761622507;62559.06161407491;62911.37088629055;63934.68032659993;89784.47047530474;89999.55000224957;91260;91668.54165729128;93497.532512337;12600.74798504043;12693;12972.610821675366;13027.47890084386;13146.948244140254;14377.7843332348;14391.424343026161;14440.397135904506;14611.707765844836;14697.41210351574;10262.384256944608;10899.455027248765;10945.945270273598;11052.723681908017;13850.376733046836;12951.093423460266;13550.322483875963;13610.727785444038;13631.79552306736;13736.87326199736;13149.21104733719;13316.334183290603;13562.796558051834;13610.795838062239;14175.93680473948;9556.092171243721;10844.67465976022;11005.449727513433;11059.115270778157;11749.353785541536;11017.338959662446;11369.147313951322;11562.190646654653;11673.299602023906;11762.94118529402 20:01:36 INFO - PROCESS | 1650 | __end_tp_report 20:01:36 INFO - PROCESS | 1650 | __start_cc_report 20:01:36 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,368 20:01:36 INFO - PROCESS | 1650 | __end_cc_report 20:01:36 INFO - PROCESS | 1650 | __startTimestamp1477018896214__endTimestamp 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | ------- Summary: start ------- 20:01:36 INFO - PROCESS | 1650 | Number of tests: 6 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5489.54 Median:5680.03 stddev:660.71 (11.6%) stddev-sans-first:628.35 20:01:36 INFO - PROCESS | 1650 | Values: 2807.9 3319.4 3329.0 3330.9 3343.6 5421.3 5423.7 5471.6 5476.8 5534.0 5459.0 5500.1 5510.4 5522.7 5533.7 5039.9 5055.3 5109.2 5124.2 5159.0 5057.9 5107.7 5124.1 5140.2 5149.9 4999.3 5043.3 5113.6 5115.8 5116.0 5029.4 5094.4 5095.2 5117.9 5145.8 4999.3 5069.8 5078.3 5082.9 5115.4 4964.7 5309.9 5421.8 5452.8 5614.9 4757.3 5868.8 5935.5 5996.6 6079.3 6097.2 6102.2 6110.1 6111.4 6130.9 5604.4 5645.0 5650.9 5653.9 5659.5 4917.3 5393.2 5837.9 6060.4 6127.0 5894.6 5916.5 5945.8 5966.8 6003.1 5191.9 5992.9 6060.3 6061.2 6071.4 5817.8 5862.6 5927.0 5954.9 5956.0 6000.8 6048.8 6068.9 6070.5 6091.2 3845.9 4282.8 4435.1 4781.5 4815.1 3629.7 4093.1 4229.2 4274.8 4322.4 5043.6 5051.7 5598.8 5640.0 5680.0 4925.6 4968.0 6004.2 6040.9 6066.7 5047.6 5469.5 5517.5 5607.9 5684.4 4430.8 5234.0 5235.5 5276.4 5300.1 6192.3 6197.8 6199.3 6221.9 6225.2 5920.3 5968.0 5971.2 6008.8 6109.4 6110.0 6163.8 6183.6 6192.6 6196.7 5923.6 5953.5 5962.6 5971.2 5999.2 5917.4 5933.0 6033.4 6035.2 6041.6 5699.4 5883.1 5910.9 5955.1 5998.9 5883.6 5892.3 5909.9 5938.3 5940.0 4543.0 5577.2 5714.0 5754.1 5769.7 5694.1 5797.6 5827.6 5866.6 5905.2 5652.5 5690.1 5699.3 5701.7 5732.6 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:65458.87 Median:38283.92 stddev:142310.48 (371.7%) stddev-sans-first:142626.04 20:01:36 INFO - PROCESS | 1650 | Values: 467.6 473.4 497.8 516.1 529.5 37130.4 40823.8 40839.0 43082.8 43236.1 41674.0 42088.5 42108.2 42186.6 42228.8 9833.1 9976.6 10024.7 10040.5 10056.5 9791.5 9872.5 9880.7 9886.8 9953.0 9886.3 9887.0 9896.3 9923.5 9930.1 9547.6 9817.2 9871.3 9875.9 9897.4 9234.9 9889.1 9905.5 9913.6 9960.6 40687.4 41004.0 41010.2 41054.6 41146.6 2643.0 3023.8 3126.9 3431.1 3577.9 25786.6 27472.5 29789.0 30173.1 30507.1 2630.3 3083.4 3128.0 3154.0 3165.8 406394.0 407880.0 410972.0 413267.0 414820.0 61578.7 61689.1 61858.4 61867.0 62444.4 27205.5 33910.0 34569.3 35999.8 36043.0 16546.8 16610.0 16671.2 16749.8 16780.3 12885.7 12893.2 12898.1 12934.2 12968.5 19206.8 19232.0 19234.0 19248.0 19332.8 6733.8 7252.5 7921.0 8202.2 8274.3 864.9 868.9 973.8 985.4 1111.5 23762.0 25577.4 27641.3 30832.5 31058.1 783.1 951.4 1001.7 1059.2 1099.7 12135.5 15090.5 15102.4 15200.3 15414.5 600368.0 601902.0 605086.0 609390.0 609622.0 54105.5 54496.5 54828.9 54867.7 54961.7 1370.9 1371.7 1390.8 1391.3 1395.5 28068.6 28937.7 29081.9 29103.9 29631.9 48686.3 49264.8 49378.8 49411.0 49425.8 554499.0 561634.0 564817.0 564976.0 565972.0 25826.0 26010.1 26031.3 26112.9 26137.9 37848.9 39843.8 44650.6 45121.8 45238.3 36031.6 36175.9 37562.2 38090.8 39253.4 31184.4 37410.4 37789.2 38477.0 38936.4 36788.0 37052.8 37447.4 37540.0 37555.1 32259.4 33304.7 33305.5 33638.2 34033.0 25309.5 25383.0 25486.8 25683.7 25821.6 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:33652.63 Median:2952.83 stddev:92772.90 (3141.8%) stddev-sans-first:92999.45 20:01:36 INFO - PROCESS | 1650 | Values: 346.3 384.4 386.8 390.9 409.3 18871.3 20333.7 20423.4 20619.5 20649.7 20031.4 20369.7 20749.0 20900.9 20995.1 3691.8 4978.3 5188.7 5907.9 6091.9 6030.2 6115.1 6124.8 6140.2 6140.3 5822.2 6080.3 6164.4 6172.1 6219.5 6095.6 6184.2 6199.2 6225.9 6252.5 5860.6 6073.4 6075.2 6084.8 6093.5 13315.1 17146.6 20561.7 25776.9 25969.0 1860.8 2212.0 2213.5 2889.0 3016.7 9748.5 9859.6 10047.8 10363.7 10428.9 1884.7 1900.6 1907.5 1925.2 1947.1 122718.0 125715.0 126435.4 128523.0 128924.4 11423.9 11710.2 11825.6 11827.8 11920.8 14562.0 14636.9 14667.7 14685.9 14871.9 8637.8 8651.9 8707.2 8780.7 8796.8 7244.3 8213.5 8695.9 8711.3 8822.3 4474.1 4505.0 4595.6 4612.8 4649.0 1681.4 1926.6 1950.7 2013.3 2015.3 842.2 853.0 883.8 989.7 1025.7 20523.4 21249.3 21384.3 21521.0 21635.0 871.3 941.1 951.1 957.5 959.4 10086.7 11169.0 11193.1 11221.8 11347.3 528100.0 531529.3 540868.0 554163.0 608417.0 100060.0 104534.0 122773.0 128430.4 128759.0 820.5 951.0 965.7 972.2 973.8 18296.1 18791.8 18958.5 18984.5 19118.6 55449.7 55649.0 56073.4 57629.7 57860.7 65263.7 74481.6 77118.9 80102.8 83588.6 7968.4 8045.2 8248.2 8297.4 8338.8 8906.7 11710.2 12444.3 12450.6 13170.9 11413.0 11432.8 11492.9 11569.1 11727.2 8703.9 10085.8 11082.0 11288.7 11509.4 10846.9 11469.4 11711.2 11827.9 11916.7 8324.0 8357.0 8368.0 8435.7 8445.0 10965.3 11103.6 11355.9 11385.8 11801.8 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5743.97 Median:2402.84 stddev:3207.64 (133.5%) stddev-sans-first:3200.79 20:01:36 INFO - PROCESS | 1650 | Values: 1500.7 1536.7 1733.9 1803.0 1852.9 8041.2 8330.5 8526.5 9064.3 9092.9 8575.2 8901.1 8920.9 8982.7 9005.0 2355.7 2375.0 2382.2 2386.3 2389.5 2382.5 2418.4 2427.6 2434.2 2443.4 2408.5 2419.9 2428.5 2433.2 2434.4 2387.4 2396.4 2403.9 2409.2 2425.2 2387.4 2402.3 2410.9 2411.0 2412.3 8468.9 8491.5 9003.9 9072.1 9099.9 5259.7 5479.4 5504.8 5511.4 5519.6 3532.9 3625.8 3656.7 3672.3 3699.0 1048.4 1072.1 1081.3 1095.9 1108.9 9340.4 9855.4 11135.8 11728.0 11881.3 4115.3 4645.1 4696.8 4917.5 4950.7 10060.9 10163.3 10170.4 10173.2 10206.7 5481.8 5484.5 5489.9 5490.8 5492.1 4441.5 4599.6 4800.5 4929.5 5013.6 4035.9 4037.1 4127.8 4133.2 4157.4 1168.4 1298.8 1314.2 1331.3 1339.1 697.2 905.9 923.2 928.9 934.0 5821.7 5864.8 5967.5 6052.7 6122.3 441.9 991.0 1003.9 1011.4 1056.6 3882.5 3967.6 4015.9 4060.4 4102.1 10248.9 10873.0 10928.6 10943.6 10947.2 10543.8 10867.5 10875.5 10926.9 10971.3 6787.5 8433.0 8437.0 8472.7 8506.7 5749.3 5817.1 5864.0 5884.6 5937.0 10014.0 10117.3 10187.5 10263.3 10301.9 9914.1 10543.7 10555.7 10558.4 10585.8 6627.2 6820.6 6995.3 7128.1 7264.5 8412.6 8561.2 8654.9 8660.7 8668.6 7574.5 7680.8 7733.4 7835.9 7850.4 7422.9 7473.4 7547.2 7647.7 7648.5 7065.3 7190.9 7195.4 7203.5 7230.6 4304.3 4337.1 4363.8 5002.2 5084.8 4034.0 4195.9 4994.4 5185.4 5264.9 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4449.85 Median:5013.89 stddev:1395.37 (27.8%) stddev-sans-first:1363.38 20:01:36 INFO - PROCESS | 1650 | Values: 259.7 297.3 301.6 306.8 311.1 4298.4 4440.8 5105.0 5329.6 5338.7 4103.3 4808.9 5084.5 5208.9 5241.7 3710.7 4059.3 4061.2 4067.9 4075.4 3757.8 4018.3 4065.0 4067.5 4075.6 3345.1 3942.8 3943.4 3957.5 3966.7 3304.1 3441.1 3785.8 3984.7 4018.1 3433.9 3439.2 3439.9 3444.2 3448.9 4151.4 4797.1 5056.9 5106.9 5123.0 4177.4 4521.0 4524.9 4533.3 4542.3 4528.4 5486.8 5490.8 5523.8 5554.3 3588.9 3753.2 3758.5 3759.8 3770.0 4613.0 4797.6 4868.6 5715.9 5758.6 3634.3 3806.8 3814.5 3816.5 3840.2 3244.4 3551.8 3682.5 3892.9 3907.5 3671.5 3731.8 4018.7 4431.2 4463.9 5489.2 5527.6 5548.9 5571.4 5572.4 1010.4 1042.0 1255.8 1283.9 1318.1 709.8 753.6 871.0 892.7 894.8 4925.1 5136.7 5198.7 5234.3 5270.0 5180.0 5316.9 5606.5 5622.8 5661.8 4377.4 4770.7 5153.4 5220.3 5229.8 2934.5 2940.6 3017.1 3020.8 3025.7 5060.5 5962.5 5966.9 6002.8 6019.5 4843.9 4860.7 5660.6 5873.4 5934.3 5315.7 5789.4 5888.5 6018.9 6020.5 5399.8 5699.6 5716.6 5720.9 5752.3 4265.9 5120.4 5134.0 5679.8 5691.2 5893.9 5997.3 6012.6 6026.5 6057.8 3669.4 3684.0 3806.6 3835.3 3863.3 5316.8 5448.8 5704.3 5717.7 5729.7 4985.8 5440.9 5562.6 5605.8 5619.6 5571.7 5579.0 5586.2 5609.5 5631.3 4742.5 5213.6 5440.6 5458.8 5516.6 5041.9 5204.8 5582.0 5589.3 5601.5 4739.6 4763.0 4915.1 5448.5 5473.3 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:24428.99 Median:3662.82 stddev:38929.00 (1062.8%) stddev-sans-first:38997.36 20:01:36 INFO - PROCESS | 1650 | Values: 677.4 704.2 760.6 785.6 801.5 15109.7 15484.2 15496.8 15498.9 15566.0 11192.8 12493.7 13971.6 14069.3 14080.9 681.6 700.3 836.7 851.8 866.7 834.5 850.5 853.7 854.5 859.7 910.6 910.7 913.4 915.5 916.7 898.4 904.9 905.9 908.2 912.6 621.9 664.1 675.8 680.0 682.8 14557.3 14663.4 14718.1 14755.0 14764.6 14532.4 14540.6 14570.9 14578.5 14620.5 11533.7 11755.8 11792.2 11941.0 12007.5 3783.4 3842.4 3879.5 3900.6 3969.4 92538.0 117066.0 126075.0 126934.4 127044.0 9047.1 10644.7 10905.8 11190.2 11378.5 21442.9 21493.5 21540.6 21557.8 21597.5 7922.4 8043.8 8182.0 8308.2 8455.1 4379.9 4463.5 4525.7 4682.1 4731.5 3513.2 3634.3 3662.7 3662.9 3676.1 657.5 660.4 662.2 678.0 684.4 601.2 645.0 660.9 686.0 686.1 8904.4 9657.7 9686.9 9820.6 9908.7 669.2 673.3 673.5 675.3 684.6 4240.4 4562.8 4564.9 4585.8 4687.3 100165.0 126462.5 143032.0 151013.5 162619.0 109367.4 130065.0 132688.0 137483.0 141687.0 75122.0 101517.0 106662.0 108435.0 108592.0 8653.0 9212.7 9598.5 10185.5 10211.9 60798.7 62238.4 62559.1 62911.4 63934.7 89784.5 89999.6 91260.0 91668.5 93497.5 12600.7 12693.0 12972.6 13027.5 13146.9 14377.8 14391.4 14440.4 14611.7 14697.4 10262.4 10899.5 10945.9 11052.7 13850.4 12951.1 13550.3 13610.7 13631.8 13736.9 13149.2 13316.3 13562.8 13610.8 14175.9 9556.1 10844.7 11005.4 11059.1 11749.4 11017.3 11369.1 11562.2 11673.3 11762.9 20:01:36 INFO - PROCESS | 1650 | -------- Summary: end -------- 20:01:36 INFO - PROCESS | 1650 | 20:01:36 INFO - TEST-INFO | 1650: exit 0 20:01:36 INFO - TEST-OK | dromaeo_css | took 1112356ms 20:01:36 INFO - TEST-START | kraken 20:01:36 INFO - operating with platform_type : mac_ 20:01:36 INFO - Initialising browser for kraken test... 20:01:36 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmpqpWclU/profile http://localhost:49266/getInfo.html) 20:01:39 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 20:01:39 INFO - PROCESS | 1660 | colorDepth:24 20:01:39 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 20:01:39 INFO - PROCESS | 1660 | __metrics 20:01:39 ERROR - PROCESS | 1660 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 20:01:40 INFO - TEST-INFO | 1660: exit 0 20:01:40 INFO - Browser initialized. 20:01:40 INFO - Running cycle 1/1 for kraken test... 20:01:40 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmpqpWclU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:01:52 INFO - PROCESS | 1662 | RSS: Main: 224952320 20:01:52 INFO - PROCESS | 1662 | 20:01:55 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 20:01:56 INFO - PROCESS | 1662 | RSS: Main: 237871104 20:01:56 INFO - PROCESS | 1662 | 20:01:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 20:01:59 INFO - PROCESS | 1662 | RSS: Main: 246284288 20:01:59 INFO - PROCESS | 1662 | 20:02:02 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 20:02:03 INFO - PROCESS | 1662 | RSS: Main: 249421824 20:02:03 INFO - PROCESS | 1662 | 20:02:05 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 20:02:05 INFO - PROCESS | 1662 | RSS: Main: 250630144 20:02:05 INFO - PROCESS | 1662 | 20:02:07 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:02:08 INFO - PROCESS | 1662 | RSS: Main: 250621952 20:02:08 INFO - PROCESS | 1662 | 20:02:11 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 20:02:12 INFO - PROCESS | 1662 | RSS: Main: 251097088 20:02:12 INFO - PROCESS | 1662 | 20:02:15 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 20:02:16 INFO - PROCESS | 1662 | RSS: Main: 251367424 20:02:16 INFO - PROCESS | 1662 | 20:02:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 20:02:19 INFO - PROCESS | 1662 | RSS: Main: 251330560 20:02:19 INFO - PROCESS | 1662 | 20:02:21 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:02:21 INFO - PROCESS | 1662 | RSS: Main: 251199488 20:02:21 INFO - PROCESS | 1662 | 20:02:23 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:02:24 INFO - PROCESS | 1662 | RSS: Main: 251154432 20:02:24 INFO - PROCESS | 1662 | 20:02:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:02:27 INFO - PROCESS | 1662 | RSS: Main: 251187200 20:02:27 INFO - PROCESS | 1662 | 20:02:30 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:02:31 INFO - PROCESS | 1662 | RSS: Main: 251584512 20:02:31 INFO - PROCESS | 1662 | 20:02:33 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:02:34 INFO - PROCESS | 1662 | RSS: Main: 251351040 20:02:34 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 20:02:36 INFO - PROCESS | 1662 | RSS: Main: 252825600 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | __start_tp_report 20:02:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 20:02:36 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 20:02:36 INFO - PROCESS | 1662 | |i|pagename|runs| 20:02:36 INFO - PROCESS | 1662 | |0;ai-astar;107;118;119;118;119;117;119;118;118;120 20:02:36 INFO - PROCESS | 1662 | |1;audio-beat-detection;145;116;147;167;111;112;109;112;137;118 20:02:36 INFO - PROCESS | 1662 | |2;audio-dft;196;202;197;197;200;191;287;253;201;197 20:02:36 INFO - PROCESS | 1662 | |3;audio-fft;77;65;80;111;85;72;62;65;90;58 20:02:36 INFO - PROCESS | 1662 | |4;audio-oscillator;82;71;89;75;100;104;127;72;70;87 20:02:36 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;119;132;88;86;88;85;122;132;93;133 20:02:36 INFO - PROCESS | 1662 | |6;imaging-darkroom;95;94;121;153;115;152;153;96;95;95 20:02:36 INFO - PROCESS | 1662 | |7;imaging-desaturate;94;155;151;92;93;116;149;92;91;91 20:02:36 INFO - PROCESS | 1662 | |8;json-parse-financial;55;56;57;58;61;61;60;60;63;84 20:02:36 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;67;76;71;80;72;71;88;100;72;73 20:02:36 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;89;83;89;85;84;84;83;85;90;86 20:02:36 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;129;161;160;156;148;142;146;143;178;166 20:02:36 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;170;172;174;171;165;186;170;171;177;211 20:02:36 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;70;84;78;66;69;69;68;68;72;79 20:02:36 INFO - PROCESS | 1662 | __end_tp_report 20:02:36 INFO - PROCESS | 1662 | __start_cc_report 20:02:36 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,946 20:02:36 INFO - PROCESS | 1662 | __end_cc_report 20:02:36 INFO - PROCESS | 1662 | __startTimestamp1477018956614__endTimestamp 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | ------- Summary: start ------- 20:02:36 INFO - PROCESS | 1662 | Number of tests: 14 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:117.30 Median:118.50 stddev:3.71 (3.1%) stddev-sans-first:0.88 20:02:36 INFO - PROCESS | 1662 | Values: 107.0 118.0 119.0 118.0 119.0 117.0 119.0 118.0 118.0 120.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:127.40 Median:127.50 stddev:20.15 (15.8%) stddev-sans-first:20.34 20:02:36 INFO - PROCESS | 1662 | Values: 145.0 116.0 147.0 167.0 111.0 112.0 109.0 112.0 137.0 118.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:212.10 Median:200.50 stddev:31.70 (15.8%) stddev-sans-first:33.08 20:02:36 INFO - PROCESS | 1662 | Values: 196.0 202.0 197.0 197.0 200.0 191.0 287.0 253.0 201.0 197.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:76.50 Median:74.50 stddev:15.97 (21.4%) stddev-sans-first:16.93 20:02:36 INFO - PROCESS | 1662 | Values: 77.0 65.0 80.0 111.0 85.0 72.0 62.0 65.0 90.0 58.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:73.50 stddev:18.25 (24.8%) stddev-sans-first:19.24 20:02:36 INFO - PROCESS | 1662 | Values: 82.0 71.0 89.0 75.0 100.0 104.0 127.0 72.0 70.0 87.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:107.80 Median:85.50 stddev:21.43 (25.1%) stddev-sans-first:22.34 20:02:36 INFO - PROCESS | 1662 | Values: 119.0 132.0 88.0 86.0 88.0 85.0 122.0 132.0 93.0 133.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:116.90 Median:94.50 stddev:26.37 (27.9%) stddev-sans-first:26.75 20:02:36 INFO - PROCESS | 1662 | Values: 95.0 94.0 121.0 153.0 115.0 152.0 153.0 96.0 95.0 95.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:112.40 Median:91.50 stddev:28.13 (30.7%) stddev-sans-first:29.03 20:02:36 INFO - PROCESS | 1662 | Values: 94.0 155.0 151.0 92.0 93.0 116.0 149.0 92.0 91.0 91.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:61.50 Median:60.50 stddev:8.29 (13.7%) stddev-sans-first:8.45 20:02:36 INFO - PROCESS | 1662 | Values: 55.0 56.0 57.0 58.0 61.0 61.0 60.0 60.0 63.0 84.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:77.00 Median:72.50 stddev:9.99 (13.8%) stddev-sans-first:9.92 20:02:36 INFO - PROCESS | 1662 | Values: 67.0 76.0 71.0 80.0 72.0 71.0 88.0 100.0 72.0 73.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.50 stddev:2.62 (3.1%) stddev-sans-first:2.51 20:02:36 INFO - PROCESS | 1662 | Values: 89.0 83.0 89.0 85.0 84.0 84.0 83.0 85.0 90.0 86.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:152.90 Median:158.00 stddev:14.09 (8.9%) stddev-sans-first:12.00 20:02:36 INFO - PROCESS | 1662 | Values: 129.0 161.0 160.0 156.0 148.0 142.0 146.0 143.0 178.0 166.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:173.00 stddev:13.27 (7.7%) stddev-sans-first:13.85 20:02:36 INFO - PROCESS | 1662 | Values: 170.0 172.0 174.0 171.0 165.0 186.0 170.0 171.0 177.0 211.0 20:02:36 INFO - PROCESS | 1662 | 20:02:36 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:71.00 stddev:5.95 (8.4%) stddev-sans-first:6.25 20:02:36 INFO - PROCESS | 1662 | Values: 70.0 84.0 78.0 66.0 69.0 69.0 68.0 68.0 72.0 79.0 20:02:36 INFO - PROCESS | 1662 | -------- Summary: end -------- 20:02:36 INFO - PROCESS | 1662 | 20:02:37 INFO - TEST-INFO | 1662: exit 0 20:02:37 INFO - TEST-OK | kraken | took 60656ms 20:02:37 INFO - SUITE-END | took 1173s 20:02:37 INFO - Completed test suite (00:19:33) 20:02:37 INFO - javascript benchmark 20:02:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7239.963308633292, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2807.929801754956, 3319.419598489365, 3329.0012996101177, 3330.8834190803295, 3343.5820522434688, 5421.349438067433, 5423.701696406696, 5471.589630777693, 5476.7535460904255, 5534.0, 5458.972705136469, 5500.092484740023, 5510.448955104487, 5522.723863806804, 5533.6956467394275, 5039.874003149914, 5055.266986286986, 5109.208072748711, 5124.231365295198, 5159.0, 5057.9494205057845, 5107.69353838769, 5124.103281925667, 5140.203268493371, 5149.897002059956, 4999.32509111269, 5043.344365232515, 5113.642045056848, 5115.820946266881, 5116.002379535992, 5029.3964724232965, 5094.3886733591835, 5095.184770436731, 5117.923231151536, 5145.84562463123, 4999.275105109775, 5069.822556210552, 5078.26365177051, 5082.872928176788, 5115.411727651331, 4964.726940018298, 5309.946900531023, 5421.756020979065, 5452.809151679712, 5614.9438505615235, 4757.286407038937, 5868.76524939002, 5935.465808077251, 5996.550258730569, 6079.300880398767, 6097.20736304282, 6102.176206212149, 6110.052941794029, 6111.419415155553, 6130.938690613081, 5604.355499117612, 5644.971775141098, 5650.858728531778, 5653.886922261614, 5659.490645841894, 4917.286993385939, 5393.164059570773, 5837.854053648693, 6060.363661815534, 6127.0, 5894.557908156906, 5916.497097746654, 5945.821625351246, 5966.791162309299, 6003.0695242237525, 5191.870203244949, 5992.850178745566, 6060.303065147476, 6061.242344706911, 6071.3928607139815, 5817.825465236049, 5862.5896187267335, 5927.0, 5954.910676339859, 5956.0, 6000.849978750479, 6048.758049677964, 6068.908966365508, 6070.453659170696, 6091.177691011657, 3845.884693438927, 4282.8222238884555, 4435.112977404532, 4781.521847815191, 4815.061063092733, 3629.7277704172293, 4093.1199792044854, 4229.217594744982, 4274.764887931132, 4322.37325587788, 5043.646944713835, 5051.747412629354, 5598.776048958078, 5639.971800141055, 5680.034394153004, 4925.581325587294, 4968.0, 6004.219451471281, 6040.879182416327, 6066.726997285133, 5047.570956468741, 5469.535089517435, 5517.503424691797, 5607.8598035048635, 5684.431556844283, 4430.800613972315, 5233.973830130825, 5235.476452354734, 5276.36683597963, 5300.09898317287, 6192.318844927145, 6197.783077592263, 6199.3490683478485, 6221.9377806222265, 6225.1907252057845, 5920.259967504062, 5967.985442474876, 5971.164037034731, 6008.849778755566, 6109.358517355614, 6109.969450152721, 6163.84590385244, 6183.598066125687, 6192.566520343533, 6196.721147548281, 5923.614965027259, 5953.523718102628, 5962.582619216787, 5971.193888825127, 5999.190109335358, 5917.37867523921, 5933.0, 6033.366496517802, 6035.245594300713, 6041.607295525952, 5699.430056994267, 5883.0881213411985, 5910.852228694317, 5955.076963070731, 5998.940010599838, 5883.558733094949, 5892.263467066617, 5909.91135132982, 5938.257717785277, 5939.970300148644, 4542.954570454253, 5577.247071645276, 5713.9714301429885, 5754.108113242454, 5769.653820770599, 5694.117411801178, 5797.623154494944, 5827.621204621686, 5866.560007999503, 5905.173275741486, 5652.519535839499, 5690.118031705092, 5699.2590963174525, 5701.657900525982, 5732.57005724564], "value": 5447.920314912679, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [467.5534864204684, 473.38696388177306, 497.8449996009255, 516.0994065355953, 529.4784637132424, 37130.443043354375, 40823.795881020626, 40838.97902552434, 43082.784586077025, 43236.13527729452, 41674.0, 42088.52690155845, 42108.157836843246, 42186.578134218646, 42228.788856055755, 9833.11501964823, 9976.551055202497, 10024.74938126549, 10040.548175332127, 10056.547455364525, 9791.510424478784, 9872.45701486418, 9880.703578892644, 9886.752831179207, 9952.950235248814, 9886.258530610234, 9886.9505652472, 9896.257780666443, 9923.503824808768, 9930.10629043386, 9547.567864820263, 9817.214622830192, 9871.259655525828, 9875.90124098757, 9897.35667181631, 9234.86147707785, 9889.109980101824, 9905.504724763732, 9913.553890074963, 9960.551775170063, 40687.38968915468, 41004.0, 41010.179796404205, 41054.58945410538, 41146.58853411458, 2643.0, 3023.7753709747585, 3126.937461250785, 3431.1422144463886, 3577.928441431183, 25786.613200802003, 27472.45055098907, 29789.0, 30173.0948071556, 30507.08478745619, 2630.3424143964007, 3083.4449799036165, 3128.03031060372, 3153.952690709641, 3165.7625678074005, 406393.96803015796, 407880.0, 410972.0, 413267.0, 414819.999999997, 61578.69210653918, 61689.07466388008, 61858.381416185264, 61867.0, 62444.37555624476, 27205.455890882073, 33910.0, 34569.30861382758, 35999.82000090035, 36043.0, 16546.83453165453, 16610.003399796053, 16671.166441677866, 16749.83250167507, 16780.32878684839, 12885.742285154245, 12893.226406415644, 12898.097133200774, 12934.159279646792, 12968.546100886613, 19206.807931920783, 19232.03839808032, 19234.03829808504, 19248.037598120318, 19332.8066719331, 6733.764318248838, 7252.492325537267, 7921.049474063034, 8202.220789025152, 8274.338052955749, 864.9264812491009, 868.9204186345049, 973.7662960889336, 985.3987270685137, 1111.5387114347616, 23762.0, 25577.360565986, 27641.308967275578, 30832.53751193734, 31058.068257952298, 783.1298291760747, 951.4206417347309, 1001.7195185348114, 1059.1579694143174, 1099.7140743406771, 12135.5145794169, 15090.471833485995, 15102.39590416393, 15200.315985780666, 15414.537563873102, 600368.0, 601902.0, 605086.0, 609390.0, 609622.0, 54105.45894541083, 54496.45503544993, 54828.90342193213, 54867.725661372235, 54961.725191373785, 1370.869767372098, 1371.7050834070724, 1390.8261467316788, 1391.3460673483446, 1395.539471974246, 28068.578971315037, 28937.7106228935, 29081.85459072691, 29103.85448072746, 29631.85184074152, 48686.26970595515, 49264.75367623139, 49378.75310623424, 49411.0, 49425.75287123541, 554499.0, 561634.0, 564817.0, 564976.0, 565972.0, 25826.0, 26010.08964686227, 26031.349216269744, 26112.8694356527, 26137.869310654085, 37848.86453406402, 39843.80078099591, 44650.55349446464, 45121.77439112784, 45238.321425177994, 36031.63968360283, 36175.914722558366, 37562.2487550242, 38090.80954595209, 39253.41119883147, 31184.440777960557, 37410.43884341683, 37789.244215116094, 38477.038074047254, 38936.41595376015, 36788.0, 37052.81473592615, 37447.43828842515, 37540.0, 37555.06112347213, 32259.35481290408, 33304.666953330154, 33305.50041749327, 33638.15904602405, 34033.0, 25309.493810123327, 25383.0, 25486.82247637991, 25683.743162568135, 25821.6126758095], "value": 19229.416450096083, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.27455480767793, 384.3504477433136, 386.7988645904131, 390.8671051842373, 409.3470913892341, 18871.339503117393, 20333.694994575057, 20423.387298381072, 20619.484512887168, 20649.690254646193, 20031.397488200946, 20369.694454583194, 20749.0, 20900.8954955225, 20995.055222514984, 3691.8338674759702, 4978.303037574742, 5188.740562971855, 5907.936571417144, 6091.908621370683, 6030.185924900148, 6115.113308570255, 6124.785632502863, 6140.171076904606, 6140.324564297946, 5822.243108395903, 6080.331163572026, 6164.383561643845, 6172.074188871683, 6219.471344935686, 6095.634261944298, 6184.196054512907, 6199.225096862892, 6225.906611400833, 6252.531060170482, 5860.560457965669, 6073.3622969588, 6075.179850720185, 6084.847878803021, 6093.542984276152, 13315.134516256412, 17146.57133571658, 20561.691574626242, 25776.871115644488, 25969.0, 1860.7860096088987, 2211.977880221193, 2213.546223024276, 2889.0, 3016.668166501683, 9748.463834489101, 9859.605615775361, 10047.799044019152, 10363.740906477398, 10428.89571104287, 1884.679604467244, 1900.5818719881604, 1907.4754442528276, 1925.1817977359706, 1947.0946010105226, 122718.0, 125715.0, 126435.36782316121, 128523.0, 128924.35537822345, 11423.942880285545, 11710.180287379972, 11825.645230643095, 11827.822582661267, 11920.821187682192, 14562.0, 14636.926815365856, 14667.706645867023, 14685.926570367294, 14871.851281487263, 8637.784055398539, 8651.870221946676, 8707.172818582225, 8780.692675756318, 8796.824063518694, 7244.275572442819, 8213.507189568645, 8695.913040869636, 8711.303095752324, 8822.338324625678, 4474.060447306102, 4504.954950450519, 4595.632349412039, 4612.815487380467, 4649.0, 1681.4031018988328, 1926.6435709393807, 1950.6781381072249, 2013.3255359454747, 2015.3147929703678, 842.1578421578422, 852.9744107676779, 883.8364902493059, 989.6981420666766, 1025.738436698637, 20523.384298471068, 21249.256276030264, 21384.251551195634, 21521.0, 21635.0, 871.285545852395, 941.1294552538874, 951.0822056715303, 957.4686049242737, 959.4195511715451, 10086.697399078039, 11169.0, 11193.10455163585, 11221.775564488664, 11347.319160850375, 528100.0, 531529.3423532858, 540868.0, 554163.0, 608417.0, 100060.0, 104534.0, 122773.0, 128430.35784821016, 128759.0, 820.4584973917305, 951.0, 965.748905284617, 972.2027937091658, 973.8149751547184, 18296.085195740427, 18791.812081879005, 18958.526036848638, 18984.52538686544, 19118.617627647647, 55449.72275138598, 55649.0, 56073.43926560682, 57629.71185144047, 57860.71069644793, 65263.67368163129, 74481.62759186169, 77118.91524338964, 80102.79845802434, 83588.58205708933, 7968.402369822171, 8045.155258697752, 8248.175182481704, 8297.419180657296, 8338.791530211793, 8906.73279801607, 11710.180287379802, 12444.253344798979, 12450.626481205578, 13170.934145329595, 11412.972832445119, 11432.828507572227, 11492.94253528727, 11569.132315076571, 11727.237729547553, 8703.869441958503, 10085.848712269175, 11082.0, 11288.717782055513, 11509.424528773696, 10846.895283589261, 11469.369184694922, 11711.238769479956, 11827.881721182677, 11916.702082448008, 8324.0, 8356.958215208884, 8368.0, 8435.704750333709, 8444.957775211331, 10965.342079475256, 11103.555857765921, 11355.886441135814, 11385.829212561985, 11801.763964720829], "value": 9556.856925095932, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1500.722366362223, 1536.731072062389, 1733.921973511192, 1802.9549261268457, 1852.8888266703998, 8041.195880411956, 8330.541820199887, 8526.488410695354, 9064.320175986812, 9092.909070909289, 8575.228229459348, 8901.109889011095, 8920.866187007185, 8982.730518084452, 9005.009448960609, 2355.6702061711376, 2374.964375534368, 2382.2019623426086, 2386.2721869829693, 2389.498205376873, 2382.5115851250453, 2418.3712234818986, 2427.599446091393, 2434.184548176363, 2443.389152711822, 2408.51829634073, 2419.8669073200967, 2428.5142971405703, 2433.2092070077206, 2434.415740222352, 2387.403149212697, 2396.4488167721347, 2403.8677872716994, 2409.229046705046, 2425.175440350272, 2387.3554140382175, 2402.25530085674, 2410.8794560271917, 2410.987945060281, 2412.300432874464, 8468.872966905501, 8491.490510569385, 9003.864942025875, 9072.138146876036, 9099.909000909973, 5259.684418934876, 5479.424660410639, 5504.779808807642, 5511.366192887829, 5519.641223320471, 3532.876349327787, 3625.8368373422995, 3656.7257455690665, 3672.320620685182, 3698.9630103699155, 1048.391932679052, 1072.083368719749, 1081.3079629037422, 1095.901368876805, 1108.8613923259593, 9340.439573625605, 9855.408675479493, 11135.832962505569, 11728.0, 11881.287122772661, 4115.32097203958, 4645.117427688729, 4696.835610753607, 4917.5082491751255, 4950.653454258239, 10060.899391006142, 10163.288569800043, 10170.389776613427, 10173.186145108373, 10206.744831379276, 5481.780728770885, 5484.451554844563, 5489.917651235235, 5490.80782172622, 5492.148716948879, 4441.511433742286, 4599.586037256663, 4800.495947925418, 4929.457759646436, 5013.598912087097, 4035.8587449439715, 4037.1118353962083, 4127.814248358831, 4133.1940271647345, 4157.355609880473, 1168.3982748884162, 1298.8375404013543, 1314.2377421095741, 1331.301066939845, 1339.055965544289, 697.1912581405545, 905.8686490458847, 923.1599244687302, 928.8606708993569, 933.9673111441067, 5821.679807610622, 5864.765409383577, 5967.492763115097, 6052.6671033092725, 6122.295935967331, 441.9248727716296, 990.980180396388, 1003.9498025098716, 1011.4032720694826, 1056.6090546497692, 3882.5340959085092, 3967.6032396760093, 4015.9478796114577, 4060.3503439449546, 4102.077032667686, 10248.948755256326, 10873.0, 10928.617498387519, 10943.616973405893, 10947.233693641529, 10543.789124217472, 10867.45662716861, 10875.510602022929, 10926.945365273123, 10971.286866353661, 6787.490938179656, 8433.03020152678, 8437.0, 8472.65330194582, 8506.702265420805, 5749.338826034892, 5817.069268916953, 5863.973804584266, 5884.6469211847425, 5936.990711578956, 10014.0, 10117.291789574954, 10187.490625468845, 10263.332883362558, 10301.896981030093, 9914.107730304018, 10543.736406589589, 10555.736106597396, 10558.419286938984, 10585.788284234119, 6627.204735431779, 6820.590764554143, 6995.265497122932, 7128.108986376703, 7264.527805692613, 8412.579371031547, 8561.22948934574, 8654.870176947225, 8660.696875609576, 8668.609912554077, 7574.545527268381, 7680.769576912701, 7733.419993500623, 7835.882461763192, 7850.4112191587, 7422.888656670262, 7473.364763995121, 7547.245275472409, 7647.732329368446, 7648.541087534766, 7065.293470652894, 7190.928090719026, 7195.352418282379, 7203.495755297288, 7230.6384680766805, 4304.332828411601, 4337.089211265544, 4363.759993200404, 5002.2496625506465, 5084.847454576221, 4033.9596604033586, 4195.916081678289, 4994.350734404649, 5185.377754669464, 5264.947350526599], "value": 4621.065874495479, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.74934188508087, 297.2790981868967, 301.641047153887, 306.7898489534669, 311.08851066375513, 4298.441202643652, 4440.822367105316, 5105.0, 5329.626926115174, 5338.67967921925, 4103.261412945669, 4808.903821923559, 5084.466295924334, 5208.869778255536, 5241.737913104339, 3710.7402481826284, 4059.3302105152616, 4061.1877624475223, 4067.9389809152885, 4075.3886916962547, 3757.7557458765227, 4018.276710192164, 4064.979675101635, 4067.4712287402594, 4075.612816782416, 3345.059865278145, 3942.7634341939574, 3943.4084887266854, 3957.515931525678, 3966.7223294369405, 3304.107890869464, 3441.0537102296817, 3785.8296376663116, 3984.7409918355215, 4018.1160144768105, 3433.866823948091, 3439.1574064354395, 3439.9212704629217, 3444.2422667013466, 3448.8792892248903, 4151.418801367811, 4797.057191837312, 5056.898862022776, 5106.872328191787, 5122.974385128088, 4177.373393990895, 4520.960179158812, 4524.886877828048, 4533.2746760518485, 4542.343413552089, 4528.415054730818, 5486.780528778844, 5490.80782172626, 5523.8066667666435, 5554.306386253137, 3588.946165807515, 3753.230587729509, 3758.542141230075, 3759.8156580677, 3770.0, 4612.953870461286, 4797.568218860284, 4868.634852386085, 5715.885682286373, 5758.596898217126, 3634.2913131939545, 3806.8286927088348, 3814.4659747635355, 3816.46569480273, 3840.1743625120735, 3244.383567122239, 3551.786892786441, 3682.4660424238336, 3892.8832135035996, 3907.5310962684093, 3671.52270204877, 3731.8134093295225, 4018.678505719535, 4431.246688063037, 4463.888402789891, 5489.176623506426, 5527.613067085265, 5548.917960997647, 5571.4150014248735, 5572.442755724395, 1010.4392062405435, 1041.9791604167874, 1255.8116282557507, 1283.9229646221256, 1318.1432069155126, 709.8260926073145, 753.6081237756335, 870.9679030349057, 892.6920212526668, 894.8367122740411, 4925.064237794808, 5136.666116702402, 5198.740062996835, 5234.345706786652, 5269.973650131725, 5180.0, 5316.893662126736, 5606.495415412633, 5622.775088996476, 5661.801836935688, 4377.430933978562, 4770.689905156223, 5153.3815942087185, 5220.321358223407, 5229.790808367698, 2934.457125431802, 2940.603018592463, 3017.125033740235, 3020.8338541379994, 3025.7125573070525, 5060.493950604984, 5962.493188078975, 5966.925953328356, 6002.759889604455, 6019.4883434908525, 4843.885906241584, 4860.708357498562, 5660.575456840671, 5873.4126587340925, 5934.3175534814045, 5315.707636079976, 5789.363170051291, 5888.5289176865745, 6018.879622407615, 6020.471402011166, 5399.757010934439, 5699.572532060195, 5716.571257155813, 5720.914186287126, 5752.252207213036, 4265.91468170641, 5120.4111527174855, 5133.998870220271, 5679.77280908759, 5691.231683722644, 5893.941060589511, 5997.280326360865, 6012.6392416455155, 6026.487748541423, 6057.818265451867, 3669.422148476074, 3683.963160368362, 3806.62961333914, 3835.328817456878, 3863.304605170984, 5316.840494785162, 5448.809291674773, 5704.258446401941, 5717.7141142941855, 5729.684867332337, 4985.825496107764, 5440.93244567062, 5562.554995600423, 5605.831825045255, 5619.606627536034, 5571.66570005801, 5579.0, 5586.162075688517, 5609.523190528851, 5631.2960879890015, 4742.529815757126, 5213.582913366846, 5440.646357986877, 5458.789190377904, 5516.558675305886, 5041.949580504148, 5204.843854684365, 5581.972090139523, 5589.289194740466, 5601.467860553241, 4739.59713424349, 4762.976185119191, 4915.139850526072, 5448.536874365724, 5473.31583552056], "value": 3997.495245424928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.3565113142514, 704.1514974455781, 760.5550752809606, 785.6189747972229, 801.4990630855717, 15109.697806043872, 15484.225788710575, 15496.845031549681, 15498.922505387485, 15566.0, 11192.776144477126, 12493.68765780856, 13971.58085257444, 14069.296535173251, 14080.929595352034, 681.6012632609917, 700.2997002997002, 836.7406104107715, 851.8168593752342, 866.7096522664915, 834.5034704350932, 850.5109562001843, 853.6585365853646, 854.4531499840107, 859.6647307550061, 910.6311943662827, 910.713125365511, 913.3515204204989, 915.450729562264, 916.6516723645005, 898.4025622960723, 904.8959369672506, 905.9275257979378, 908.2280061947358, 912.5938957164065, 621.860081481663, 664.0835646807424, 675.8344205669642, 680.0479328939475, 682.8497730499332, 14557.344919478543, 14663.41346346145, 14718.116912985255, 14755.040922340013, 14764.557063288119, 14532.418703251857, 14540.563783086418, 14570.92714536431, 14578.489752858704, 14620.488282910048, 11533.711657208552, 11755.823662645067, 11792.23350482216, 11941.044716422752, 12007.45966431504, 3783.4324851272254, 3842.4044273137706, 3879.495665563487, 3900.609939006105, 3969.3847453644444, 92538.0, 117066.0, 126075.0, 126934.36532817369, 127044.0, 9047.140521650434, 10644.733881653021, 10905.83641245382, 11190.216684832147, 11378.487968041292, 21442.892785536285, 21493.462663433227, 21540.56918861614, 21557.78442215589, 21597.46006349854, 7922.445428820042, 8043.758687239392, 8181.959090204511, 8308.169183081643, 8455.069942306342, 4379.890502737393, 4463.531329210451, 4525.728456292567, 4682.1338052460405, 4731.455882573479, 3513.1568423578155, 3634.309481198564, 3662.7436079474714, 3662.8901132966053, 3676.0993556578273, 657.5397221944658, 660.3825423229296, 662.1987395251703, 677.9864402712017, 684.4319215051495, 601.1823919469518, 644.9806505804834, 660.9438197753245, 686.0, 686.1286166568431, 8904.376693631384, 9657.672412071437, 9686.854697179548, 9820.558074886505, 9908.702738917844, 669.1635455680399, 673.2829536543566, 673.4578664175287, 675.3179288918129, 684.6234570985938, 4240.385144154142, 4562.817487300537, 4564.885877853014, 4585.830613193681, 4687.273472611751, 100165.0, 126462.51531135202, 143032.0, 151013.48986510214, 162619.0, 109367.35948960773, 130065.0, 132688.0, 137483.0, 141687.0, 75122.0, 101516.99999999852, 106662.0, 108435.0, 108592.0, 8652.996375552206, 9212.677556285498, 9598.520073996133, 10185.541650625888, 10211.897881021094, 60798.69600651968, 62238.37761622507, 62559.06161407491, 62911.37088629055, 63934.68032659993, 89784.47047530474, 89999.55000224957, 91260.0, 91668.54165729128, 93497.532512337, 12600.74798504043, 12693.0, 12972.610821675366, 13027.47890084386, 13146.948244140254, 14377.7843332348, 14391.424343026161, 14440.397135904506, 14611.707765844836, 14697.41210351574, 10262.384256944608, 10899.455027248765, 10945.945270273598, 11052.723681908017, 13850.376733046836, 12951.093423460266, 13550.322483875963, 13610.727785444038, 13631.79552306736, 13736.87326199736, 13149.21104733719, 13316.334183290603, 13562.796558051834, 13610.795838062239, 14175.93680473948, 9556.092171243721, 10844.67465976022, 11005.449727513433, 11059.115270778157, 11749.353785541536, 11017.338959662446, 11369.147313951322, 11562.190646654653, 11673.299602023906, 11762.94118529402], "value": 7786.278286492894, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1584.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 119.0, 118.0, 119.0, 117.0, 119.0, 118.0, 118.0, 120.0], "value": 117.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 116.0, 147.0, 167.0, 111.0, 112.0, 109.0, 112.0, 137.0, 118.0], "value": 127.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 202.0, 197.0, 197.0, 200.0, 191.0, 287.0, 253.0, 201.0, 197.0], "value": 212.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 65.0, 80.0, 111.0, 85.0, 72.0, 62.0, 65.0, 90.0, 58.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 89.0, 75.0, 100.0, 104.0, 127.0, 72.0, 70.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 132.0, 88.0, 86.0, 88.0, 85.0, 122.0, 132.0, 93.0, 133.0], "value": 107.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 121.0, 153.0, 115.0, 152.0, 153.0, 96.0, 95.0, 95.0], "value": 116.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 155.0, 151.0, 92.0, 93.0, 116.0, 149.0, 92.0, 91.0, 91.0], "value": 112.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 58.0, 61.0, 61.0, 60.0, 60.0, 63.0, 84.0], "value": 61.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 76.0, 71.0, 80.0, 72.0, 71.0, 88.0, 100.0, 72.0, 73.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 89.0, 85.0, 84.0, 84.0, 83.0, 85.0, 90.0, 86.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 161.0, 160.0, 156.0, 148.0, 142.0, 146.0, 143.0, 178.0, 166.0], "value": 152.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 172.0, 174.0, 171.0, 165.0, 186.0, 170.0, 171.0, 177.0, 211.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 84.0, 78.0, 66.0, 69.0, 69.0, 68.0, 68.0, 72.0, 79.0], "value": 72.3, "unit": "score"}]}]} 20:02:37 INFO - Return code: 0 20:02:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:02:37 ERROR - # TBPL SUCCESS # 20:02:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:02:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:02:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:02:37 INFO - 2016-10-20 20:02:37.953 screenresolution[1667:10226] starting screenresolution argv=screenresolution get 20:02:37 INFO - 2016-10-20 20:02:37.956 screenresolution[1667:10226] Display 0: 1600x1200x32@60 20:02:37 INFO - 2016-10-20 20:02:37.962 screenresolution[1668:10229] starting screenresolution argv=screenresolution list 20:02:37 INFO - Available Modes on Display 0 20:02:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:02:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:02:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:02:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:02:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:02:38 INFO - Intel Iris: 20:02:38 INFO - Chipset Model: Intel Iris 20:02:38 INFO - Type: GPU 20:02:38 INFO - Bus: Built-In 20:02:38 INFO - VRAM (Dynamic, Max): 1536 MB 20:02:38 INFO - Vendor: Intel (0x8086) 20:02:38 INFO - Device ID: 0x0a2e 20:02:38 INFO - Revision ID: 0x0009 20:02:38 INFO - Displays: 20:02:38 INFO - Display: 20:02:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:02:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:02:38 INFO - Display Serial Number: 1600x1200 60 20:02:38 INFO - Main Display: Yes 20:02:38 INFO - Mirror: Off 20:02:38 INFO - Online: Yes 20:02:38 INFO - Rotation: Supported 20:02:38 INFO - Return code: 0 20:02:38 INFO - Running post-action listener: _resource_record_post_action 20:02:38 INFO - [mozharness: 2016-10-21 03:02:38.197618Z] Finished run-tests step (success) 20:02:38 INFO - Running post-run listener: _resource_record_post_run 20:02:38 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 36725760; Write bytes: 659578880; Read time: 410; Write time: 3027 20:02:38 INFO - TinderboxPrint: CPU usage
54.3% 20:02:38 INFO - TinderboxPrint: I/O read bytes / time
36,725,760 / 410 20:02:38 INFO - TinderboxPrint: I/O write bytes / time
659,578,880 / 3,027 20:02:38 INFO - TinderboxPrint: CPU idle
2,207.6 (45.7%) 20:02:38 INFO - TinderboxPrint: CPU system
974.8 (20.2%) 20:02:38 INFO - TinderboxPrint: CPU user
1,643.2 (34.1%) 20:02:38 INFO - TinderboxPrint: Swap in / out
400,232,448 / 0 20:02:38 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 360776192; Write bytes: 356378624; Read time: 27910; Write time: 653 20:02:38 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 34649088; Write bytes: 291895296; Read time: 382; Write time: 2336 20:02:38 INFO - Running post-run listener: _upload_blobber_files 20:02:38 INFO - Blob upload gear active. 20:02:38 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:02:38 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 20:02:38 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'] 20:02:38 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 20:02:39 INFO - (blobuploader) - INFO - Open directory for files ... 20:02:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:02:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:02:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:02:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:02:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:02:39 INFO - (blobuploader) - INFO - Done attempting. 20:02:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:02:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:02:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:02:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:02:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:02:40 INFO - (blobuploader) - INFO - Done attempting. 20:02:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:02:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:02:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:02:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:02:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:02:43 INFO - (blobuploader) - INFO - Done attempting. 20:02:43 INFO - (blobuploader) - INFO - Iteration through files over. 20:02:43 INFO - Return code: 0 20:02:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:02:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:02:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d12b4423e224d965c8acf242fad35939644755a2825a9740fc2fc9ae443aa88abfd11ee132e48c7987aa953211b86f3c708c792647537e67cebdf2daf2374402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/885168ae29620aab76c4402b74adb340afcba122d3115a2198f0f4e496c8234b62b421089542e4d69f4e62a93a9abc787ddca207a9b2c2b36416345155888763", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883fa64d1dc37c6e5ca6d451b8df63cd1db80b7a5fbfd6f49833c7553a52521148e5ef0e8ef90a7d444549c8eb14589bde00d2d75582aa7ba19ed6749965846b"} 20:02:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:02:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:02:43 INFO - Contents: 20:02:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d12b4423e224d965c8acf242fad35939644755a2825a9740fc2fc9ae443aa88abfd11ee132e48c7987aa953211b86f3c708c792647537e67cebdf2daf2374402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/885168ae29620aab76c4402b74adb340afcba122d3115a2198f0f4e496c8234b62b421089542e4d69f4e62a93a9abc787ddca207a9b2c2b36416345155888763", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883fa64d1dc37c6e5ca6d451b8df63cd1db80b7a5fbfd6f49833c7553a52521148e5ef0e8ef90a7d444549c8eb14589bde00d2d75582aa7ba19ed6749965846b"} 20:02:43 INFO - Running post-run listener: copy_logs_to_upload_dir 20:02:43 INFO - Copying logs to upload dir... 20:02:43 INFO - mkdir: /builds/slave/test/build/upload/logs 20:02:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.639099 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-10-20 20:02:43.177568) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 20:02:43.181125) ========= 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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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/d12b4423e224d965c8acf242fad35939644755a2825a9740fc2fc9ae443aa88abfd11ee132e48c7987aa953211b86f3c708c792647537e67cebdf2daf2374402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/885168ae29620aab76c4402b74adb340afcba122d3115a2198f0f4e496c8234b62b421089542e4d69f4e62a93a9abc787ddca207a9b2c2b36416345155888763", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883fa64d1dc37c6e5ca6d451b8df63cd1db80b7a5fbfd6f49833c7553a52521148e5ef0e8ef90a7d444549c8eb14589bde00d2d75582aa7ba19ed6749965846b"} build_url:https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/Va2TcNq-QdCRoRJTujEI_g/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/d12b4423e224d965c8acf242fad35939644755a2825a9740fc2fc9ae443aa88abfd11ee132e48c7987aa953211b86f3c708c792647537e67cebdf2daf2374402", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/885168ae29620aab76c4402b74adb340afcba122d3115a2198f0f4e496c8234b62b421089542e4d69f4e62a93a9abc787ddca207a9b2c2b36416345155888763", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/883fa64d1dc37c6e5ca6d451b8df63cd1db80b7a5fbfd6f49833c7553a52521148e5ef0e8ef90a7d444549c8eb14589bde00d2d75582aa7ba19ed6749965846b"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 20:02:43.218538) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 20:02:43.219030) ========= 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.e9PbF4fY07/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.lZ8MG7zA9f/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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.005012 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 20:02:43.271900) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 20:02:43.272738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 20:02:43.273503) ========= ========= Total master_lag: 0.19 =========