builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0102 starttime: 1476980191.24 results: success (0) buildid: 20161020062850 builduid: 47dbb878b948470097db031390a9ce73 revision: bcca478fadc01e2f47d38675de8555cb1ced584d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.240184) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.240625) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.240904) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.275156) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.275551) ========= 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.bzhX4r4C9G/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.45mL35xEDx/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:16:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 29.0M=0s 2016-10-20 09:16:31 (29.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090269 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.388311) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.388637) ========= 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.bzhX4r4C9G/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.45mL35xEDx/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.026623 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:31.438483) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 09:16:31.438828) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev bcca478fadc01e2f47d38675de8555cb1ced584d --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 bcca478fadc01e2f47d38675de8555cb1ced584d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bzhX4r4C9G/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.45mL35xEDx/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:16:31,512 truncating revision to first 12 chars 2016-10-20 09:16:31,512 Setting DEBUG logging. 2016-10-20 09:16:31,512 attempt 1/10 2016-10-20 09:16:31,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/bcca478fadc0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-20 09:16:33,248 unpacking tar archive at: mozilla-aurora-bcca478fadc0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.990799 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-20 09:16:33.451382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:33.451699) ========= script_repo_revision: bcca478fadc01e2f47d38675de8555cb1ced584d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:33.452089) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:33.452355) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-20 09:16:33.470707) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-20 09:16:33.471099) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.bzhX4r4C9G/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.45mL35xEDx/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:16:33 INFO - MultiFileLogger online at 20161020 09:16:33 in /builds/slave/test 09:16:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:16:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:16:33 INFO - {'append_to_log': False, 09:16:33 INFO - 'base_work_dir': '/builds/slave/test', 09:16:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:16:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:16:33 INFO - 'branch': 'Mozilla-Aurora', 09:16:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:16:33 INFO - 'config_files': ('talos/mac_config.py',), 09:16:33 INFO - 'default_actions': ('clobber', 09:16:33 INFO - 'read-buildbot-config', 09:16:33 INFO - 'download-and-extract', 09:16:33 INFO - 'populate-webroot', 09:16:33 INFO - 'create-virtualenv', 09:16:33 INFO - 'install', 09:16:33 INFO - 'run-tests'), 09:16:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:16:33 INFO - 'download_minidump_stackwalk': True, 09:16:33 INFO - 'download_symbols': 'ondemand', 09:16:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:16:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:16:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:16:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:16:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:16:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:16:33 INFO - 'installer_path': 'installer.exe', 09:16:33 INFO - 'log_level': 'info', 09:16:33 INFO - 'log_name': 'talos', 09:16:33 INFO - 'log_to_console': True, 09:16:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:16:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:16:33 INFO - 'opt_config_files': (), 09:16:33 INFO - 'pip_index': False, 09:16:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:33 INFO - 'cmd': ('bash', 09:16:33 INFO - '-c', 09:16:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:33 INFO - 'enabled': True, 09:16:33 INFO - 'halt_on_failure': False, 09:16:33 INFO - 'name': 'check_screen_resolution'},), 09:16:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:16:33 INFO - 'cmd': ('bash', 09:16:33 INFO - '-c', 09:16:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:16:33 INFO - 'enabled': True, 09:16:33 INFO - 'halt_on_failure': False, 09:16:33 INFO - 'name': 'check_screen_resolution'},), 09:16:33 INFO - 'run_cmd_checks_enabled': True, 09:16:33 INFO - 'sps_profile': False, 09:16:33 INFO - 'sps_profile_interval': 0, 09:16:33 INFO - 'suite': 'dromaeojs', 09:16:33 INFO - 'system_bits': '32', 09:16:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:16:33 INFO - 'title': 't-yosemite-r7-0102', 09:16:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:16:33 INFO - 'use_talos_json': True, 09:16:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:16:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:16:33 INFO - 'work_dir': 'build'} 09:16:33 INFO - [mozharness: 2016-10-20 16:16:33.666548Z] Running clobber step. 09:16:33 INFO - Running pre-action listener: _resource_record_pre_action 09:16:33 INFO - Running main action method: clobber 09:16:33 INFO - rmtree: /builds/slave/test/build 09:16:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:16:35 INFO - Running post-action listener: _resource_record_post_action 09:16:35 INFO - [mozharness: 2016-10-20 16:16:35.727933Z] Finished clobber step (success) 09:16:35 INFO - [mozharness: 2016-10-20 16:16:35.728112Z] Running read-buildbot-config step. 09:16:35 INFO - Running pre-action listener: _resource_record_pre_action 09:16:35 INFO - Running main action method: read_buildbot_config 09:16:35 INFO - Using buildbot properties: 09:16:35 INFO - { 09:16:35 INFO - "project": "", 09:16:35 INFO - "product": "firefox", 09:16:35 INFO - "script_repo_revision": "production", 09:16:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:16:35 INFO - "repository": "", 09:16:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:16:35 INFO - "buildid": "20161020062850", 09:16:35 INFO - "pgo_build": "False", 09:16:35 INFO - "basedir": "/builds/slave/test", 09:16:35 INFO - "buildnumber": 46, 09:16:35 INFO - "slavename": "t-yosemite-r7-0102", 09:16:35 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:16:35 INFO - "platform": "yosemite_r7", 09:16:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:16:35 INFO - "branch": "mozilla-aurora", 09:16:35 INFO - "repo_path": "releases/mozilla-aurora", 09:16:35 INFO - "revision": "bcca478fadc01e2f47d38675de8555cb1ced584d", 09:16:35 INFO - "stage_platform": "macosx64", 09:16:35 INFO - "builduid": "47dbb878b948470097db031390a9ce73", 09:16:35 INFO - "slavebuilddir": "test" 09:16:35 INFO - } 09:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 09:16:35 INFO - Running post-action listener: _resource_record_post_action 09:16:35 INFO - [mozharness: 2016-10-20 16:16:35.731400Z] Finished read-buildbot-config step (success) 09:16:35 INFO - [mozharness: 2016-10-20 16:16:35.731500Z] Running download-and-extract step. 09:16:35 INFO - Running pre-action listener: _resource_record_pre_action 09:16:35 INFO - Running main action method: download_and_extract 09:16:35 INFO - mkdir: /builds/slave/test/build/tests 09:16:35 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')]} 09:16:35 INFO - trying https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 09:16:35 INFO - Downloading https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/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 09:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/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 09:16:37 INFO - Downloaded 1199 bytes. 09:16:37 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 09:16:37 INFO - Using the following test package requirements: 09:16:37 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:16:37 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 09:16:37 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 09:16:37 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'jsshell-mac.zip'], 09:16:37 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 09:16:37 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 09:16:37 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 09:16:37 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 09:16:37 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 09:16:37 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 09:16:37 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 09:16:37 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:16:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:16:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:16:37 INFO - Fetch https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:16:37 INFO - Expected file size: 16436218 09:16:44 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 09:16:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 09:16:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:16:44 INFO - Fetch https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 09:16:45 INFO - Expected file size: 16436218 09:16:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 09:16:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:16:51 INFO - Fetch https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 09:16:52 INFO - Expected file size: 14414081 09:16:53 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')]} 09:16:53 INFO - trying https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:16:53 INFO - Downloading https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 09:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/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 09:16:55 INFO - Downloaded 115426076 bytes. 09:16:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:16:55 INFO - mkdir: /builds/slave/test/properties 09:16:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:16:55 INFO - Writing to file /builds/slave/test/properties/build_url 09:16:55 INFO - Contents: 09:16:55 INFO - build_url:https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 09:16:57 INFO - Running post-action listener: _resource_record_post_action 09:16:57 INFO - Running post-action listener: set_extra_try_arguments 09:16:57 INFO - [mozharness: 2016-10-20 16:16:57.093080Z] Finished download-and-extract step (success) 09:16:57 INFO - [mozharness: 2016-10-20 16:16:57.093261Z] Running populate-webroot step. 09:16:57 INFO - Running pre-action listener: _resource_record_pre_action 09:16:57 INFO - Running main action method: populate_webroot 09:16:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:16:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:16:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:16:57 INFO - '--tppagecycles', 09:16:57 INFO - '7'], 09:16:57 INFO - 'tests': ['tsvgm']}}, 09:16:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:16:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:16:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:16:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:16:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:16:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['damp', 'tps']}, 09:16:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'tests': ['damp', 'tps']}, 09:16:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['dromaeo_dom']}, 09:16:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:16:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['basic_compositor_video']}, 09:16:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:16:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['a11yr', 09:16:57 INFO - 'ts_paint', 09:16:57 INFO - 'tpaint', 09:16:57 INFO - 'sessionrestore', 09:16:57 INFO - 'sessionrestore_no_auto_restore', 09:16:57 INFO - 'tabpaint']}, 09:16:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:16:57 INFO - 'ts_paint', 09:16:57 INFO - 'tpaint', 09:16:57 INFO - 'sessionrestore', 09:16:57 INFO - 'sessionrestore_no_auto_restore', 09:16:57 INFO - 'tabpaint']}, 09:16:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:16:57 INFO - 'ts_paint', 09:16:57 INFO - 'tpaint', 09:16:57 INFO - 'sessionrestore', 09:16:57 INFO - 'sessionrestore_no_auto_restore', 09:16:57 INFO - 'tabpaint']}, 09:16:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:16:57 INFO - 'ts_paint', 09:16:57 INFO - 'tpaint', 09:16:57 INFO - 'sessionrestore', 09:16:57 INFO - 'sessionrestore_no_auto_restore', 09:16:57 INFO - 'tabpaint']}, 09:16:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['a11yr', 09:16:57 INFO - 'ts_paint', 09:16:57 INFO - 'tpaint', 09:16:57 INFO - 'sessionrestore', 09:16:57 INFO - 'sessionrestore_no_auto_restore', 09:16:57 INFO - 'tabpaint']}, 09:16:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['a11yr', 09:16:57 INFO - 'ts_paint', 09:16:57 INFO - 'tpaint', 09:16:57 INFO - 'sessionrestore', 09:16:57 INFO - 'sessionrestore_no_auto_restore', 09:16:57 INFO - 'tabpaint']}, 09:16:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['tsvgx', 09:16:57 INFO - 'tsvgr_opacity', 09:16:57 INFO - 'tart', 09:16:57 INFO - 'tscrollx', 09:16:57 INFO - 'cart']}, 09:16:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:16:57 INFO - 'tsvgr_opacity', 09:16:57 INFO - 'tart', 09:16:57 INFO - 'tscrollx', 09:16:57 INFO - 'cart']}, 09:16:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'talos_options': ['--disable-e10s'], 09:16:57 INFO - 'tests': ['tp5o']}, 09:16:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'tests': ['tp5o']}, 09:16:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'talos_options': ['--disable-e10s', 09:16:57 INFO - '--xperf_path', 09:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:57 INFO - 'tests': ['tp5n']}, 09:16:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:16:57 INFO - 'talos_options': ['--xperf_path', 09:16:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:16:57 INFO - 'tests': ['tp5n']}}, 09:16:57 INFO - 'talos.zip': {'path': '', 09:16:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:16:57 INFO - Running post-action listener: _resource_record_post_action 09:16:57 INFO - [mozharness: 2016-10-20 16:16:57.111816Z] Finished populate-webroot step (success) 09:16:57 INFO - [mozharness: 2016-10-20 16:16:57.111945Z] Running create-virtualenv step. 09:16:57 INFO - Running pre-action listener: _resource_record_pre_action 09:16:57 INFO - Running main action method: create_virtualenv 09:16:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:16:57 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 09:16:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:16:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:16:57 INFO - Using real prefix '/tools/python27' 09:16:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:16:57 INFO - Installing distribute.............................................................................................................................................................................................done. 09:17:00 INFO - Installing pip.................done. 09:17:00 INFO - Return code: 0 09:17:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:17:00 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')]} 09:17:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:00 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')]} 09:17:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:00 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:00 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 09:17:00 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 09:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:00 INFO - 'HOME': '/Users/cltbld', 09:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:00 INFO - 'LOGNAME': 'cltbld', 09:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:00 INFO - 'MOZ_NO_REMOTE': '1', 09:17:00 INFO - 'NO_EM_RESTART': '1', 09:17:00 INFO - 'PAGER': '/bin/cat', 09:17:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:00 INFO - 'PWD': '/builds/slave/test', 09:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:00 INFO - 'SHELL': '/bin/bash', 09:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:00 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:00 INFO - 'USER': 'cltbld', 09:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:00 INFO - 'XPC_FLAGS': '0x0', 09:17:00 INFO - 'XPC_SERVICE_NAME': '0', 09:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:01 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 09:17:01 INFO - Cleaning up... 09:17:01 INFO - Return code: 0 09:17:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:17:01 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')]} 09:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:01 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')]} 09:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:01 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:01 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 09:17:01 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 09:17:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:01 INFO - 'HOME': '/Users/cltbld', 09:17:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:01 INFO - 'LOGNAME': 'cltbld', 09:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:01 INFO - 'MOZ_NO_REMOTE': '1', 09:17:01 INFO - 'NO_EM_RESTART': '1', 09:17:01 INFO - 'PAGER': '/bin/cat', 09:17:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:01 INFO - 'PWD': '/builds/slave/test', 09:17:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:01 INFO - 'SHELL': '/bin/bash', 09:17:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:01 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:01 INFO - 'USER': 'cltbld', 09:17:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:01 INFO - 'XPC_FLAGS': '0x0', 09:17:01 INFO - 'XPC_SERVICE_NAME': '0', 09:17:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:01 INFO - Downloading/unpacking psutil>=3.1.1 09:17:01 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 09:17:01 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 09:17:01 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 09:17:01 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 09:17:01 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 09:17:01 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 09:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:17:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:04 INFO - Installing collected packages: psutil 09:17:04 INFO - Running setup.py install for psutil 09:17:04 INFO - building 'psutil._psutil_osx' extension 09:17:04 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 09:17:05 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 09:17:05 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 09:17:05 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 09:17:05 INFO - building 'psutil._psutil_posix' extension 09:17:05 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 09:17:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:17:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:17:05 INFO - ^ 09:17:05 INFO - 1 warning generated. 09:17:05 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 09:17:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:17:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:17:06 INFO - Successfully installed psutil 09:17:06 INFO - Cleaning up... 09:17:06 INFO - Return code: 0 09:17:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:17:06 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')]} 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:06 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')]} 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:06 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:06 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 09:17:06 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 09:17:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:06 INFO - 'HOME': '/Users/cltbld', 09:17:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:06 INFO - 'LOGNAME': 'cltbld', 09:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:06 INFO - 'MOZ_NO_REMOTE': '1', 09:17:06 INFO - 'NO_EM_RESTART': '1', 09:17:06 INFO - 'PAGER': '/bin/cat', 09:17:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:06 INFO - 'PWD': '/builds/slave/test', 09:17:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:06 INFO - 'SHELL': '/bin/bash', 09:17:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:06 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:06 INFO - 'USER': 'cltbld', 09:17:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:06 INFO - 'XPC_FLAGS': '0x0', 09:17:06 INFO - 'XPC_SERVICE_NAME': '0', 09:17:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:17:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:17:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:17:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:17:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:17:08 INFO - Installing collected packages: mozsystemmonitor 09:17:08 INFO - Running setup.py install for mozsystemmonitor 09:17:09 INFO - Successfully installed mozsystemmonitor 09:17:09 INFO - Cleaning up... 09:17:09 INFO - Return code: 0 09:17:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:17:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:17:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:09 INFO - 'HOME': '/Users/cltbld', 09:17:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:09 INFO - 'LOGNAME': 'cltbld', 09:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:09 INFO - 'MOZ_NO_REMOTE': '1', 09:17:09 INFO - 'NO_EM_RESTART': '1', 09:17:09 INFO - 'PAGER': '/bin/cat', 09:17:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:09 INFO - 'PWD': '/builds/slave/test', 09:17:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:09 INFO - 'SHELL': '/bin/bash', 09:17:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:09 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:09 INFO - 'USER': 'cltbld', 09:17:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:09 INFO - 'XPC_FLAGS': '0x0', 09:17:09 INFO - 'XPC_SERVICE_NAME': '0', 09:17:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:09 INFO - Downloading/unpacking jsonschema==2.5.1 09:17:09 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 09:17:09 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 09:17:09 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 09:17:09 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 09:17:09 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 09:17:09 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 09:17:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:17:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:12 INFO - Downloading functools32-3.2.3-2.tar.gz 09:17:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:17:12 INFO - warning: no files found matching '*.txt' 09:17:12 INFO - no previously-included directories found matching 'build' 09:17:12 INFO - no previously-included directories found matching 'dist' 09:17:12 INFO - no previously-included directories found matching '.git*' 09:17:12 INFO - Installing collected packages: jsonschema, functools32 09:17:12 INFO - Running setup.py install for functools32 09:17:12 INFO - warning: no files found matching '*.txt' 09:17:12 INFO - no previously-included directories found matching 'build' 09:17:12 INFO - no previously-included directories found matching 'dist' 09:17:12 INFO - no previously-included directories found matching '.git*' 09:17:12 INFO - Successfully installed jsonschema functools32 09:17:12 INFO - Cleaning up... 09:17:12 INFO - Return code: 0 09:17:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:17:12 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')]} 09:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:12 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')]} 09:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:12 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:12 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 09:17:12 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 09:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:12 INFO - 'HOME': '/Users/cltbld', 09:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:12 INFO - 'LOGNAME': 'cltbld', 09:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:12 INFO - 'MOZ_NO_REMOTE': '1', 09:17:12 INFO - 'NO_EM_RESTART': '1', 09:17:12 INFO - 'PAGER': '/bin/cat', 09:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:12 INFO - 'PWD': '/builds/slave/test', 09:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:12 INFO - 'SHELL': '/bin/bash', 09:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:12 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:12 INFO - 'USER': 'cltbld', 09:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:12 INFO - 'XPC_FLAGS': '0x0', 09:17:12 INFO - 'XPC_SERVICE_NAME': '0', 09:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:17:12 INFO - Cleaning up... 09:17:12 INFO - Return code: 0 09:17:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:17:12 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')]} 09:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:12 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')]} 09:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:12 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:12 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 09:17:12 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 09:17:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:12 INFO - 'HOME': '/Users/cltbld', 09:17:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:12 INFO - 'LOGNAME': 'cltbld', 09:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:12 INFO - 'MOZ_NO_REMOTE': '1', 09:17:12 INFO - 'NO_EM_RESTART': '1', 09:17:12 INFO - 'PAGER': '/bin/cat', 09:17:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:12 INFO - 'PWD': '/builds/slave/test', 09:17:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:12 INFO - 'SHELL': '/bin/bash', 09:17:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:12 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:12 INFO - 'USER': 'cltbld', 09:17:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:12 INFO - 'XPC_FLAGS': '0x0', 09:17:12 INFO - 'XPC_SERVICE_NAME': '0', 09:17:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:13 INFO - Downloading/unpacking blobuploader==1.2.4 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:13 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 09:17:15 INFO - Downloading blobuploader-1.2.4.tar.gz 09:17:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:17:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17: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 09:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:17:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 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 09:17:16 INFO - Downloading docopt-0.6.1.tar.gz 09:17:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:17:16 INFO - Installing collected packages: blobuploader, requests, docopt 09:17:16 INFO - Running setup.py install for blobuploader 09:17:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:17:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:17:17 INFO - Running setup.py install for requests 09:17:17 INFO - Running setup.py install for docopt 09:17:17 INFO - Successfully installed blobuploader requests docopt 09:17:17 INFO - Cleaning up... 09:17:17 INFO - Return code: 0 09:17:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:17 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')]} 09:17:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:17 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')]} 09:17:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:17 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:17 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 09:17:17 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 09:17:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:17 INFO - 'HOME': '/Users/cltbld', 09:17:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:17 INFO - 'LOGNAME': 'cltbld', 09:17:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:17 INFO - 'MOZ_NO_REMOTE': '1', 09:17:17 INFO - 'NO_EM_RESTART': '1', 09:17:17 INFO - 'PAGER': '/bin/cat', 09:17:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:17 INFO - 'PWD': '/builds/slave/test', 09:17:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:17 INFO - 'SHELL': '/bin/bash', 09:17:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:17 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:17 INFO - 'USER': 'cltbld', 09:17:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:17 INFO - 'XPC_FLAGS': '0x0', 09:17:17 INFO - 'XPC_SERVICE_NAME': '0', 09:17:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-jtbQzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-qrsi2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ebjBHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ciDh9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-mMZH_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-ZeWeUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-mXzC_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-G5weC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:18 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-95okOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-MOSmMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-HbPm5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PjS5DY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-XrcwS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xv7Tjo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-a2dDP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-KQHGMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:19 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-dqud05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:17:19 INFO - Running setup.py install for manifestparser 09:17:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:17:19 INFO - Running setup.py install for mozcrash 09:17:20 INFO - Running setup.py install for mozdebug 09:17:20 INFO - Running setup.py install for mozdevice 09:17:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Running setup.py install for mozfile 09:17:20 INFO - Running setup.py install for mozhttpd 09:17:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Running setup.py install for mozinfo 09:17:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Running setup.py install for mozInstall 09:17:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:17:20 INFO - Running setup.py install for mozleak 09:17:21 INFO - Running setup.py install for mozlog 09:17:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:17:21 INFO - Running setup.py install for moznetwork 09:17:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:17:21 INFO - Running setup.py install for mozprocess 09:17:21 INFO - Running setup.py install for mozprofile 09:17:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:17:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:17:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:17:21 INFO - Running setup.py install for mozrunner 09:17:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:17:21 INFO - Running setup.py install for mozscreenshot 09:17:22 INFO - Running setup.py install for moztest 09:17:22 INFO - Running setup.py install for mozversion 09:17:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:17:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:17:22 INFO - Cleaning up... 09:17:22 INFO - Return code: 0 09:17:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:22 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')]} 09:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:23 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')]} 09:17:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:23 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:23 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 09:17:23 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 09:17:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:23 INFO - 'HOME': '/Users/cltbld', 09:17:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:23 INFO - 'LOGNAME': 'cltbld', 09:17:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:23 INFO - 'MOZ_NO_REMOTE': '1', 09:17:23 INFO - 'NO_EM_RESTART': '1', 09:17:23 INFO - 'PAGER': '/bin/cat', 09:17:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:23 INFO - 'PWD': '/builds/slave/test', 09:17:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:23 INFO - 'SHELL': '/bin/bash', 09:17:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:23 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:23 INFO - 'USER': 'cltbld', 09:17:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:23 INFO - 'XPC_FLAGS': '0x0', 09:17:23 INFO - 'XPC_SERVICE_NAME': '0', 09:17:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:17:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-U7gwq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:17:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-AQRs_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:17:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-eNU330-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:17:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-YfHVM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:17:23 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)) 09:17:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:17:23 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-plkfJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-c_jfgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-crbZDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Z0Gyuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-hE1WBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-0ATOa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-Z_ccWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-aQSD4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-xHTyIP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-kyRGzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:17:24 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)) 09:17:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:24 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-PsZPsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:17:25 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)) 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:17:25 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-VR_jMB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:17:25 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)) 09:17:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:17:25 INFO - Running setup.py (path:/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/pip-sawBBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:17:25 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)) 09:17:25 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)) 09:17:25 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)) 09:17:25 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)) 09:17:25 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)) 09:17:25 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)) 09:17:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:17:25 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 09:17:25 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 09:17:25 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 09:17:25 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 09:17:25 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 09:17:25 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 09:17:28 INFO - Downloading blessings-1.6.tar.gz 09:17:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:17:28 INFO - Installing collected packages: blessings 09:17:28 INFO - Running setup.py install for blessings 09:17:28 INFO - Successfully installed blessings 09:17:28 INFO - Cleaning up... 09:17:28 INFO - Return code: 0 09:17:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:28 INFO - Reading from file tmpfile_stdout 09:17:28 INFO - Current package versions: 09:17:28 INFO - blessings == 1.6 09:17:28 INFO - blobuploader == 1.2.4 09:17:28 INFO - docopt == 0.6.1 09:17:28 INFO - functools32 == 3.2.3-2 09:17:28 INFO - jsonschema == 2.5.1 09:17:28 INFO - manifestparser == 1.1 09:17:28 INFO - mozInstall == 1.12 09:17:28 INFO - mozcrash == 0.17 09:17:28 INFO - mozdebug == 0.1 09:17:28 INFO - mozdevice == 0.48 09:17:28 INFO - mozfile == 1.2 09:17:28 INFO - mozhttpd == 0.7 09:17:28 INFO - mozinfo == 0.9 09:17:28 INFO - mozleak == 0.1 09:17:28 INFO - mozlog == 3.4 09:17:28 INFO - moznetwork == 0.27 09:17:28 INFO - mozprocess == 0.23 09:17:28 INFO - mozprofile == 0.28 09:17:28 INFO - mozrunner == 6.12 09:17:28 INFO - mozscreenshot == 0.1 09:17:28 INFO - mozsystemmonitor == 0.3 09:17:28 INFO - moztest == 0.7 09:17:28 INFO - mozversion == 1.4 09:17:28 INFO - psutil == 3.1.1 09:17:28 INFO - requests == 1.2.3 09:17:28 INFO - wsgiref == 0.1.2 09:17:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:17:28 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')]} 09:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:28 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')]} 09:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:28 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:28 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 09:17:28 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 09:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:28 INFO - 'HOME': '/Users/cltbld', 09:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:28 INFO - 'LOGNAME': 'cltbld', 09:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:28 INFO - 'MOZ_NO_REMOTE': '1', 09:17:28 INFO - 'NO_EM_RESTART': '1', 09:17:28 INFO - 'PAGER': '/bin/cat', 09:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:28 INFO - 'PWD': '/builds/slave/test', 09:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:28 INFO - 'SHELL': '/bin/bash', 09:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:28 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:28 INFO - 'USER': 'cltbld', 09:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:28 INFO - 'XPC_FLAGS': '0x0', 09:17:28 INFO - 'XPC_SERVICE_NAME': '0', 09:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 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)) 09:17:28 INFO - Cleaning up... 09:17:29 INFO - Return code: 0 09:17:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:17:29 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')]} 09:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:29 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')]} 09:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:17:29 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 0x10c705490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c67b570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf894dbb20>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, '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.bzhX4r4C9G/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.45mL35xEDx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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 09:17:29 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 09:17:29 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 09:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:17:29 INFO - 'HOME': '/Users/cltbld', 09:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:17:29 INFO - 'LOGNAME': 'cltbld', 09:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:17:29 INFO - 'MOZ_NO_REMOTE': '1', 09:17:29 INFO - 'NO_EM_RESTART': '1', 09:17:29 INFO - 'PAGER': '/bin/cat', 09:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:17:29 INFO - 'PWD': '/builds/slave/test', 09:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:17:29 INFO - 'SHELL': '/bin/bash', 09:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:17:29 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:17:29 INFO - 'USER': 'cltbld', 09:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:17:29 INFO - 'XPC_FLAGS': '0x0', 09:17:29 INFO - 'XPC_SERVICE_NAME': '0', 09:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:17:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:17:29 INFO - Cleaning up... 09:17:29 INFO - Return code: 0 09:17:29 INFO - Running post-action listener: _resource_record_post_action 09:17:29 INFO - Running post-action listener: _start_resource_monitoring 09:17:29 INFO - Starting resource monitoring. 09:17:29 INFO - [mozharness: 2016-10-20 16:17:29.296221Z] Finished create-virtualenv step (success) 09:17:29 INFO - [mozharness: 2016-10-20 16:17:29.297189Z] Running install step. 09:17:29 INFO - Running pre-action listener: _resource_record_pre_action 09:17:29 INFO - Running main action method: install 09:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:17:29 INFO - Reading from file tmpfile_stdout 09:17:29 INFO - Detecting whether we're running mozinstall >=1.0... 09:17:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:17:29 INFO - Reading from file tmpfile_stdout 09:17:29 INFO - Output received: 09:17:29 INFO - Usage: mozinstall [options] installer 09:17:29 INFO - Options: 09:17:29 INFO - -h, --help show this help message and exit 09:17:29 INFO - -d DEST, --destination=DEST 09:17:29 INFO - Directory to install application into. [default: 09:17:29 INFO - "/builds/slave/test"] 09:17:29 INFO - --app=APP Application being installed. [default: firefox] 09:17:29 INFO - mkdir: /builds/slave/test/build/application 09:17:29 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'] 09:17:29 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 09:18:01 INFO - Reading from file tmpfile_stdout 09:18:01 INFO - Output received: 09:18:01 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:18:01 INFO - Running post-action listener: _resource_record_post_action 09:18:01 INFO - [mozharness: 2016-10-20 16:18:01.913949Z] Finished install step (success) 09:18:01 INFO - [mozharness: 2016-10-20 16:18:01.914081Z] Running run-tests step. 09:18:01 INFO - Running pre-action listener: _resource_record_pre_action 09:18:01 INFO - Running main action method: run_tests 09:18:01 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:18:01 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:18:01 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:18:01 INFO - 2016-10-20 09:18:01.928 screenresolution[1639:7982] starting screenresolution argv=screenresolution get 09:18:01 INFO - 2016-10-20 09:18:01.931 screenresolution[1639:7982] Display 0: 1600x1200x32@60 09:18:01 INFO - 2016-10-20 09:18:01.936 screenresolution[1640:7984] starting screenresolution argv=screenresolution list 09:18:01 INFO - Available Modes on Display 0 09:18:01 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:18:01 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:18:01 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:18:01 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:18:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:18:02 INFO - Intel Iris: 09:18:02 INFO - Chipset Model: Intel Iris 09:18:02 INFO - Type: GPU 09:18:02 INFO - Bus: Built-In 09:18:02 INFO - VRAM (Dynamic, Max): 1536 MB 09:18:02 INFO - Vendor: Intel (0x8086) 09:18:02 INFO - Device ID: 0x0a2e 09:18:02 INFO - Revision ID: 0x0009 09:18:02 INFO - Displays: 09:18:02 INFO - Display: 09:18:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:18:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:18:02 INFO - Display Serial Number: 1600x1200 60 09:18:02 INFO - Main Display: Yes 09:18:02 INFO - Mirror: Off 09:18:02 INFO - Online: Yes 09:18:02 INFO - Rotation: Supported 09:18:02 INFO - Return code: 0 09:18:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:18:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:18:02 INFO - Python 2.7.3 09:18:02 INFO - Return code: 0 09:18:02 INFO - grabbing minidump binary from tooltool 09:18:02 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')]} 09:18:02 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 0x10c519d30>, '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 0x10c37fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c511b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:18:02 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 09:18:02 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 09:18:02 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 09:18:02 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:18:02 INFO - Return code: 0 09:18:02 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:18:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:18:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:18:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:18:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:18:02 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', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:18:02 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 --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0102 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:18:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bzhX4r4C9G/Render', 09:18:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:18:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:18:02 INFO - 'HOME': '/Users/cltbld', 09:18:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:18:02 INFO - 'LOGNAME': 'cltbld', 09:18:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:18:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:18:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:18:02 INFO - 'MOZ_NO_REMOTE': '1', 09:18:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:18:02 INFO - 'NO_EM_RESTART': '1', 09:18:02 INFO - 'PAGER': '/bin/cat', 09:18:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:18:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:18:02 INFO - 'PWD': '/builds/slave/test', 09:18:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:18:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:18:02 INFO - 'SHELL': '/bin/bash', 09:18:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.45mL35xEDx/Listeners', 09:18:02 INFO - 'TMPDIR': '/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/', 09:18:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:18:02 INFO - 'USER': 'cltbld', 09:18:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:18:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:18:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:18:02 INFO - 'XPC_FLAGS': '0x0', 09:18:02 INFO - 'XPC_SERVICE_NAME': '0', 09:18:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:18:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0102', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:18:02 INFO - mozversion application_buildid: 20161020062850 09:18:02 INFO - mozversion application_changeset: bcca478fadc01e2f47d38675de8555cb1ced584d 09:18:02 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:18:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:18:02 INFO - mozversion application_name: Firefox 09:18:02 INFO - mozversion application_remotingname: firefox-dev 09:18:02 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:18:02 INFO - mozversion application_vendor: Mozilla 09:18:02 INFO - mozversion application_version: 51.0a2 09:18:02 INFO - mozversion platform_buildid: 20161020062850 09:18:02 INFO - mozversion platform_changeset: bcca478fadc01e2f47d38675de8555cb1ced584d 09:18:02 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:18:02 INFO - mozversion platform_version: 51.0a2 09:18:02 INFO - using testdate: 1476980282 09:18:02 INFO - actual date: 1476980282 09:18:02 INFO - starting webserver on 'localhost:49267' 09:18:02 INFO - SUITE-START | Running 2 tests 09:18:02 INFO - TEST-START | dromaeo_css 09:18:02 INFO - operating with platform_type : mac_ 09:18:02 INFO - Initialising browser for dromaeo_css test... 09:18:02 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpU0CK9B/profile http://localhost:49267/getInfo.html) 09:18:05 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 09:18:05 INFO - PROCESS | 1650 | colorDepth:24 09:18:05 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 09:18:05 INFO - PROCESS | 1650 | __metrics 09:18:05 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:18:05 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:18:05 INFO - TEST-INFO | 1650: exit 0 09:18:05 INFO - Browser initialized. 09:18:05 INFO - Running cycle 1/1 for dromaeo_css test... 09:18:05 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmpU0CK9B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:18:17 INFO - PROCESS | 1653 | RSS: Main: 219189248 09:18:17 INFO - PROCESS | 1653 | 09:19:09 INFO - PROCESS | 1653 | 1476980349717 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] 09:21:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49267/tests/dromaeo/cssquery-ext.html) 09:21:22 INFO - PROCESS | 1653 | RSS: Main: 348835840 09:21:22 INFO - PROCESS | 1653 | 09:24:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-ext.html (next: http://localhost:49267/tests/dromaeo/cssquery-jquery.html) 09:24:25 INFO - PROCESS | 1653 | RSS: Main: 349405184 09:24:25 INFO - PROCESS | 1653 | 09:27:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49267/tests/dromaeo/cssquery-mootools.html) 09:27:28 INFO - PROCESS | 1653 | RSS: Main: 326148096 09:27:28 INFO - PROCESS | 1653 | 09:30:31 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49267/tests/dromaeo/cssquery-prototype.html) 09:30:31 INFO - PROCESS | 1653 | RSS: Main: 323268608 09:30:31 INFO - PROCESS | 1653 | 09:33:35 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49267/tests/dromaeo/cssquery-yui.html) 09:33:35 INFO - PROCESS | 1653 | RSS: Main: 316096512 09:33:35 INFO - PROCESS | 1653 | 09:36:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49267/tests/dromaeo/cssquery-yui.html (next: http://localhost:49267/tests/dromaeo/cssquery-dojo.html) 09:36:38 INFO - PROCESS | 1653 | RSS: Main: 394838016 09:36:38 INFO - PROCESS | 1653 | 09:36:38 INFO - PROCESS | 1653 | __start_tp_report 09:36:38 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:36:38 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:36:38 INFO - PROCESS | 1653 | |i|pagename|runs| 09:36:38 INFO - PROCESS | 1653 | |0;dojo.html;2779.916602501923;3343.7659363844527;3350.5644266245386;3387.1362802485364;3420.7947523148614;5707.14392841074;5805.506531944785;5875.794347197849;5918.1418694289305;5918.171455996158;5829.941700583004;5889.558283128761;5915.290165180174;5917.822465326037;5931.495822855051;5270.367555893288;5318;5331.840044798643;5357.035733567956;5370.113931201347;5275.446078161795;5279.023380674587;5283.656562323456;5379.757910894;5417.810376636819;5320.547753440962;5339.22581225722;5345.599080068991;5346.946530534703;5359.437259087798;5329.680219186861;5353.2237825515085;5391.865203369908;5392;5393.83818485446;5194.71429071401;5289.709066001368;5328.573714102862;5368.70472124033;5384.461553844623;5757.712114394263;5784.537237021028;5827.417258274181;5842.152887831241;5878.088896221093;6273.56085074045;6291.197994139668;6292.811215663537;6303.023031430135;6316.6841657917375;6236.064590311445;6279.152314437538;6281.528885333572;6294.213223347082;6298.968505157491;5817.592768506206;5864.325602555676;5893.174955506232;5926.318473375531;5936.7922122725495;6357.777477788255;6360.713767880364;6366.140571022946;6368.42684158428;6369.554131210771;5247.18668606359;6302.054691796267;6308.905366419507;6312.621242725451;6323.146375239376;6218;6224.128621992924;6233.812985610439;6253.155823963707;6272.435480806749;6327.430531252209;6355.491560675135;6356.078368636614;6363.077353783676;6366.840828979312;6266.686665666698;6307.180066591313;6313.43179113882;6330.240371155491;6355.713992870332;4872.952315252167;4972.279019542146;4990.950090499048;5048.268001139814;5053.216751403538;4538.410006699174;4562;4563.657725670521;4574.748388838646;4587.541245875453;5860.208871802252;5877.089051197071;5903.085021821625;5906.940930590725;5911.852203694942;6187.81436556904;6234.719437625317;6246;6252.74989000444;6256.593321434092;5937.0203916354185;5949.750552383961;5955.285365756137;5960.731767070492;5966.761329546856;4503.797329120198;5493.972530137324;5496.945030549723;5502.312210973629;5517.062099443105;5800.274965629296;6215.96892015537;6226.5641405101205;6240.469560087353;6251.374862513712;6251.624902505864;6256.781012664717;6263.65549894742;6265.624062556261;6276.560640755103;6320.747170113144;6327.240731112296;6338.397852204033;6344.873102538016;6348.809535713936;6137.8366772191985;6215.223097112861;6270.623762574261;6280.591761535486;6283.403076707706;6203.100550420074;6232.470240029648;6258.499320054294;6321.209848768904;6324.051392291193;6117.388261173847;6216.191895053795;6220.409061139185;6226.221722284715;6234.563580549499;5210.426853046086;6121.32665406796;6182.165407669907;6248.125262463168;6250.1874756281395;6031.215941927521;6060.424259695322;6074.236242412216;6105.725242364193;6126.142340072304;6198.2252218472695;6198.690065496798;6201.627902325875;6207.720652570735;6229.345918678655;6069.696515174312;6099.359567245553;6123;6136.723847426966;6136.846578835565 09:36:38 INFO - PROCESS | 1653 | |1;ext.html;473.46025530894764;482.41145802121423;489.65968651787;514.6320380927637;529.3912001198621;30581.541276880864;31598.420078996045;32810.67189328106;40573.18853622926;41631.375529367084;40637.59362406375;42531;42989.570104298946;43004.354934675925;43056;9595.760105997337;9750.36622619531;9761.219102471785;9769.511524423786;9787.706368808947;8645.092265312145;8837.204651581356;8843.380963332569;9714;9805;8831.116888311182;8893.066228046058;11753.588624398148;11964;12021.15851890368;11934.880651193464;12007;12014.939925300405;12020.819687704692;12100.515979360815;11849.94075029628;11960.40197990097;11962.700932476671;11963.282203067844;12031.398430078549;31631;32359.838200808845;39816;40012.799936000134;40064.59935400667;3202.96797032029;3205.166656669283;3506.7194624429985;3938.5273767148124;3946.3291240489184;29032.41935161306;29149.41701165986;31021.84489077563;31157.065288041395;31920.840395798106;3223.403670320998;3229.9838500807346;3236.4336241157703;3257.804531728104;3358.5465962095295;381158;381842;382012;383145;387413;48908.75545622249;50726.74636626867;51374.48625513697;57863.710681446326;58459.123113153335;61442;61860.69069654713;61909;61945.38054619396;62090.0686489703;14299.356528956221;16328.75506867398;16346.75479867803;16354.591135221477;16511.422100226435;12756.553520626734;12848.871511284955;12857.4214160363;12964.481420743065;13019.804702929463;13871.722565548633;15614.84385156134;15658.295376708076;15673.68652626941;15708.68582628341;5580.325902229315;6592.571482853599;6625.436837868739;6664.500162487833;6720.932790672031;826.9710560130487;945.3760518058049;948.1987720376271;972.6595691507915;1003.934744241622;29357.26606834846;30068.248293792392;30133;30431.847840760656;30803.075907722803;897.2014906733012;985.8077674853334;986.0435377683779;999.3354419311077;1081.324172392255;14036.877049835988;14929.925350373396;15180.696386072217;15430;15623.062616243062;631665;651217;651258;651528;652122;53031.469685303426;53808;53985.1902221467;57603.84792304131;57915;1300.8699130086916;1305.3473263368317;1336.3785839584639;1346.0443085409274;1348.649351168723;29857.70142298549;30151.246218844706;32195.839020805684;32239;32795.508067378534;55896.72051639716;56372.87254254974;56374;56512;56597;387931;400522;401030;598607;607227;25157.24528264155;25491.107811226517;25516.48967020686;25585.87207063953;25644.102456413937;45166.32250516311;45489.77255113703;45605.54394456013;45612;45680;32986.010419687445;37108.257834843695;37456.81271593733;37664;37980.62019379771;36071.27857442784;36908.70505166686;37114.814425927696;37143.25713485769;37787.677431289776;36769.816150919076;37378.8131059343;37586.436203456426;37601;37627.87116386513;28052;31770.04689859308;33259;33964.83017584896;34098.31803363968;25111.402880560545;25166.874165629055;25217.243482695547;25346.873265633552;25662.8716856422 09:36:38 INFO - PROCESS | 1653 | |2;jquery.html;348.3555422468432;353.1013570463171;370.885025642051;373.689837434929;400.07183334663574;15246.313915873785;15312.617184570392;16418.91790541047;21189.470263243427;21888.90555472228;19308.4207473776;20064.699029514533;20522.48693782656;20761;20766.377008689728;5752.309722833245;5757.366689664133;6003.759849606011;6004.249468816398;6022.066579680157;5340.54605358545;5878.970605146968;6001.699915004254;6047.818565443022;6066.393360663942;4125;4362.912741745163;6338.556301058928;6601.768938087168;6654.733810647568;5748.741306641211;6053.334133245339;6693.263740988487;6707.295733947938;6734.225564060147;5950.047992321208;5955.255593050869;5966.373530779249;5972.940270597325;5978.312494063195;24977.50044999108;25720.614190787153;26328.47343053128;26420.86789566059;26536;2104.947376315589;2219.6004719150546;2244.494988627562;2365.698850790793;2446.559619268531;9604.66383676568;10000.249981251436;10041.54813033408;10155.238357123246;10372.11836993849;1664.8085470170843;1802.8197180281998;1853.9536511587182;1870.1490821676105;1949.9025048747505;124392;126273;126532.36733816365;128801.35599321943;131419.34290328488;9282.860757088649;9460.337776355589;9977.650782222587;10134.290599658101;11504.15933450644;11437.656870293904;12518.561850335194;12519.43662535188;12521.436535355931;12521.937390313173;7851.60741962911;7890.698034824304;7954.045514538292;7970.601469926596;8050.59747012647;6961.129858767654;8244.29923456513;8385.287250583646;8395.62219700115;8430.536320502431;3810.65704086628;3855.614438556122;3857.8263978121054;3874.2832575973534;3931.351327031065;1663.7254852949127;1736.827641342089;1884.7738271407245;1907.4754442528138;1954.2573821947854;824.8061705499202;833.5415521463171;886.499127992695;985.2659768472533;992.33827177714;21795.128194872344;22267.665985010237;22306.442338941655;22308.55382892333;22394.216202432835;922.7508572685338;933.7347893604069;943.1228957069991;954.4464210757744;1003.5584342889251;10903.890961090447;11692.00617947484;11703.005244554139;11715.00422464083;11718.355490447937;596949;613943;622626;623830;642768.5723142802;96322.03677963131;107386.46306768416;139897;143265.28367358306;147211;960.4093482508207;972.2222222222194;998.960041598328;999.1157825324494;1000.0599436529639;19304.324348648293;19798.80201198027;19896.90051549733;19904.90047549811;19912.904790236676;54996.25243591698;55076.17385739137;55906.720466397404;55921.16401589383;57061;81835.77246341191;84165;84515.5774221125;84746.88132796483;85336.57331713302;6678.298778628174;6925.792226233221;6998.160220773336;8237;8328.750137495885;7864.410169237216;12430.751384972431;13378.665533361744;13398.052428465722;13474.461021559027;11512.82730759056;11558.768824623292;11595.8260626089;11875.821862671894;11917;9560.235181185628;10988.890111098786;11034.282771619819;11366.204365694322;11503.367314797766;11582.36297003673;11586.188966772244;11821.527138914347;12017;12063.81904271419;8107.918920810716;8129.227723366271;8296.294814940798;8512.70205542803;8549.700760473354;10812.35125892449;11386.829197562209;11726.472308745957;12114.454849531969;12184.817227741414 09:36:38 INFO - PROCESS | 1653 | |3;mootools.html;1299.3633119771312;1303.504668226074;1525.4279645133074;1607.573992891883;1822.639681612312;7721.845563088735;8257.339412846974;8574.742757717278;8815.911840881588;8835.646574137027;8692.087330830267;8792.47245165289;8808.515531645757;8810.427322224066;8811.162939520751;2375.6199008158696;2409.5421869844763;2412.3124909400826;2412.7828495435406;2413.51729654069;2352.2590384029063;2391.9594976185326;2399.4241382068267;2402.255300856731;2403.2429784617875;2359.49270906755;2360.8819559022068;2370.3244575296044;2393.162393162388;2403.4952659941346;2347.5774360615083;2367.4554852383962;2374.5607062693457;2377.227401094651;2378.1200955646436;2320.234322673514;2357.2456813819585;2366.1363602285214;2366.4438856868624;2368.4315764216635;8684.47893126408;8761.474311541264;8793.472391656522;8809.207171354545;8829.735107946772;5185.637005409623;5372;5375.0862353399625;5417.4311697272005;5423.647462914937;3459.221675123102;3621.529201203853;3665.120371110941;3679;3680.723945704056;1076.4725284610563;1098.357460885383;1103.2497901427028;1127.4926283172606;1128.5880653561474;11532.769344613062;11536.711582210428;11612.419379031015;11613.593524226697;11622.244554103956;4427.203103441411;4500.369948207253;4664.113818374498;4690.530946905282;4695.131400690815;9090.590923408463;9101.635934562544;9105.271578273721;9113.908860911439;9123.224525915239;5214.348206474191;5240.764165612557;5242;5244.921326180111;5251.2123181523075;4157.189348077096;4394.12117576486;4543.522930092358;4544.409226800495;4904.509549045139;3776.4335349697217;3814.256220037066;3851.364524853424;3894.4937158169823;3903.980480097581;1169.9415029248503;1180.0972256223995;1185.9881401185878;1195.5875223048035;1200.4417945655312;866.5234121233296;878.3544095090103;878.543157558079;898.1108702384593;910.7040211931148;5629.183768353566;5878.088896221093;5887.735051922674;5971.4327138921735;6073.420910563197;881.9691310804219;902.7382059202757;910.0853642089658;916.2074805293373;922.1792604581927;3670.953778173261;3723.8510459581853;3790.5830358660523;3801.581825999138;3818.8281527331337;10528.315659482108;10818.94590527058;10922.017018468376;10933.398663073607;10970.670879873616;10858.131349492021;10864.130869530418;10866.72833179161;10870.152074147414;10926.508307126198;8127.2279133482225;8192.631331590093;8247.670093196324;8253.628586713612;8262.297704695047;5137.974310128426;5330.653507521999;5376.542993845567;5517.889642207214;5690.4878560928055;9436.95281523588;9645.565949532147;9742.805143897223;10014;10059.044390782863;9212.355135140744;10002.549885255035;10168.389896606228;10334.844977325196;10341.4312212829;6575.309592492719;6743.291954344723;6751.358620931003;6957.130358705162;6961.269066747918;8103.230193131643;8112.089274643521;8187.181281871765;8209.753707388787;8230.794230144054;6522.119513865568;7435.962820185864;7448.776536703907;7461.552306861606;7576.431767617561;7131.643417829192;7218.314260145278;7316.304951029643;7344.96327518359;7368.820988641792;5927.911081333869;7011.929880701127;7013.964930175521;7016.228214896255;7020.192677842114;4734.952650473451;4759.262314341283;4833.130036593447;4865.781039853145;4938.209886418156;4737.692050016738;4820.638452116035;4847.563719265283;4950.603951683928;5007.84976450707 09:36:38 INFO - PROCESS | 1653 | |4;prototype.html;255.61657513729395;282.9165396208118;299.27276717576285;306.9662337142914;311.48293832238477;4380.160332660283;4679.478215705466;5410.594205434593;5449.427810079944;5454.290942177521;3917.784521851297;4328.913421731563;4882.853514394574;5166.715830629314;5229.424763276036;3360.747943904205;3810.8567429770956;3854.747207157671;3942.1130245694776;4103.815328310233;3711.536057992751;4076.714629975903;4103.712740108193;4131.7934103294865;4141.6065473779945;3287.8356082195796;3518.243577630809;3663.6444515529292;3777.7355585109053;4093.6520395766397;3369.6124945631077;3640.4698734379485;3947.065937690511;4022.597740225983;4046.3092043790843;3542.096765324826;3551.396262635358;3555.2178520725397;3563.233904710474;3563.6614521620404;4101.569335219789;4484.1928452878465;4952.963955330449;5009.699418034929;5179.922301165486;4204.201201771653;4398.516163222075;4639.628829693616;4678.812847486097;4733.195356789354;4331.501877284121;4667.836625718118;4786.808527658889;4964.652474326798;5668.348139963916;3944.684425245973;3950.5851885551892;3960.980195099035;3961.841526338943;3969.7816620085882;4714.95285047152;5043.470435604282;5830.2420685310635;5882.264761876197;5933.436323549256;3230.6607806180014;3574.767640103385;3659.682514294852;3685.4840322354894;3848.9223017555128;3168.002079344999;3518.683318501296;4059.6752259819145;4066.8169932353117;4074.2258970795456;3897;4445.409074317038;4544.613707834871;4685.617742765892;4735.384400028043;4913.066517361762;5378.865528361822;5539.833804985857;5564.415736347706;5661.943380566224;1375.6767159717458;1384.7438223928605;1386.4956522173354;1388.1046724862408;1389.6664800448023;859.4070091636751;885.2254277507182;893.2452077994085;899.1547944931874;926.6571368593663;4725.621950243973;4968.354113965162;5230.992179496805;5290.28581141541;5303.257543943851;5771.278590176228;5799.9130013049835;5808.970955145197;5813.3895940925595;5819.418058194146;5019.598432125421;5278.577713782888;5355.116405793001;5393.545936598838;5417.349918009864;3018.351054523288;3062.617172853393;3077.815331080142;3078.3843231353817;3095.5820964169548;5533.778648854081;5770.855728606818;5903.527717782567;5941.58408911372;6029.577929544977;4953.826616068421;5948.524118070544;5952.880942381128;5992.041273396323;5993.760249590055;5209.6092793041435;5955.076963070731;5962.612430192024;5964.970175149183;5973.970130149321;4742.834000809955;5066.392032956069;5204.8178313758835;5860.560457965585;5868.623207600928;4964.7765850537535;5063.873403164803;5746.655200687972;5785.566082543742;5795;5087;5247.685138891678;5437.504686211323;5856;5958.672273025025;3742.5321834770652;3857.672097871712;3881.223755248905;3914.238592633383;3917.9020524485977;4772.5227477252;5158.406783219978;5835.503982161564;5855.8536036597725;5871.4715675589405;5389.62272640927;5703.258576385043;5713.600047996601;5727.541796656341;5731.570132240182;4925.876853078702;5282.207668849704;5668.574856885668;5687.3459552152035;5710;5256.265432407373;5261.342332208474;5350.598705097211;5524.2322456815045;5591.30108736408;5298.947010529845;5494.752736126964;5527.613067085265;5625.606207565595;5666.490015898589;4641.721496710208;4846.127697014571;5515.338159420895;5534.806281780118;5535.446455354432 09:36:39 INFO - PROCESS | 1653 | |5;yui.html;675.912131422915;709.0194211823272;722.8807246804278;782.8882986159653;817.480899628736;14786.334614942327;15552.611184720374;15971.92014039931;16028.75956860648;16935.91532042341;15743.606409839731;16372.590685232875;16616.418425355114;16642.58393540162;16642.916785416088;817.6075483767795;827.954462504562;855.9700410485634;856.9271611912994;862.7153039496951;682.4506272450675;705.8376573388124;709.2517394149171;832.5504227717025;852.4544291653316;904.023654453189;906.9274458043341;907.8547432410816;908.5275656658533;912.333996182787;902.0798785239052;903.6791938861675;903.7966457547066;904.0959040959041;906.2025417632507;522.1593234891822;542.956563474921;644.1239913717387;664.4850241063166;668.5721138471382;15248.923755381264;15307.387704491806;15312.617184570363;15313.081215127017;15325.770113448307;11972.58095966637;12131;12156.884153271289;12287.447064882102;12505.124641275115;12396.194247373982;12762.361881905868;12895.484180632764;12991.805122923164;13030.609081727564;4486.887827804331;4586.3579098926175;4618.122556714214;4761.166795810719;4775.021120670289;122025;124337.37831310875;125277.37361313227;125687.37156314251;127394;10606.787864242671;10671.94664026675;10825.621103261348;10913.072388846878;10931.617393391192;21008.15967361319;21037.474063148544;21052.89473552653;21093.62891412084;21626.675599866016;7676.117246516722;7777.688892444352;7802.141764405911;7809.882851757228;7888.5266883986;4269.475191693789;4335.3713711511655;4343.9348409773875;4380.540043295472;4454.465464144323;3548.698360639323;3699.648533389324;3704.1850792825535;3710.703143748494;3713.9442908356395;654.731560060373;660.9636469994197;663.0352836622702;674.993250067493;694.5589550635282;622.3434276837979;660.7324033766237;672.9158855143107;675.4630069095081;699.7201119552118;9116.680916168036;9455.338126331091;9472.479013654316;9510.302328136431;9572.56923438447;573.3263415486787;678.7646483400263;687.4328678839977;694.2502097734434;696.689972962027;4066.4916885389325;4393.406890069799;4589.35748995141;4650.883727906829;4651.2557990722;147675;165155;168692;170584.1470792638;172549;99459.50270248602;101009.49495252623;125001;128779;146500;80329.59835200786;101938;102855.48572257091;112761;112840.43579782048;9552.283578731483;9696.85454718194;9959.302848800515;10202.489875506344;10273.589056437659;44393.55606443894;46829;55542.72228638831;58669.013133884095;59225.70387148209;66275.66862165659;86472;96842;98049.50975245364;102238;12637.74724505523;12748.74502509926;13060.804087938499;13258.204507729568;13418;12630.134534498673;14105.224212668401;14997.625059373602;15281.35932033983;15880.761788573413;13540;14045.859541404863;14135.505257315945;14422.927885360506;14722.484713034992;13050.869491304966;13964.581062568139;14212.857871421153;14392;14431.45431528756;13140.73718525605;13463.653634636457;13467.461301547828;13713.245771482665;13875.514356997457;10910.509027093642;11188.66434006981;11243.132108049766;11650.88349116498;11825.586104486301;11196.992270695677;11256.155788316073;11414.828777568177;11724.58963936258;11748.823767643664 09:36:39 INFO - PROCESS | 1653 | __end_tp_report 09:36:39 INFO - PROCESS | 1653 | __start_cc_report 09:36:39 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1258 09:36:39 INFO - PROCESS | 1653 | __end_cc_report 09:36:39 INFO - PROCESS | 1653 | __startTimestamp1476981398987__endTimestamp 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:36:39 INFO - PROCESS | 1653 | Number of tests: 6 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - PROCESS | 1653 | [#0] dojo.html Cycles:165 Average:5822.03 Median:6099.36 stddev:654.55 (10.7%) stddev-sans-first:611.51 09:36:39 INFO - PROCESS | 1653 | Values: 2779.9 3343.8 3350.6 3387.1 3420.8 5707.1 5805.5 5875.8 5918.1 5918.2 5829.9 5889.6 5915.3 5917.8 5931.5 5270.4 5318.0 5331.8 5357.0 5370.1 5275.4 5279.0 5283.7 5379.8 5417.8 5320.5 5339.2 5345.6 5346.9 5359.4 5329.7 5353.2 5391.9 5392.0 5393.8 5194.7 5289.7 5328.6 5368.7 5384.5 5757.7 5784.5 5827.4 5842.2 5878.1 6273.6 6291.2 6292.8 6303.0 6316.7 6236.1 6279.2 6281.5 6294.2 6299.0 5817.6 5864.3 5893.2 5926.3 5936.8 6357.8 6360.7 6366.1 6368.4 6369.6 5247.2 6302.1 6308.9 6312.6 6323.1 6218.0 6224.1 6233.8 6253.2 6272.4 6327.4 6355.5 6356.1 6363.1 6366.8 6266.7 6307.2 6313.4 6330.2 6355.7 4873.0 4972.3 4991.0 5048.3 5053.2 4538.4 4562.0 4563.7 4574.7 4587.5 5860.2 5877.1 5903.1 5906.9 5911.9 6187.8 6234.7 6246.0 6252.7 6256.6 5937.0 5949.8 5955.3 5960.7 5966.8 4503.8 5494.0 5496.9 5502.3 5517.1 5800.3 6216.0 6226.6 6240.5 6251.4 6251.6 6256.8 6263.7 6265.6 6276.6 6320.7 6327.2 6338.4 6344.9 6348.8 6137.8 6215.2 6270.6 6280.6 6283.4 6203.1 6232.5 6258.5 6321.2 6324.1 6117.4 6216.2 6220.4 6226.2 6234.6 5210.4 6121.3 6182.2 6248.1 6250.2 6031.2 6060.4 6074.2 6105.7 6126.1 6198.2 6198.7 6201.6 6207.7 6229.3 6069.7 6099.4 6123.0 6136.7 6136.8 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - PROCESS | 1653 | [#1] ext.html Cycles:180 Average:64242.48 Median:37417.81 stddev:138590.50 (370.4%) stddev-sans-first:138896.58 09:36:39 INFO - PROCESS | 1653 | Values: 473.5 482.4 489.7 514.6 529.4 30581.5 31598.4 32810.7 40573.2 41631.4 40637.6 42531.0 42989.6 43004.4 43056.0 9595.8 9750.4 9761.2 9769.5 9787.7 8645.1 8837.2 8843.4 9714.0 9805.0 8831.1 8893.1 11753.6 11964.0 12021.2 11934.9 12007.0 12014.9 12020.8 12100.5 11849.9 11960.4 11962.7 11963.3 12031.4 31631.0 32359.8 39816.0 40012.8 40064.6 3203.0 3205.2 3506.7 3938.5 3946.3 29032.4 29149.4 31021.8 31157.1 31920.8 3223.4 3230.0 3236.4 3257.8 3358.5 381158.0 381842.0 382012.0 383145.0 387413.0 48908.8 50726.7 51374.5 57863.7 58459.1 61442.0 61860.7 61909.0 61945.4 62090.1 14299.4 16328.8 16346.8 16354.6 16511.4 12756.6 12848.9 12857.4 12964.5 13019.8 13871.7 15614.8 15658.3 15673.7 15708.7 5580.3 6592.6 6625.4 6664.5 6720.9 827.0 945.4 948.2 972.7 1003.9 29357.3 30068.2 30133.0 30431.8 30803.1 897.2 985.8 986.0 999.3 1081.3 14036.9 14929.9 15180.7 15430.0 15623.1 631665.0 651217.0 651258.0 651528.0 652122.0 53031.5 53808.0 53985.2 57603.8 57915.0 1300.9 1305.3 1336.4 1346.0 1348.6 29857.7 30151.2 32195.8 32239.0 32795.5 55896.7 56372.9 56374.0 56512.0 56597.0 387931.0 400522.0 401030.0 598607.0 607227.0 25157.2 25491.1 25516.5 25585.9 25644.1 45166.3 45489.8 45605.5 45612.0 45680.0 32986.0 37108.3 37456.8 37664.0 37980.6 36071.3 36908.7 37114.8 37143.3 37787.7 36769.8 37378.8 37586.4 37601.0 37627.9 28052.0 31770.0 33259.0 33964.8 34098.3 25111.4 25166.9 25217.2 25346.9 25662.9 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - PROCESS | 1653 | [#2] jquery.html Cycles:180 Average:36031.90 Median:350.73 stddev:103677.32 (29560.6%) stddev-sans-first:103933.54 09:36:39 INFO - PROCESS | 1653 | Values: 348.4 353.1 370.9 373.7 400.1 15246.3 15312.6 16418.9 21189.5 21888.9 19308.4 20064.7 20522.5 20761.0 20766.4 5752.3 5757.4 6003.8 6004.2 6022.1 5340.5 5879.0 6001.7 6047.8 6066.4 4125.0 4362.9 6338.6 6601.8 6654.7 5748.7 6053.3 6693.3 6707.3 6734.2 5950.0 5955.3 5966.4 5972.9 5978.3 24977.5 25720.6 26328.5 26420.9 26536.0 2104.9 2219.6 2244.5 2365.7 2446.6 9604.7 10000.2 10041.5 10155.2 10372.1 1664.8 1802.8 1854.0 1870.1 1949.9 124392.0 126273.0 126532.4 128801.4 131419.3 9282.9 9460.3 9977.7 10134.3 11504.2 11437.7 12518.6 12519.4 12521.4 12521.9 7851.6 7890.7 7954.0 7970.6 8050.6 6961.1 8244.3 8385.3 8395.6 8430.5 3810.7 3855.6 3857.8 3874.3 3931.4 1663.7 1736.8 1884.8 1907.5 1954.3 824.8 833.5 886.5 985.3 992.3 21795.1 22267.7 22306.4 22308.6 22394.2 922.8 933.7 943.1 954.4 1003.6 10903.9 11692.0 11703.0 11715.0 11718.4 596949.0 613943.0 622626.0 623830.0 642768.6 96322.0 107386.5 139897.0 143265.3 147211.0 960.4 972.2 999.0 999.1 1000.1 19304.3 19798.8 19896.9 19904.9 19912.9 54996.3 55076.2 55906.7 55921.2 57061.0 81835.8 84165.0 84515.6 84746.9 85336.6 6678.3 6925.8 6998.2 8237.0 8328.8 7864.4 12430.8 13378.7 13398.1 13474.5 11512.8 11558.8 11595.8 11875.8 11917.0 9560.2 10988.9 11034.3 11366.2 11503.4 11582.4 11586.2 11821.5 12017.0 12063.8 8107.9 8129.2 8296.3 8512.7 8549.7 10812.4 11386.8 11726.5 12114.5 12184.8 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - PROCESS | 1653 | [#3] mootools.html Cycles:180 Average:5615.56 Median:4856.67 stddev:3162.49 (65.1%) stddev-sans-first:3154.73 09:36:39 INFO - PROCESS | 1653 | Values: 1299.4 1303.5 1525.4 1607.6 1822.6 7721.8 8257.3 8574.7 8815.9 8835.6 8692.1 8792.5 8808.5 8810.4 8811.2 2375.6 2409.5 2412.3 2412.8 2413.5 2352.3 2392.0 2399.4 2402.3 2403.2 2359.5 2360.9 2370.3 2393.2 2403.5 2347.6 2367.5 2374.6 2377.2 2378.1 2320.2 2357.2 2366.1 2366.4 2368.4 8684.5 8761.5 8793.5 8809.2 8829.7 5185.6 5372.0 5375.1 5417.4 5423.6 3459.2 3621.5 3665.1 3679.0 3680.7 1076.5 1098.4 1103.2 1127.5 1128.6 11532.8 11536.7 11612.4 11613.6 11622.2 4427.2 4500.4 4664.1 4690.5 4695.1 9090.6 9101.6 9105.3 9113.9 9123.2 5214.3 5240.8 5242.0 5244.9 5251.2 4157.2 4394.1 4543.5 4544.4 4904.5 3776.4 3814.3 3851.4 3894.5 3904.0 1169.9 1180.1 1186.0 1195.6 1200.4 866.5 878.4 878.5 898.1 910.7 5629.2 5878.1 5887.7 5971.4 6073.4 882.0 902.7 910.1 916.2 922.2 3671.0 3723.9 3790.6 3801.6 3818.8 10528.3 10818.9 10922.0 10933.4 10970.7 10858.1 10864.1 10866.7 10870.2 10926.5 8127.2 8192.6 8247.7 8253.6 8262.3 5138.0 5330.7 5376.5 5517.9 5690.5 9437.0 9645.6 9742.8 10014.0 10059.0 9212.4 10002.5 10168.4 10334.8 10341.4 6575.3 6743.3 6751.4 6957.1 6961.3 8103.2 8112.1 8187.2 8209.8 8230.8 6522.1 7436.0 7448.8 7461.6 7576.4 7131.6 7218.3 7316.3 7345.0 7368.8 5927.9 7011.9 7014.0 7016.2 7020.2 4735.0 4759.3 4833.1 4865.8 4938.2 4737.7 4820.6 4847.6 4950.6 5007.8 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - PROCESS | 1653 | [#4] prototype.html Cycles:180 Average:4491.61 Median:4964.71 stddev:1385.82 (27.9%) stddev-sans-first:1352.74 09:36:39 INFO - PROCESS | 1653 | Values: 255.6 282.9 299.3 307.0 311.5 4380.2 4679.5 5410.6 5449.4 5454.3 3917.8 4328.9 4882.9 5166.7 5229.4 3360.7 3810.9 3854.7 3942.1 4103.8 3711.5 4076.7 4103.7 4131.8 4141.6 3287.8 3518.2 3663.6 3777.7 4093.7 3369.6 3640.5 3947.1 4022.6 4046.3 3542.1 3551.4 3555.2 3563.2 3563.7 4101.6 4484.2 4953.0 5009.7 5179.9 4204.2 4398.5 4639.6 4678.8 4733.2 4331.5 4667.8 4786.8 4964.7 5668.3 3944.7 3950.6 3961.0 3961.8 3969.8 4715.0 5043.5 5830.2 5882.3 5933.4 3230.7 3574.8 3659.7 3685.5 3848.9 3168.0 3518.7 4059.7 4066.8 4074.2 3897.0 4445.4 4544.6 4685.6 4735.4 4913.1 5378.9 5539.8 5564.4 5661.9 1375.7 1384.7 1386.5 1388.1 1389.7 859.4 885.2 893.2 899.2 926.7 4725.6 4968.4 5231.0 5290.3 5303.3 5771.3 5799.9 5809.0 5813.4 5819.4 5019.6 5278.6 5355.1 5393.5 5417.3 3018.4 3062.6 3077.8 3078.4 3095.6 5533.8 5770.9 5903.5 5941.6 6029.6 4953.8 5948.5 5952.9 5992.0 5993.8 5209.6 5955.1 5962.6 5965.0 5974.0 4742.8 5066.4 5204.8 5860.6 5868.6 4964.8 5063.9 5746.7 5785.6 5795.0 5087.0 5247.7 5437.5 5856.0 5958.7 3742.5 3857.7 3881.2 3914.2 3917.9 4772.5 5158.4 5835.5 5855.9 5871.5 5389.6 5703.3 5713.6 5727.5 5731.6 4925.9 5282.2 5668.6 5687.3 5710.0 5256.3 5261.3 5350.6 5524.2 5591.3 5298.9 5494.8 5527.6 5625.6 5666.5 4641.7 4846.1 5515.3 5534.8 5535.4 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - PROCESS | 1653 | [#5] yui.html Cycles:180 Average:25078.74 Median:12587.69 stddev:40894.66 (324.9%) stddev-sans-first:40968.33 09:36:39 INFO - PROCESS | 1653 | Values: 675.9 709.0 722.9 782.9 817.5 14786.3 15552.6 15971.9 16028.8 16935.9 15743.6 16372.6 16616.4 16642.6 16642.9 817.6 828.0 856.0 856.9 862.7 682.5 705.8 709.3 832.6 852.5 904.0 906.9 907.9 908.5 912.3 902.1 903.7 903.8 904.1 906.2 522.2 543.0 644.1 664.5 668.6 15248.9 15307.4 15312.6 15313.1 15325.8 11972.6 12131.0 12156.9 12287.4 12505.1 12396.2 12762.4 12895.5 12991.8 13030.6 4486.9 4586.4 4618.1 4761.2 4775.0 122025.0 124337.4 125277.4 125687.4 127394.0 10606.8 10671.9 10825.6 10913.1 10931.6 21008.2 21037.5 21052.9 21093.6 21626.7 7676.1 7777.7 7802.1 7809.9 7888.5 4269.5 4335.4 4343.9 4380.5 4454.5 3548.7 3699.6 3704.2 3710.7 3713.9 654.7 661.0 663.0 675.0 694.6 622.3 660.7 672.9 675.5 699.7 9116.7 9455.3 9472.5 9510.3 9572.6 573.3 678.8 687.4 694.3 696.7 4066.5 4393.4 4589.4 4650.9 4651.3 147675.0 165155.0 168692.0 170584.1 172549.0 99459.5 101009.5 125001.0 128779.0 146500.0 80329.6 101938.0 102855.5 112761.0 112840.4 9552.3 9696.9 9959.3 10202.5 10273.6 44393.6 46829.0 55542.7 58669.0 59225.7 66275.7 86472.0 96842.0 98049.5 102238.0 12637.7 12748.7 13060.8 13258.2 13418.0 12630.1 14105.2 14997.6 15281.4 15880.8 13540.0 14045.9 14135.5 14422.9 14722.5 13050.9 13964.6 14212.9 14392.0 14431.5 13140.7 13463.7 13467.5 13713.2 13875.5 10910.5 11188.7 11243.1 11650.9 11825.6 11197.0 11256.2 11414.8 11724.6 11748.8 09:36:39 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:36:39 INFO - PROCESS | 1653 | 09:36:39 INFO - TEST-INFO | 1653: exit 0 09:36:39 INFO - TEST-OK | dromaeo_css | took 1117098ms 09:36:39 INFO - TEST-START | kraken 09:36:39 INFO - operating with platform_type : mac_ 09:36:39 INFO - Initialising browser for kraken test... 09:36:39 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp5tsZIJ/profile http://localhost:49267/getInfo.html) 09:36:41 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 09:36:41 INFO - PROCESS | 1662 | colorDepth:24 09:36:41 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 09:36:41 INFO - PROCESS | 1662 | __metrics 09:36:42 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:36:42 INFO - PROCESS | 1662 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:36:42 INFO - TEST-INFO | 1662: exit 0 09:36:42 INFO - Browser initialized. 09:36:42 INFO - Running cycle 1/1 for kraken test... 09:36:42 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/T/tmp5tsZIJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:36:54 INFO - PROCESS | 1663 | RSS: Main: 219877376 09:36:54 INFO - PROCESS | 1663 | 09:36:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection) 09:36:58 INFO - PROCESS | 1663 | RSS: Main: 269918208 09:36:58 INFO - PROCESS | 1663 | 09:37:01 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-dft) 09:37:01 INFO - PROCESS | 1663 | RSS: Main: 281157632 09:37:01 INFO - PROCESS | 1663 | 09:37:05 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-fft) 09:37:05 INFO - PROCESS | 1663 | RSS: Main: 377196544 09:37:05 INFO - PROCESS | 1663 | 09:37:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator) 09:37:08 INFO - PROCESS | 1663 | RSS: Main: 281157632 09:37:08 INFO - PROCESS | 1663 | 09:37:10 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:37:10 INFO - PROCESS | 1663 | RSS: Main: 281640960 09:37:10 INFO - PROCESS | 1663 | 09:37:13 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom) 09:37:14 INFO - PROCESS | 1663 | RSS: Main: 320634880 09:37:14 INFO - PROCESS | 1663 | 09:37:17 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate) 09:37:18 INFO - PROCESS | 1663 | RSS: Main: 320237568 09:37:18 INFO - PROCESS | 1663 | 09:37:21 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial) 09:37:21 INFO - PROCESS | 1663 | RSS: Main: 319365120 09:37:21 INFO - PROCESS | 1663 | 09:37:23 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:37:23 INFO - PROCESS | 1663 | RSS: Main: 290521088 09:37:23 INFO - PROCESS | 1663 | 09:37:25 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:37:26 INFO - PROCESS | 1663 | RSS: Main: 295690240 09:37:26 INFO - PROCESS | 1663 | 09:37:28 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:37:29 INFO - PROCESS | 1663 | RSS: Main: 297914368 09:37:29 INFO - PROCESS | 1663 | 09:37:32 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:37:32 INFO - PROCESS | 1663 | RSS: Main: 307286016 09:37:32 INFO - PROCESS | 1663 | 09:37:35 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:37:36 INFO - PROCESS | 1663 | RSS: Main: 307032064 09:37:36 INFO - PROCESS | 1663 | 09:37:37 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49267/tests/kraken/driver.html?testName=ai-astar) 09:37:38 INFO - PROCESS | 1663 | RSS: Main: 350748672 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | __start_tp_report 09:37:38 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 09:37:38 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 09:37:38 INFO - PROCESS | 1663 | |i|pagename|runs| 09:37:38 INFO - PROCESS | 1663 | |0;ai-astar;115;113;114;114;113;114;114;113;111;114 09:37:38 INFO - PROCESS | 1663 | |1;audio-beat-detection;142;111;109;164;114;110;107;107;145;134 09:37:38 INFO - PROCESS | 1663 | |2;audio-dft;184;180;186;180;183;182;203;263;201;183 09:37:38 INFO - PROCESS | 1663 | |3;audio-fft;79;59;59;89;59;59;58;69;83;58 09:37:38 INFO - PROCESS | 1663 | |4;audio-oscillator;87;70;94;69;67;69;92;67;68;89 09:37:38 INFO - PROCESS | 1663 | |5;imaging-gaussian-blur;88;85;88;88;130;116;88;84;87;86 09:37:38 INFO - PROCESS | 1663 | |6;imaging-darkroom;98;99;154;128;97;97;96;126;164;97 09:37:38 INFO - PROCESS | 1663 | |7;imaging-desaturate;97;141;116;86;101;123;85;97;138;119 09:37:38 INFO - PROCESS | 1663 | |8;json-parse-financial;58;52;55;56;57;59;59;59;58;58 09:37:38 INFO - PROCESS | 1663 | |9;json-stringify-tinderbox;65;72;69;76;73;69;71;70;76;71 09:37:38 INFO - PROCESS | 1663 | |10;stanford-crypto-aes;84;83;86;82;81;81;90;100;96;77 09:37:38 INFO - PROCESS | 1663 | |11;stanford-crypto-ccm;138;137;134;138;140;141;141;135;182;126 09:37:38 INFO - PROCESS | 1663 | |12;stanford-crypto-pbkdf2;161;160;163;168;164;159;161;163;164;161 09:37:38 INFO - PROCESS | 1663 | |13;stanford-crypto-sha256-iterative;67;66;68;67;67;67;65;66;67;66 09:37:38 INFO - PROCESS | 1663 | __end_tp_report 09:37:38 INFO - PROCESS | 1663 | __start_cc_report 09:37:38 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2024 09:37:38 INFO - PROCESS | 1663 | __end_cc_report 09:37:38 INFO - PROCESS | 1663 | __startTimestamp1476981458165__endTimestamp 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | ------- Summary: start ------- 09:37:38 INFO - PROCESS | 1663 | Number of tests: 14 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#0] ai-astar Cycles:10 Average:113.50 Median:114.00 stddev:1.08 (0.9%) stddev-sans-first:1.00 09:37:38 INFO - PROCESS | 1663 | Values: 115.0 113.0 114.0 114.0 113.0 114.0 114.0 113.0 111.0 114.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:124.00 stddev:20.36 (16.4%) stddev-sans-first:20.57 09:37:38 INFO - PROCESS | 1663 | Values: 142.0 111.0 109.0 164.0 114.0 110.0 107.0 107.0 145.0 134.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#2] audio-dft Cycles:10 Average:194.50 Median:185.00 stddev:25.45 (13.8%) stddev-sans-first:26.71 09:37:38 INFO - PROCESS | 1663 | Values: 184.0 180.0 186.0 180.0 183.0 182.0 203.0 263.0 201.0 183.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#3] audio-fft Cycles:10 Average:67.20 Median:64.00 stddev:12.04 (18.8%) stddev-sans-first:11.99 09:37:38 INFO - PROCESS | 1663 | Values: 79.0 59.0 59.0 89.0 59.0 59.0 58.0 69.0 83.0 58.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#4] audio-oscillator Cycles:10 Average:77.20 Median:78.50 stddev:11.62 (14.8%) stddev-sans-first:11.77 09:37:38 INFO - PROCESS | 1663 | Values: 87.0 70.0 94.0 69.0 67.0 69.0 92.0 67.0 68.0 89.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#5] imaging-gaussian-blur Cycles:10 Average:94.00 Median:87.50 stddev:15.70 (17.9%) stddev-sans-first:16.50 09:37:38 INFO - PROCESS | 1663 | Values: 88.0 85.0 88.0 88.0 130.0 116.0 88.0 84.0 87.0 86.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#6] imaging-darkroom Cycles:10 Average:115.60 Median:97.00 stddev:26.01 (26.8%) stddev-sans-first:26.79 09:37:38 INFO - PROCESS | 1663 | Values: 98.0 99.0 154.0 128.0 97.0 97.0 96.0 126.0 164.0 97.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#7] imaging-desaturate Cycles:10 Average:110.30 Median:113.00 stddev:20.14 (17.8%) stddev-sans-first:20.78 09:37:38 INFO - PROCESS | 1663 | Values: 97.0 141.0 116.0 86.0 101.0 123.0 85.0 97.0 138.0 119.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#8] json-parse-financial Cycles:10 Average:57.10 Median:58.00 stddev:2.23 (3.9%) stddev-sans-first:2.35 09:37:38 INFO - PROCESS | 1663 | Values: 58.0 52.0 55.0 56.0 57.0 59.0 59.0 59.0 58.0 58.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:3.33 (4.7%) stddev-sans-first:2.67 09:37:38 INFO - PROCESS | 1663 | Values: 65.0 72.0 69.0 76.0 73.0 69.0 71.0 70.0 76.0 71.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.50 stddev:7.24 (8.7%) stddev-sans-first:7.64 09:37:38 INFO - PROCESS | 1663 | Values: 84.0 83.0 86.0 82.0 81.0 81.0 90.0 100.0 96.0 77.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:139.00 stddev:15.00 (10.8%) stddev-sans-first:15.87 09:37:38 INFO - PROCESS | 1663 | Values: 138.0 137.0 134.0 138.0 140.0 141.0 141.0 135.0 182.0 126.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.40 Median:163.00 stddev:2.59 (1.6%) stddev-sans-first:2.70 09:37:38 INFO - PROCESS | 1663 | Values: 161.0 160.0 163.0 168.0 164.0 159.0 161.0 163.0 164.0 161.0 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - PROCESS | 1663 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.88 09:37:38 INFO - PROCESS | 1663 | Values: 67.0 66.0 68.0 67.0 67.0 67.0 65.0 66.0 67.0 66.0 09:37:38 INFO - PROCESS | 1663 | -------- Summary: end -------- 09:37:38 INFO - PROCESS | 1663 | 09:37:38 INFO - TEST-INFO | 1663: exit 0 09:37:39 INFO - TEST-OK | kraken | took 59410ms 09:37:39 INFO - SUITE-END | took 1176s 09:37:39 INFO - Completed test suite (00:19:36) 09:37:39 INFO - javascript benchmark 09:37:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2779.916602501923, 3343.7659363844527, 3350.5644266245386, 3387.1362802485364, 3420.7947523148614, 5707.14392841074, 5805.506531944785, 5875.794347197849, 5918.1418694289305, 5918.171455996158, 5829.941700583004, 5889.558283128761, 5915.290165180174, 5917.822465326037, 5931.495822855051, 5270.367555893288, 5318.0, 5331.840044798643, 5357.035733567956, 5370.113931201347, 5275.446078161795, 5279.023380674587, 5283.656562323456, 5379.757910894, 5417.810376636819, 5320.547753440962, 5339.22581225722, 5345.599080068991, 5346.946530534703, 5359.437259087798, 5329.680219186861, 5353.2237825515085, 5391.865203369908, 5392.0, 5393.83818485446, 5194.71429071401, 5289.709066001368, 5328.573714102862, 5368.70472124033, 5384.461553844623, 5757.712114394263, 5784.537237021028, 5827.417258274181, 5842.152887831241, 5878.088896221093, 6273.56085074045, 6291.197994139668, 6292.811215663537, 6303.023031430135, 6316.6841657917375, 6236.064590311445, 6279.152314437538, 6281.528885333572, 6294.213223347082, 6298.968505157491, 5817.592768506206, 5864.325602555676, 5893.174955506232, 5926.318473375531, 5936.7922122725495, 6357.777477788255, 6360.713767880364, 6366.140571022946, 6368.42684158428, 6369.554131210771, 5247.18668606359, 6302.054691796267, 6308.905366419507, 6312.621242725451, 6323.146375239376, 6218.0, 6224.128621992924, 6233.812985610439, 6253.155823963707, 6272.435480806749, 6327.430531252209, 6355.491560675135, 6356.078368636614, 6363.077353783676, 6366.840828979312, 6266.686665666698, 6307.180066591313, 6313.43179113882, 6330.240371155491, 6355.713992870332, 4872.952315252167, 4972.279019542146, 4990.950090499048, 5048.268001139814, 5053.216751403538, 4538.410006699174, 4562.0, 4563.657725670521, 4574.748388838646, 4587.541245875453, 5860.208871802252, 5877.089051197071, 5903.085021821625, 5906.940930590725, 5911.852203694942, 6187.81436556904, 6234.719437625317, 6246.0, 6252.74989000444, 6256.593321434092, 5937.0203916354185, 5949.750552383961, 5955.285365756137, 5960.731767070492, 5966.761329546856, 4503.797329120198, 5493.972530137324, 5496.945030549723, 5502.312210973629, 5517.062099443105, 5800.274965629296, 6215.96892015537, 6226.5641405101205, 6240.469560087353, 6251.374862513712, 6251.624902505864, 6256.781012664717, 6263.65549894742, 6265.624062556261, 6276.560640755103, 6320.747170113144, 6327.240731112296, 6338.397852204033, 6344.873102538016, 6348.809535713936, 6137.8366772191985, 6215.223097112861, 6270.623762574261, 6280.591761535486, 6283.403076707706, 6203.100550420074, 6232.470240029648, 6258.499320054294, 6321.209848768904, 6324.051392291193, 6117.388261173847, 6216.191895053795, 6220.409061139185, 6226.221722284715, 6234.563580549499, 5210.426853046086, 6121.32665406796, 6182.165407669907, 6248.125262463168, 6250.1874756281395, 6031.215941927521, 6060.424259695322, 6074.236242412216, 6105.725242364193, 6126.142340072304, 6198.2252218472695, 6198.690065496798, 6201.627902325875, 6207.720652570735, 6229.345918678655, 6069.696515174312, 6099.359567245553, 6123.0, 6136.723847426966, 6136.846578835565], "value": 5778.886538660654, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.46025530894764, 482.41145802121423, 489.65968651787, 514.6320380927637, 529.3912001198621, 30581.541276880864, 31598.420078996045, 32810.67189328106, 40573.18853622926, 41631.375529367084, 40637.59362406375, 42531.0, 42989.570104298946, 43004.354934675925, 43056.0, 9595.760105997337, 9750.36622619531, 9761.219102471785, 9769.511524423786, 9787.706368808947, 8645.092265312145, 8837.204651581356, 8843.380963332569, 9714.0, 9805.0, 8831.116888311182, 8893.066228046058, 11753.588624398148, 11964.0, 12021.15851890368, 11934.880651193464, 12007.0, 12014.939925300405, 12020.819687704692, 12100.515979360815, 11849.94075029628, 11960.40197990097, 11962.700932476671, 11963.282203067844, 12031.398430078549, 31631.0, 32359.838200808845, 39816.0, 40012.799936000134, 40064.59935400667, 3202.96797032029, 3205.166656669283, 3506.7194624429985, 3938.5273767148124, 3946.3291240489184, 29032.41935161306, 29149.41701165986, 31021.84489077563, 31157.065288041395, 31920.840395798106, 3223.403670320998, 3229.9838500807346, 3236.4336241157703, 3257.804531728104, 3358.5465962095295, 381158.0, 381842.0, 382012.0, 383145.0, 387413.0, 48908.75545622249, 50726.74636626867, 51374.48625513697, 57863.710681446326, 58459.123113153335, 61442.0, 61860.69069654713, 61909.0, 61945.38054619396, 62090.0686489703, 14299.356528956221, 16328.75506867398, 16346.75479867803, 16354.591135221477, 16511.422100226435, 12756.553520626734, 12848.871511284955, 12857.4214160363, 12964.481420743065, 13019.804702929463, 13871.722565548633, 15614.84385156134, 15658.295376708076, 15673.68652626941, 15708.68582628341, 5580.325902229315, 6592.571482853599, 6625.436837868739, 6664.500162487833, 6720.932790672031, 826.9710560130487, 945.3760518058049, 948.1987720376271, 972.6595691507915, 1003.934744241622, 29357.26606834846, 30068.248293792392, 30133.0, 30431.847840760656, 30803.075907722803, 897.2014906733012, 985.8077674853334, 986.0435377683779, 999.3354419311077, 1081.324172392255, 14036.877049835988, 14929.925350373396, 15180.696386072217, 15430.0, 15623.062616243062, 631665.0, 651217.0, 651258.0, 651528.0, 652122.0, 53031.469685303426, 53808.0, 53985.1902221467, 57603.84792304131, 57915.0, 1300.8699130086916, 1305.3473263368317, 1336.3785839584639, 1346.0443085409274, 1348.649351168723, 29857.70142298549, 30151.246218844706, 32195.839020805684, 32239.0, 32795.508067378534, 55896.72051639716, 56372.87254254974, 56374.0, 56512.0, 56597.0, 387931.0, 400522.0, 401030.0, 598607.0, 607227.0, 25157.24528264155, 25491.107811226517, 25516.48967020686, 25585.87207063953, 25644.102456413937, 45166.32250516311, 45489.77255113703, 45605.54394456013, 45612.0, 45680.0, 32986.010419687445, 37108.257834843695, 37456.81271593733, 37664.0, 37980.62019379771, 36071.27857442784, 36908.70505166686, 37114.814425927696, 37143.25713485769, 37787.677431289776, 36769.816150919076, 37378.8131059343, 37586.436203456426, 37601.0, 37627.87116386513, 28052.0, 31770.04689859308, 33259.0, 33964.83017584896, 34098.31803363968, 25111.402880560545, 25166.874165629055, 25217.243482695547, 25346.873265633552, 25662.8716856422], "value": 19509.395177453447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.3555422468432, 353.1013570463171, 370.885025642051, 373.689837434929, 400.07183334663574, 15246.313915873785, 15312.617184570392, 16418.91790541047, 21189.470263243427, 21888.90555472228, 19308.4207473776, 20064.699029514533, 20522.48693782656, 20761.0, 20766.377008689728, 5752.309722833245, 5757.366689664133, 6003.759849606011, 6004.249468816398, 6022.066579680157, 5340.54605358545, 5878.970605146968, 6001.699915004254, 6047.818565443022, 6066.393360663942, 4125.0, 4362.912741745163, 6338.556301058928, 6601.768938087168, 6654.733810647568, 5748.741306641211, 6053.334133245339, 6693.263740988487, 6707.295733947938, 6734.225564060147, 5950.047992321208, 5955.255593050869, 5966.373530779249, 5972.940270597325, 5978.312494063195, 24977.50044999108, 25720.614190787153, 26328.47343053128, 26420.86789566059, 26536.0, 2104.947376315589, 2219.6004719150546, 2244.494988627562, 2365.698850790793, 2446.559619268531, 9604.66383676568, 10000.249981251436, 10041.54813033408, 10155.238357123246, 10372.11836993849, 1664.8085470170843, 1802.8197180281998, 1853.9536511587182, 1870.1490821676105, 1949.9025048747505, 124392.0, 126273.0, 126532.36733816365, 128801.35599321943, 131419.34290328488, 9282.860757088649, 9460.337776355589, 9977.650782222587, 10134.290599658101, 11504.15933450644, 11437.656870293904, 12518.561850335194, 12519.43662535188, 12521.436535355931, 12521.937390313173, 7851.60741962911, 7890.698034824304, 7954.045514538292, 7970.601469926596, 8050.59747012647, 6961.129858767654, 8244.29923456513, 8385.287250583646, 8395.62219700115, 8430.536320502431, 3810.65704086628, 3855.614438556122, 3857.8263978121054, 3874.2832575973534, 3931.351327031065, 1663.7254852949127, 1736.827641342089, 1884.7738271407245, 1907.4754442528138, 1954.2573821947854, 824.8061705499202, 833.5415521463171, 886.499127992695, 985.2659768472533, 992.33827177714, 21795.128194872344, 22267.665985010237, 22306.442338941655, 22308.55382892333, 22394.216202432835, 922.7508572685338, 933.7347893604069, 943.1228957069991, 954.4464210757744, 1003.5584342889251, 10903.890961090447, 11692.00617947484, 11703.005244554139, 11715.00422464083, 11718.355490447937, 596949.0, 613943.0, 622626.0, 623830.0, 642768.5723142802, 96322.03677963131, 107386.46306768416, 139897.0, 143265.28367358306, 147211.0, 960.4093482508207, 972.2222222222194, 998.960041598328, 999.1157825324494, 1000.0599436529639, 19304.324348648293, 19798.80201198027, 19896.90051549733, 19904.90047549811, 19912.904790236676, 54996.25243591698, 55076.17385739137, 55906.720466397404, 55921.16401589383, 57061.0, 81835.77246341191, 84165.0, 84515.5774221125, 84746.88132796483, 85336.57331713302, 6678.298778628174, 6925.792226233221, 6998.160220773336, 8237.0, 8328.750137495885, 7864.410169237216, 12430.751384972431, 13378.665533361744, 13398.052428465722, 13474.461021559027, 11512.82730759056, 11558.768824623292, 11595.8260626089, 11875.821862671894, 11917.0, 9560.235181185628, 10988.890111098786, 11034.282771619819, 11366.204365694322, 11503.367314797766, 11582.36297003673, 11586.188966772244, 11821.527138914347, 12017.0, 12063.81904271419, 8107.918920810716, 8129.227723366271, 8296.294814940798, 8512.70205542803, 8549.700760473354, 10812.35125892449, 11386.829197562209, 11726.472308745957, 12114.454849531969, 12184.817227741414], "value": 9509.150507700684, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.3633119771312, 1303.504668226074, 1525.4279645133074, 1607.573992891883, 1822.639681612312, 7721.845563088735, 8257.339412846974, 8574.742757717278, 8815.911840881588, 8835.646574137027, 8692.087330830267, 8792.47245165289, 8808.515531645757, 8810.427322224066, 8811.162939520751, 2375.6199008158696, 2409.5421869844763, 2412.3124909400826, 2412.7828495435406, 2413.51729654069, 2352.2590384029063, 2391.9594976185326, 2399.4241382068267, 2402.255300856731, 2403.2429784617875, 2359.49270906755, 2360.8819559022068, 2370.3244575296044, 2393.162393162388, 2403.4952659941346, 2347.5774360615083, 2367.4554852383962, 2374.5607062693457, 2377.227401094651, 2378.1200955646436, 2320.234322673514, 2357.2456813819585, 2366.1363602285214, 2366.4438856868624, 2368.4315764216635, 8684.47893126408, 8761.474311541264, 8793.472391656522, 8809.207171354545, 8829.735107946772, 5185.637005409623, 5372.0, 5375.0862353399625, 5417.4311697272005, 5423.647462914937, 3459.221675123102, 3621.529201203853, 3665.120371110941, 3679.0, 3680.723945704056, 1076.4725284610563, 1098.357460885383, 1103.2497901427028, 1127.4926283172606, 1128.5880653561474, 11532.769344613062, 11536.711582210428, 11612.419379031015, 11613.593524226697, 11622.244554103956, 4427.203103441411, 4500.369948207253, 4664.113818374498, 4690.530946905282, 4695.131400690815, 9090.590923408463, 9101.635934562544, 9105.271578273721, 9113.908860911439, 9123.224525915239, 5214.348206474191, 5240.764165612557, 5242.0, 5244.921326180111, 5251.2123181523075, 4157.189348077096, 4394.12117576486, 4543.522930092358, 4544.409226800495, 4904.509549045139, 3776.4335349697217, 3814.256220037066, 3851.364524853424, 3894.4937158169823, 3903.980480097581, 1169.9415029248503, 1180.0972256223995, 1185.9881401185878, 1195.5875223048035, 1200.4417945655312, 866.5234121233296, 878.3544095090103, 878.543157558079, 898.1108702384593, 910.7040211931148, 5629.183768353566, 5878.088896221093, 5887.735051922674, 5971.4327138921735, 6073.420910563197, 881.9691310804219, 902.7382059202757, 910.0853642089658, 916.2074805293373, 922.1792604581927, 3670.953778173261, 3723.8510459581853, 3790.5830358660523, 3801.581825999138, 3818.8281527331337, 10528.315659482108, 10818.94590527058, 10922.017018468376, 10933.398663073607, 10970.670879873616, 10858.131349492021, 10864.130869530418, 10866.72833179161, 10870.152074147414, 10926.508307126198, 8127.2279133482225, 8192.631331590093, 8247.670093196324, 8253.628586713612, 8262.297704695047, 5137.974310128426, 5330.653507521999, 5376.542993845567, 5517.889642207214, 5690.4878560928055, 9436.95281523588, 9645.565949532147, 9742.805143897223, 10014.0, 10059.044390782863, 9212.355135140744, 10002.549885255035, 10168.389896606228, 10334.844977325196, 10341.4312212829, 6575.309592492719, 6743.291954344723, 6751.358620931003, 6957.130358705162, 6961.269066747918, 8103.230193131643, 8112.089274643521, 8187.181281871765, 8209.753707388787, 8230.794230144054, 6522.119513865568, 7435.962820185864, 7448.776536703907, 7461.552306861606, 7576.431767617561, 7131.643417829192, 7218.314260145278, 7316.304951029643, 7344.96327518359, 7368.820988641792, 5927.911081333869, 7011.929880701127, 7013.964930175521, 7016.228214896255, 7020.192677842114, 4734.952650473451, 4759.262314341283, 4833.130036593447, 4865.781039853145, 4938.209886418156, 4737.692050016738, 4820.638452116035, 4847.563719265283, 4950.603951683928, 5007.84976450707], "value": 4512.662999088898, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.61657513729395, 282.9165396208118, 299.27276717576285, 306.9662337142914, 311.48293832238477, 4380.160332660283, 4679.478215705466, 5410.594205434593, 5449.427810079944, 5454.290942177521, 3917.784521851297, 4328.913421731563, 4882.853514394574, 5166.715830629314, 5229.424763276036, 3360.747943904205, 3810.8567429770956, 3854.747207157671, 3942.1130245694776, 4103.815328310233, 3711.536057992751, 4076.714629975903, 4103.712740108193, 4131.7934103294865, 4141.6065473779945, 3287.8356082195796, 3518.243577630809, 3663.6444515529292, 3777.7355585109053, 4093.6520395766397, 3369.6124945631077, 3640.4698734379485, 3947.065937690511, 4022.597740225983, 4046.3092043790843, 3542.096765324826, 3551.396262635358, 3555.2178520725397, 3563.233904710474, 3563.6614521620404, 4101.569335219789, 4484.1928452878465, 4952.963955330449, 5009.699418034929, 5179.922301165486, 4204.201201771653, 4398.516163222075, 4639.628829693616, 4678.812847486097, 4733.195356789354, 4331.501877284121, 4667.836625718118, 4786.808527658889, 4964.652474326798, 5668.348139963916, 3944.684425245973, 3950.5851885551892, 3960.980195099035, 3961.841526338943, 3969.7816620085882, 4714.95285047152, 5043.470435604282, 5830.2420685310635, 5882.264761876197, 5933.436323549256, 3230.6607806180014, 3574.767640103385, 3659.682514294852, 3685.4840322354894, 3848.9223017555128, 3168.002079344999, 3518.683318501296, 4059.6752259819145, 4066.8169932353117, 4074.2258970795456, 3897.0, 4445.409074317038, 4544.613707834871, 4685.617742765892, 4735.384400028043, 4913.066517361762, 5378.865528361822, 5539.833804985857, 5564.415736347706, 5661.943380566224, 1375.6767159717458, 1384.7438223928605, 1386.4956522173354, 1388.1046724862408, 1389.6664800448023, 859.4070091636751, 885.2254277507182, 893.2452077994085, 899.1547944931874, 926.6571368593663, 4725.621950243973, 4968.354113965162, 5230.992179496805, 5290.28581141541, 5303.257543943851, 5771.278590176228, 5799.9130013049835, 5808.970955145197, 5813.3895940925595, 5819.418058194146, 5019.598432125421, 5278.577713782888, 5355.116405793001, 5393.545936598838, 5417.349918009864, 3018.351054523288, 3062.617172853393, 3077.815331080142, 3078.3843231353817, 3095.5820964169548, 5533.778648854081, 5770.855728606818, 5903.527717782567, 5941.58408911372, 6029.577929544977, 4953.826616068421, 5948.524118070544, 5952.880942381128, 5992.041273396323, 5993.760249590055, 5209.6092793041435, 5955.076963070731, 5962.612430192024, 5964.970175149183, 5973.970130149321, 4742.834000809955, 5066.392032956069, 5204.8178313758835, 5860.560457965585, 5868.623207600928, 4964.7765850537535, 5063.873403164803, 5746.655200687972, 5785.566082543742, 5795.0, 5087.0, 5247.685138891678, 5437.504686211323, 5856.0, 5958.672273025025, 3742.5321834770652, 3857.672097871712, 3881.223755248905, 3914.238592633383, 3917.9020524485977, 4772.5227477252, 5158.406783219978, 5835.503982161564, 5855.8536036597725, 5871.4715675589405, 5389.62272640927, 5703.258576385043, 5713.600047996601, 5727.541796656341, 5731.570132240182, 4925.876853078702, 5282.207668849704, 5668.574856885668, 5687.3459552152035, 5710.0, 5256.265432407373, 5261.342332208474, 5350.598705097211, 5524.2322456815045, 5591.30108736408, 5298.947010529845, 5494.752736126964, 5527.613067085265, 5625.606207565595, 5666.490015898589, 4641.721496710208, 4846.127697014571, 5515.338159420895, 5534.806281780118, 5535.446455354432], "value": 4053.452527185881, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.912131422915, 709.0194211823272, 722.8807246804278, 782.8882986159653, 817.480899628736, 14786.334614942327, 15552.611184720374, 15971.92014039931, 16028.75956860648, 16935.91532042341, 15743.606409839731, 16372.590685232875, 16616.418425355114, 16642.58393540162, 16642.916785416088, 817.6075483767795, 827.954462504562, 855.9700410485634, 856.9271611912994, 862.7153039496951, 682.4506272450675, 705.8376573388124, 709.2517394149171, 832.5504227717025, 852.4544291653316, 904.023654453189, 906.9274458043341, 907.8547432410816, 908.5275656658533, 912.333996182787, 902.0798785239052, 903.6791938861675, 903.7966457547066, 904.0959040959041, 906.2025417632507, 522.1593234891822, 542.956563474921, 644.1239913717387, 664.4850241063166, 668.5721138471382, 15248.923755381264, 15307.387704491806, 15312.617184570363, 15313.081215127017, 15325.770113448307, 11972.58095966637, 12131.0, 12156.884153271289, 12287.447064882102, 12505.124641275115, 12396.194247373982, 12762.361881905868, 12895.484180632764, 12991.805122923164, 13030.609081727564, 4486.887827804331, 4586.3579098926175, 4618.122556714214, 4761.166795810719, 4775.021120670289, 122025.0, 124337.37831310875, 125277.37361313227, 125687.37156314251, 127394.0, 10606.787864242671, 10671.94664026675, 10825.621103261348, 10913.072388846878, 10931.617393391192, 21008.15967361319, 21037.474063148544, 21052.89473552653, 21093.62891412084, 21626.675599866016, 7676.117246516722, 7777.688892444352, 7802.141764405911, 7809.882851757228, 7888.5266883986, 4269.475191693789, 4335.3713711511655, 4343.9348409773875, 4380.540043295472, 4454.465464144323, 3548.698360639323, 3699.648533389324, 3704.1850792825535, 3710.703143748494, 3713.9442908356395, 654.731560060373, 660.9636469994197, 663.0352836622702, 674.993250067493, 694.5589550635282, 622.3434276837979, 660.7324033766237, 672.9158855143107, 675.4630069095081, 699.7201119552118, 9116.680916168036, 9455.338126331091, 9472.479013654316, 9510.302328136431, 9572.56923438447, 573.3263415486787, 678.7646483400263, 687.4328678839977, 694.2502097734434, 696.689972962027, 4066.4916885389325, 4393.406890069799, 4589.35748995141, 4650.883727906829, 4651.2557990722, 147675.0, 165155.0, 168692.0, 170584.1470792638, 172549.0, 99459.50270248602, 101009.49495252623, 125001.0, 128779.0, 146500.0, 80329.59835200786, 101938.0, 102855.48572257091, 112761.0, 112840.43579782048, 9552.283578731483, 9696.85454718194, 9959.302848800515, 10202.489875506344, 10273.589056437659, 44393.55606443894, 46829.0, 55542.72228638831, 58669.013133884095, 59225.70387148209, 66275.66862165659, 86472.0, 96842.0, 98049.50975245364, 102238.0, 12637.74724505523, 12748.74502509926, 13060.804087938499, 13258.204507729568, 13418.0, 12630.134534498673, 14105.224212668401, 14997.625059373602, 15281.35932033983, 15880.761788573413, 13540.0, 14045.859541404863, 14135.505257315945, 14422.927885360506, 14722.484713034992, 13050.869491304966, 13964.581062568139, 14212.857871421153, 14392.0, 14431.45431528756, 13140.73718525605, 13463.653634636457, 13467.461301547828, 13713.245771482665, 13875.514356997457, 10910.509027093642, 11188.66434006981, 11243.132108049766, 11650.88349116498, 11825.586104486301, 11196.992270695677, 11256.155788316073, 11414.828777568177, 11724.58963936258, 11748.823767643664], "value": 7888.987121642151, "unit": "score"}], "name": "dromaeo_css", "value": 7326.993390849423, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 114.0, 114.0, 113.0, 114.0, 114.0, 113.0, 111.0, 114.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 111.0, 109.0, 164.0, 114.0, 110.0, 107.0, 107.0, 145.0, 134.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 180.0, 186.0, 180.0, 183.0, 182.0, 203.0, 263.0, 201.0, 183.0], "value": 194.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 59.0, 59.0, 89.0, 59.0, 59.0, 58.0, 69.0, 83.0, 58.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 94.0, 69.0, 67.0, 69.0, 92.0, 67.0, 68.0, 89.0], "value": 77.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 88.0, 130.0, 116.0, 88.0, 84.0, 87.0, 86.0], "value": 94.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 99.0, 154.0, 128.0, 97.0, 97.0, 96.0, 126.0, 164.0, 97.0], "value": 115.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 141.0, 116.0, 86.0, 101.0, 123.0, 85.0, 97.0, 138.0, 119.0], "value": 110.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 55.0, 56.0, 57.0, 59.0, 59.0, 59.0, 58.0, 58.0], "value": 57.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 69.0, 76.0, 73.0, 69.0, 71.0, 70.0, 76.0, 71.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 86.0, 82.0, 81.0, 81.0, 90.0, 100.0, 96.0, 77.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 137.0, 134.0, 138.0, 140.0, 141.0, 141.0, 135.0, 182.0, 126.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 163.0, 168.0, 164.0, 159.0, 161.0, 163.0, 164.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 67.0, 67.0, 67.0, 65.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1481.1000000000001, "alertThreshold": 2.0}]} 09:37:39 INFO - Return code: 0 09:37:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:37:39 INFO - # TBPL SUCCESS # 09:37:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:37:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:37:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:37:39 INFO - 2016-10-20 09:37:39.497 screenresolution[1667:10425] starting screenresolution argv=screenresolution get 09:37:39 INFO - 2016-10-20 09:37:39.500 screenresolution[1667:10425] Display 0: 1600x1200x32@60 09:37:39 INFO - 2016-10-20 09:37:39.505 screenresolution[1668:10428] starting screenresolution argv=screenresolution list 09:37:39 INFO - Available Modes on Display 0 09:37:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:37:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:37:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:37:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:37:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:37:39 INFO - Intel Iris: 09:37:39 INFO - Chipset Model: Intel Iris 09:37:39 INFO - Type: GPU 09:37:39 INFO - Bus: Built-In 09:37:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:37:39 INFO - Vendor: Intel (0x8086) 09:37:39 INFO - Device ID: 0x0a2e 09:37:39 INFO - Revision ID: 0x0009 09:37:39 INFO - Displays: 09:37:39 INFO - Display: 09:37:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:37:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:37:39 INFO - Display Serial Number: 1600x1200 60 09:37:39 INFO - Main Display: Yes 09:37:39 INFO - Mirror: Off 09:37:39 INFO - Online: Yes 09:37:39 INFO - Rotation: Supported 09:37:39 INFO - Return code: 0 09:37:39 INFO - Running post-action listener: _resource_record_post_action 09:37:39 INFO - [mozharness: 2016-10-20 16:37:39.738376Z] Finished run-tests step (success) 09:37:39 INFO - Running post-run listener: _resource_record_post_run 09:37:39 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 38495232; Write bytes: 662460928; Read time: 373; Write time: 1796 09:37:39 INFO - TinderboxPrint: CPU usage
53.5% 09:37:39 INFO - TinderboxPrint: I/O read bytes / time
38,495,232 / 373 09:37:39 INFO - TinderboxPrint: I/O write bytes / time
662,460,928 / 1,796 09:37:39 INFO - TinderboxPrint: CPU idle
2,249.4 (46.5%) 09:37:39 INFO - TinderboxPrint: CPU system
966.8 (20.0%) 09:37:39 INFO - TinderboxPrint: CPU user
1,621.5 (33.5%) 09:37:39 INFO - TinderboxPrint: Swap in / out
401,776,640 / 0 09:37:39 INFO - install - Wall time: 33s; CPU: 55.0%; Read bytes: 356532736; Write bytes: 355772416; Read time: 27339; Write time: 655 09:37:39 INFO - run-tests - Wall time: 1178s; CPU: 53.0%; Read bytes: 36729856; Write bytes: 295666176; Read time: 356; Write time: 1109 09:37:40 INFO - Running post-run listener: _upload_blobber_files 09:37:40 INFO - Blob upload gear active. 09:37:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:37:40 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 09:37:40 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'] 09:37:40 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 09:37:40 INFO - (blobuploader) - INFO - Open directory for files ... 09:37:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:37:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:37:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:41 INFO - (blobuploader) - INFO - Done attempting. 09:37:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:37:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:37:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:42 INFO - (blobuploader) - INFO - Done attempting. 09:37:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:37:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:37:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:37:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:37:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:37:45 INFO - (blobuploader) - INFO - Done attempting. 09:37:45 INFO - (blobuploader) - INFO - Iteration through files over. 09:37:45 INFO - Return code: 0 09:37:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:37:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:37:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/822e565d5bb2b5013db2ad0fc324407a340553edc09175eea81a012f364536f719a301fcc78db9e72536933a3675521c9374c031f114aefd5e4cbc728aeea191", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f7352cb7bbd9e765ec40ef51fd77e204f0ffc57e8e8b2bcc32ae390a89b634b05d08bc17d962ca391ff38b3e400bda1e008781a01fdbfdcb90da9b25f8919f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c98f85e5eb6fbfdbc1b1653be3fc2603497b1ebb11a8e3d7e51c4a790f2ddfd83c6668b55dc7cedca6d81d37803ddf59eaf2b938ae5fde08bc4c1fc04f433034"} 09:37:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:37:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:37:45 INFO - Contents: 09:37:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/822e565d5bb2b5013db2ad0fc324407a340553edc09175eea81a012f364536f719a301fcc78db9e72536933a3675521c9374c031f114aefd5e4cbc728aeea191", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f7352cb7bbd9e765ec40ef51fd77e204f0ffc57e8e8b2bcc32ae390a89b634b05d08bc17d962ca391ff38b3e400bda1e008781a01fdbfdcb90da9b25f8919f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c98f85e5eb6fbfdbc1b1653be3fc2603497b1ebb11a8e3d7e51c4a790f2ddfd83c6668b55dc7cedca6d81d37803ddf59eaf2b938ae5fde08bc4c1fc04f433034"} 09:37:45 INFO - Running post-run listener: copy_logs_to_upload_dir 09:37:45 INFO - Copying logs to upload dir... 09:37:45 INFO - mkdir: /builds/slave/test/build/upload/logs 09:37:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.831462 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-10-20 09:37:45.356871) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:37:45.361953) ========= 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.bzhX4r4C9G/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.45mL35xEDx/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/822e565d5bb2b5013db2ad0fc324407a340553edc09175eea81a012f364536f719a301fcc78db9e72536933a3675521c9374c031f114aefd5e4cbc728aeea191", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f7352cb7bbd9e765ec40ef51fd77e204f0ffc57e8e8b2bcc32ae390a89b634b05d08bc17d962ca391ff38b3e400bda1e008781a01fdbfdcb90da9b25f8919f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c98f85e5eb6fbfdbc1b1653be3fc2603497b1ebb11a8e3d7e51c4a790f2ddfd83c6668b55dc7cedca6d81d37803ddf59eaf2b938ae5fde08bc4c1fc04f433034"} build_url:https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009867 build_url: 'https://queue.taskcluster.net/v1/task/cm3d9OfHQX2sDbxxl7_CiA/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/822e565d5bb2b5013db2ad0fc324407a340553edc09175eea81a012f364536f719a301fcc78db9e72536933a3675521c9374c031f114aefd5e4cbc728aeea191", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7f7352cb7bbd9e765ec40ef51fd77e204f0ffc57e8e8b2bcc32ae390a89b634b05d08bc17d962ca391ff38b3e400bda1e008781a01fdbfdcb90da9b25f8919f6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c98f85e5eb6fbfdbc1b1653be3fc2603497b1ebb11a8e3d7e51c4a790f2ddfd83c6668b55dc7cedca6d81d37803ddf59eaf2b938ae5fde08bc4c1fc04f433034"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-20 09:37:45.394549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:37:45.394931) ========= 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.bzhX4r4C9G/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.45mL35xEDx/Listeners TMPDIR=/var/folders/_1/1pr27cr94bq03lwn54yxn2z800000w/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.004868 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-20 09:37:45.443289) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:37:45.446756) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-20 09:37:45.447190) ========= ========= Total master_lag: 0.19 =========