builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0351 starttime: 1480530779.79 results: success (0) buildid: 20161130084443 builduid: 3de78507841e48c0bddab9ef8bd21852 revision: aef032ba201c027510f804901477113748db6681 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 10:32:59.791781) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 10:32:59.792186) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 10:32:59.792465) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 10:32:59.817390) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:32:59.818016) ========= 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.GsBzBShx1r/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.tcvZNZAyAI/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-30 10:32:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 66.0M=0s 2016-11-30 10:33:00 (66.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.353486 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:33:00.198862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:33:00.199295) ========= 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.GsBzBShx1r/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.tcvZNZAyAI/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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.021634 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:33:00.248653) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 10:33:00.249024) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev aef032ba201c027510f804901477113748db6681 --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-beta --rev aef032ba201c027510f804901477113748db6681 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GsBzBShx1r/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.tcvZNZAyAI/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-30 10:33:00,333 truncating revision to first 12 chars 2016-11-30 10:33:00,333 Setting DEBUG logging. 2016-11-30 10:33:00,333 attempt 1/10 2016-11-30 10:33:00,333 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/aef032ba201c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 10:33:00,978 unpacking tar archive at: mozilla-beta-aef032ba201c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934518 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-30 10:33:01.304562) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 10:33:01.304917) ========= script_repo_revision: aef032ba201c027510f804901477113748db6681 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 10:33:01.305377) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 10:33:01.305703) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 10:33:01.326467) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-30 10:33:01.326875) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.GsBzBShx1r/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.tcvZNZAyAI/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:01 INFO - MultiFileLogger online at 20161130 10:33:01 in /builds/slave/test 10:33:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 10:33:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:33:01 INFO - {'append_to_log': False, 10:33:01 INFO - 'base_work_dir': '/builds/slave/test', 10:33:01 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:33:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:33:01 INFO - 'branch': 'Mozilla-Beta', 10:33:01 INFO - 'buildbot_json_path': 'buildprops.json', 10:33:01 INFO - 'config_files': ('talos/mac_config.py',), 10:33:01 INFO - 'default_actions': ('clobber', 10:33:01 INFO - 'read-buildbot-config', 10:33:01 INFO - 'download-and-extract', 10:33:01 INFO - 'populate-webroot', 10:33:01 INFO - 'create-virtualenv', 10:33:01 INFO - 'install', 10:33:01 INFO - 'run-tests'), 10:33:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:33:01 INFO - 'download_minidump_stackwalk': True, 10:33:01 INFO - 'download_symbols': 'ondemand', 10:33:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:33:01 INFO - 'tooltool.py': '/tools/tooltool.py', 10:33:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:33:01 INFO - '/tools/misc-python/virtualenv.py')}, 10:33:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:33:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:33:01 INFO - 'installer_path': 'installer.exe', 10:33:01 INFO - 'log_level': 'info', 10:33:01 INFO - 'log_name': 'talos', 10:33:01 INFO - 'log_to_console': True, 10:33:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:33:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:33:01 INFO - 'opt_config_files': (), 10:33:01 INFO - 'pip_index': False, 10:33:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:33:01 INFO - 'cmd': ('bash', 10:33:01 INFO - '-c', 10:33:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:33:01 INFO - 'enabled': True, 10:33:01 INFO - 'halt_on_failure': False, 10:33:01 INFO - 'name': 'check_screen_resolution'},), 10:33:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:33:01 INFO - 'cmd': ('bash', 10:33:01 INFO - '-c', 10:33:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:33:01 INFO - 'enabled': True, 10:33:01 INFO - 'halt_on_failure': False, 10:33:01 INFO - 'name': 'check_screen_resolution'},), 10:33:01 INFO - 'run_cmd_checks_enabled': True, 10:33:01 INFO - 'sps_profile': False, 10:33:01 INFO - 'sps_profile_interval': 0, 10:33:01 INFO - 'suite': 'dromaeojs', 10:33:01 INFO - 'system_bits': '32', 10:33:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:33:01 INFO - 'title': 't-yosemite-r7-0351', 10:33:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:33:01 INFO - 'use_talos_json': True, 10:33:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:33:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:33:01 INFO - 'work_dir': 'build'} 10:33:01 INFO - [mozharness: 2016-11-30 18:33:01.519360Z] Running clobber step. 10:33:01 INFO - Running pre-action listener: _resource_record_pre_action 10:33:01 INFO - Running main action method: clobber 10:33:01 INFO - rmtree: /builds/slave/test/build 10:33:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:33:02 INFO - Running post-action listener: _resource_record_post_action 10:33:02 INFO - [mozharness: 2016-11-30 18:33:02.410003Z] Finished clobber step (success) 10:33:02 INFO - [mozharness: 2016-11-30 18:33:02.410120Z] Running read-buildbot-config step. 10:33:02 INFO - Running pre-action listener: _resource_record_pre_action 10:33:02 INFO - Running main action method: read_buildbot_config 10:33:02 INFO - Using buildbot properties: 10:33:02 INFO - { 10:33:02 INFO - "project": "", 10:33:02 INFO - "product": "firefox", 10:33:02 INFO - "script_repo_revision": "production", 10:33:02 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 10:33:02 INFO - "repository": "", 10:33:02 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 10:33:02 INFO - "buildid": "20161130084443", 10:33:02 INFO - "pgo_build": "False", 10:33:02 INFO - "basedir": "/builds/slave/test", 10:33:02 INFO - "buildnumber": 40, 10:33:02 INFO - "slavename": "t-yosemite-r7-0351", 10:33:02 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:33:02 INFO - "platform": "yosemite_r7", 10:33:02 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:33:02 INFO - "branch": "mozilla-beta", 10:33:02 INFO - "repo_path": "releases/mozilla-beta", 10:33:02 INFO - "revision": "aef032ba201c027510f804901477113748db6681", 10:33:02 INFO - "stage_platform": "macosx64", 10:33:02 INFO - "builduid": "3de78507841e48c0bddab9ef8bd21852", 10:33:02 INFO - "slavebuilddir": "test" 10:33:02 INFO - } 10:33:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 10:33:02 INFO - Running post-action listener: _resource_record_post_action 10:33:02 INFO - [mozharness: 2016-11-30 18:33:02.413295Z] Finished read-buildbot-config step (success) 10:33:02 INFO - [mozharness: 2016-11-30 18:33:02.413407Z] Running download-and-extract step. 10:33:02 INFO - Running pre-action listener: _resource_record_pre_action 10:33:02 INFO - Running main action method: download_and_extract 10:33:02 INFO - mkdir: /builds/slave/test/build/tests 10:33: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')]} 10:33:02 INFO - trying https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 10:33:02 INFO - Downloading https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 10:33:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 10:33:03 INFO - Downloaded 1165 bytes. 10:33:03 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 10:33:03 INFO - Using the following test package requirements: 10:33:03 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 10:33:03 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:03 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 10:33:03 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:03 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 10:33:03 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:33:03 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:03 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 10:33:03 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 10:33:03 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:03 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 10:33:03 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:03 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 10:33:03 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:03 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 10:33:03 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 10:33:03 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 10:33:03 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 10:33:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 10:33:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 10:33:03 INFO - Fetch https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 10:33:03 INFO - Expected file size: 16233195 10:33:10 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:33:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 10:33:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 10:33:10 INFO - Fetch https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 10:33:11 INFO - Expected file size: 16233195 10:33:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 10:33:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 10:33:17 INFO - Fetch https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 10:33:18 INFO - Expected file size: 14414089 10:33:19 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')]} 10:33:19 INFO - trying https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:33:19 INFO - Downloading https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 10:33:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 10:33:21 INFO - Downloaded 86054771 bytes. 10:33:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:33:21 INFO - mkdir: /builds/slave/test/properties 10:33:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:33:21 INFO - Writing to file /builds/slave/test/properties/build_url 10:33:21 INFO - Contents: 10:33:21 INFO - build_url:https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 10:33:22 INFO - Running post-action listener: _resource_record_post_action 10:33:22 INFO - Running post-action listener: set_extra_try_arguments 10:33:22 INFO - [mozharness: 2016-11-30 18:33:22.249942Z] Finished download-and-extract step (success) 10:33:22 INFO - [mozharness: 2016-11-30 18:33:22.250060Z] Running populate-webroot step. 10:33:22 INFO - Running pre-action listener: _resource_record_pre_action 10:33:22 INFO - Running main action method: populate_webroot 10:33:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:33:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:33:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:33:22 INFO - '--tppagecycles', 10:33:22 INFO - '7'], 10:33:22 INFO - 'tests': ['tsvgm']}}, 10:33:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:33:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:33:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:33:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:33:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:33:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['damp', 'tps']}, 10:33:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'tests': ['damp', 'tps']}, 10:33:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['dromaeo_dom']}, 10:33:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:33:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['basic_compositor_video']}, 10:33:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:33:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['a11yr', 10:33:22 INFO - 'ts_paint', 10:33:22 INFO - 'tpaint', 10:33:22 INFO - 'sessionrestore', 10:33:22 INFO - 'sessionrestore_no_auto_restore', 10:33:22 INFO - 'tabpaint']}, 10:33:22 INFO - 'other-e10s': {'tests': ['a11yr', 10:33:22 INFO - 'ts_paint', 10:33:22 INFO - 'tpaint', 10:33:22 INFO - 'sessionrestore', 10:33:22 INFO - 'sessionrestore_no_auto_restore', 10:33:22 INFO - 'tabpaint']}, 10:33:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:33:22 INFO - 'ts_paint', 10:33:22 INFO - 'tpaint', 10:33:22 INFO - 'sessionrestore', 10:33:22 INFO - 'sessionrestore_no_auto_restore', 10:33:22 INFO - 'tabpaint']}, 10:33:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:33:22 INFO - 'ts_paint', 10:33:22 INFO - 'tpaint', 10:33:22 INFO - 'sessionrestore', 10:33:22 INFO - 'sessionrestore_no_auto_restore', 10:33:22 INFO - 'tabpaint']}, 10:33:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['a11yr', 10:33:22 INFO - 'ts_paint', 10:33:22 INFO - 'tpaint', 10:33:22 INFO - 'sessionrestore', 10:33:22 INFO - 'sessionrestore_no_auto_restore', 10:33:22 INFO - 'tabpaint']}, 10:33:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['a11yr', 10:33:22 INFO - 'ts_paint', 10:33:22 INFO - 'tpaint', 10:33:22 INFO - 'sessionrestore', 10:33:22 INFO - 'sessionrestore_no_auto_restore', 10:33:22 INFO - 'tabpaint']}, 10:33:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['tsvgx', 10:33:22 INFO - 'tsvgr_opacity', 10:33:22 INFO - 'tart', 10:33:22 INFO - 'tscrollx', 10:33:22 INFO - 'cart']}, 10:33:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:33:22 INFO - 'tsvgr_opacity', 10:33:22 INFO - 'tart', 10:33:22 INFO - 'tscrollx', 10:33:22 INFO - 'cart']}, 10:33:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'talos_options': ['--disable-e10s'], 10:33:22 INFO - 'tests': ['tp5o']}, 10:33:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'tests': ['tp5o']}, 10:33:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'talos_options': ['--disable-e10s', 10:33:22 INFO - '--xperf_path', 10:33:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:22 INFO - 'tests': ['tp5n']}, 10:33:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:33:22 INFO - 'talos_options': ['--xperf_path', 10:33:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:33:22 INFO - 'tests': ['tp5n']}}, 10:33:22 INFO - 'talos.zip': {'path': '', 10:33:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:33:22 INFO - Running post-action listener: _resource_record_post_action 10:33:22 INFO - [mozharness: 2016-11-30 18:33:22.268689Z] Finished populate-webroot step (success) 10:33:22 INFO - [mozharness: 2016-11-30 18:33:22.268825Z] Running create-virtualenv step. 10:33:22 INFO - Running pre-action listener: _resource_record_pre_action 10:33:22 INFO - Running main action method: create_virtualenv 10:33:22 INFO - Creating virtualenv /builds/slave/test/build/venv 10:33:22 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 10:33:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:33:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:33:22 INFO - Using real prefix '/tools/python27' 10:33:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:33:23 INFO - Installing distribute.............................................................................................................................................................................................done. 10:33:25 INFO - Installing pip.................done. 10:33:25 INFO - Return code: 0 10:33:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:33:25 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')]} 10:33:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:25 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')]} 10:33:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:25 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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:25 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 10:33:25 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 10:33:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:25 INFO - 'HOME': '/Users/cltbld', 10:33:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:25 INFO - 'LOGNAME': 'cltbld', 10:33:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:25 INFO - 'MOZ_NO_REMOTE': '1', 10:33:25 INFO - 'NO_EM_RESTART': '1', 10:33:25 INFO - 'PAGER': '/bin/cat', 10:33:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:25 INFO - 'PWD': '/builds/slave/test', 10:33:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:25 INFO - 'SHELL': '/bin/bash', 10:33:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:25 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:25 INFO - 'USER': 'cltbld', 10:33:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:25 INFO - 'XPC_FLAGS': '0x0', 10:33:25 INFO - 'XPC_SERVICE_NAME': '0', 10:33:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:26 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 10:33:26 INFO - Cleaning up... 10:33:26 INFO - Return code: 0 10:33:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:33:26 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')]} 10:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:26 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')]} 10:33:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:26 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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:26 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 10:33:26 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 10:33:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:26 INFO - 'HOME': '/Users/cltbld', 10:33:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:26 INFO - 'LOGNAME': 'cltbld', 10:33:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:26 INFO - 'MOZ_NO_REMOTE': '1', 10:33:26 INFO - 'NO_EM_RESTART': '1', 10:33:26 INFO - 'PAGER': '/bin/cat', 10:33:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:26 INFO - 'PWD': '/builds/slave/test', 10:33:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:26 INFO - 'SHELL': '/bin/bash', 10:33:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:26 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:26 INFO - 'USER': 'cltbld', 10:33:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:26 INFO - 'XPC_FLAGS': '0x0', 10:33:26 INFO - 'XPC_SERVICE_NAME': '0', 10:33:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:26 INFO - Downloading/unpacking psutil>=3.1.1 10:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:33:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:33:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:29 INFO - Installing collected packages: psutil 10:33:29 INFO - Running setup.py install for psutil 10:33:29 INFO - building 'psutil._psutil_osx' extension 10:33:29 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 10:33:30 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 10:33:30 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 10:33:30 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 10:33:30 INFO - building 'psutil._psutil_posix' extension 10:33:30 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 10:33:30 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:33:30 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:33:30 INFO - ^ 10:33:30 INFO - 1 warning generated. 10:33:30 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 10:33:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:33:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:33:30 INFO - Successfully installed psutil 10:33:30 INFO - Cleaning up... 10:33:30 INFO - Return code: 0 10:33:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:30 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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:30 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 10:33:30 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 10:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:30 INFO - 'HOME': '/Users/cltbld', 10:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:30 INFO - 'LOGNAME': 'cltbld', 10:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:30 INFO - 'MOZ_NO_REMOTE': '1', 10:33:30 INFO - 'NO_EM_RESTART': '1', 10:33:30 INFO - 'PAGER': '/bin/cat', 10:33:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:30 INFO - 'PWD': '/builds/slave/test', 10:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:30 INFO - 'SHELL': '/bin/bash', 10:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:30 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:30 INFO - 'USER': 'cltbld', 10:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:30 INFO - 'XPC_FLAGS': '0x0', 10:33:30 INFO - 'XPC_SERVICE_NAME': '0', 10:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:33:30 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 10:33:30 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 10:33:30 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 10:33:30 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 10:33:30 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 10:33:30 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 10:33:33 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:33:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:33:33 INFO - Installing collected packages: mozsystemmonitor 10:33:33 INFO - Running setup.py install for mozsystemmonitor 10:33:33 INFO - Successfully installed mozsystemmonitor 10:33:33 INFO - Cleaning up... 10:33:33 INFO - Return code: 0 10:33:33 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:33:33 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')]} 10:33:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:33 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')]} 10:33:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:33 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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:33 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 10:33:33 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 10:33:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:33 INFO - 'HOME': '/Users/cltbld', 10:33:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:33 INFO - 'LOGNAME': 'cltbld', 10:33:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:33 INFO - 'MOZ_NO_REMOTE': '1', 10:33:33 INFO - 'NO_EM_RESTART': '1', 10:33:33 INFO - 'PAGER': '/bin/cat', 10:33:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:33 INFO - 'PWD': '/builds/slave/test', 10:33:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:33 INFO - 'SHELL': '/bin/bash', 10:33:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:33 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:33 INFO - 'USER': 'cltbld', 10:33:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:33 INFO - 'XPC_FLAGS': '0x0', 10:33:33 INFO - 'XPC_SERVICE_NAME': '0', 10:33:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:33 INFO - Downloading/unpacking jsonschema==2.5.1 10:33:33 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 10:33:33 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 10:33:33 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 10:33:33 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 10:33:33 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 10:33:33 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 10:33:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:33:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:33:36 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 10:33:36 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 10:33:36 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 10:33:36 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 10:33:36 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 10:33:36 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 10:33:36 INFO - Downloading functools32-3.2.3-2.tar.gz 10:33:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:33:37 INFO - warning: no files found matching '*.txt' 10:33:37 INFO - no previously-included directories found matching 'build' 10:33:37 INFO - no previously-included directories found matching 'dist' 10:33:37 INFO - no previously-included directories found matching '.git*' 10:33:37 INFO - Installing collected packages: jsonschema, functools32 10:33:37 INFO - Running setup.py install for functools32 10:33:37 INFO - warning: no files found matching '*.txt' 10:33:37 INFO - no previously-included directories found matching 'build' 10:33:37 INFO - no previously-included directories found matching 'dist' 10:33:37 INFO - no previously-included directories found matching '.git*' 10:33:37 INFO - Successfully installed jsonschema functools32 10:33:37 INFO - Cleaning up... 10:33:37 INFO - Return code: 0 10:33:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:37 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 10:33:37 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 10:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:37 INFO - 'HOME': '/Users/cltbld', 10:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:37 INFO - 'LOGNAME': 'cltbld', 10:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:37 INFO - 'MOZ_NO_REMOTE': '1', 10:33:37 INFO - 'NO_EM_RESTART': '1', 10:33:37 INFO - 'PAGER': '/bin/cat', 10:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:37 INFO - 'PWD': '/builds/slave/test', 10:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:37 INFO - 'SHELL': '/bin/bash', 10:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:37 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:37 INFO - 'USER': 'cltbld', 10:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:37 INFO - 'XPC_FLAGS': '0x0', 10:33:37 INFO - 'XPC_SERVICE_NAME': '0', 10:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 10:33:37 INFO - Cleaning up... 10:33:37 INFO - Return code: 0 10:33:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:37 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 10:33:37 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 10:33:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:37 INFO - 'HOME': '/Users/cltbld', 10:33:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:37 INFO - 'LOGNAME': 'cltbld', 10:33:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:37 INFO - 'MOZ_NO_REMOTE': '1', 10:33:37 INFO - 'NO_EM_RESTART': '1', 10:33:37 INFO - 'PAGER': '/bin/cat', 10:33:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:37 INFO - 'PWD': '/builds/slave/test', 10:33:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:37 INFO - 'SHELL': '/bin/bash', 10:33:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:37 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:37 INFO - 'USER': 'cltbld', 10:33:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:37 INFO - 'XPC_FLAGS': '0x0', 10:33:37 INFO - 'XPC_SERVICE_NAME': '0', 10:33:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:37 INFO - Downloading/unpacking blobuploader==1.2.4 10:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:37 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 10:33:37 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 10:33:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 INFO - Downloading blobuploader-1.2.4.tar.gz 10:33:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:33:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:40 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 10:33:40 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 10:33:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:33:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:41 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 10:33:41 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 10:33:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:41 INFO - Downloading docopt-0.6.1.tar.gz 10:33:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:33:41 INFO - Installing collected packages: blobuploader, requests, docopt 10:33:41 INFO - Running setup.py install for blobuploader 10:33:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:33:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:33:41 INFO - Running setup.py install for requests 10:33:42 INFO - Running setup.py install for docopt 10:33:42 INFO - Successfully installed blobuploader requests docopt 10:33:42 INFO - Cleaning up... 10:33:42 INFO - Return code: 0 10:33:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:42 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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:42 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 10:33:42 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 10:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:42 INFO - 'HOME': '/Users/cltbld', 10:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:42 INFO - 'LOGNAME': 'cltbld', 10:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:42 INFO - 'MOZ_NO_REMOTE': '1', 10:33:42 INFO - 'NO_EM_RESTART': '1', 10:33:42 INFO - 'PAGER': '/bin/cat', 10:33:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:42 INFO - 'PWD': '/builds/slave/test', 10:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:42 INFO - 'SHELL': '/bin/bash', 10:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:42 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:42 INFO - 'USER': 'cltbld', 10:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:42 INFO - 'XPC_FLAGS': '0x0', 10:33:42 INFO - 'XPC_SERVICE_NAME': '0', 10:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:42 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-IXj5xA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:42 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-IlqAWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-XG7Doh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-pDsZNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-3MaPf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-6VrbXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-G5LJ89-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-sLiflq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-O2b4HL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-iJtdAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-EGOocK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:43 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-yMECJY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:44 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-CsAgER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:44 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-hycoNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:44 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-5m23J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:44 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-4E6trA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:44 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-VNQjBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:33:44 INFO - Running setup.py install for manifestparser 10:33:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:33:44 INFO - Running setup.py install for mozcrash 10:33:44 INFO - Running setup.py install for mozdebug 10:33:45 INFO - Running setup.py install for mozdevice 10:33:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Running setup.py install for mozfile 10:33:45 INFO - Running setup.py install for mozhttpd 10:33:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Running setup.py install for mozinfo 10:33:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Running setup.py install for mozInstall 10:33:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:33:45 INFO - Running setup.py install for mozleak 10:33:45 INFO - Running setup.py install for mozlog 10:33:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for moznetwork 10:33:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozprocess 10:33:46 INFO - Running setup.py install for mozprofile 10:33:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozrunner 10:33:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:33:46 INFO - Running setup.py install for mozscreenshot 10:33:46 INFO - Running setup.py install for moztest 10:33:47 INFO - Running setup.py install for mozversion 10:33:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:33:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:33:47 INFO - Cleaning up... 10:33:47 INFO - Return code: 0 10:33:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:33:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 10:33:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 10:33:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:47 INFO - 'HOME': '/Users/cltbld', 10:33:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:47 INFO - 'LOGNAME': 'cltbld', 10:33:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:47 INFO - 'MOZ_NO_REMOTE': '1', 10:33:47 INFO - 'NO_EM_RESTART': '1', 10:33:47 INFO - 'PAGER': '/bin/cat', 10:33:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:47 INFO - 'PWD': '/builds/slave/test', 10:33:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:47 INFO - 'SHELL': '/bin/bash', 10:33:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:47 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:47 INFO - 'USER': 'cltbld', 10:33:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:47 INFO - 'XPC_FLAGS': '0x0', 10:33:47 INFO - 'XPC_SERVICE_NAME': '0', 10:33:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:33:47 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-cnRPCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:33:47 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:33:47 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-YORlP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:33:47 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:33:47 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-B8M7LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:33:47 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:33:47 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-2rl7J4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:33:47 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:33:47 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-I0Sckq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:33:47 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)) 10:33:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:33:47 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-O72214-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-QRgm28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-lFVhOl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-0eHMyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-3DRrjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-ePvv5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:33:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-6KB9tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-XzR26d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-TWvZL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:33:48 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)) 10:33:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:48 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-Pym4p5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:33:49 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-h3M_8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:33:49 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)) 10:33:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:33:49 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-QDrRUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:33:49 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:49 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 10:33:49 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 10:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:33:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:33:51 INFO - Downloading blessings-1.6.tar.gz 10:33:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:33:51 INFO - Installing collected packages: blessings 10:33:51 INFO - Running setup.py install for blessings 10:33:52 INFO - Successfully installed blessings 10:33:52 INFO - Cleaning up... 10:33:52 INFO - Return code: 0 10:33:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:33:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:52 INFO - Reading from file tmpfile_stdout 10:33:52 INFO - Current package versions: 10:33:52 INFO - blessings == 1.6 10:33:52 INFO - blobuploader == 1.2.4 10:33:52 INFO - docopt == 0.6.1 10:33:52 INFO - functools32 == 3.2.3-2 10:33:52 INFO - jsonschema == 2.5.1 10:33:52 INFO - manifestparser == 1.1 10:33:52 INFO - mozInstall == 1.12 10:33:52 INFO - mozcrash == 0.17 10:33:52 INFO - mozdebug == 0.1 10:33:52 INFO - mozdevice == 0.48 10:33:52 INFO - mozfile == 1.2 10:33:52 INFO - mozhttpd == 0.7 10:33:52 INFO - mozinfo == 0.9 10:33:52 INFO - mozleak == 0.1 10:33:52 INFO - mozlog == 3.4 10:33:52 INFO - moznetwork == 0.27 10:33:52 INFO - mozprocess == 0.23 10:33:52 INFO - mozprofile == 0.28 10:33:52 INFO - mozrunner == 6.12 10:33:52 INFO - mozscreenshot == 0.1 10:33:52 INFO - mozsystemmonitor == 0.3 10:33:52 INFO - moztest == 0.7 10:33:52 INFO - mozversion == 1.4 10:33:52 INFO - psutil == 3.1.1 10:33:52 INFO - requests == 1.2.3 10:33:52 INFO - wsgiref == 0.1.2 10:33:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:33:52 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')]} 10:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:52 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')]} 10:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:52 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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:52 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 10:33:52 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 10:33:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:52 INFO - 'HOME': '/Users/cltbld', 10:33:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:52 INFO - 'LOGNAME': 'cltbld', 10:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:52 INFO - 'MOZ_NO_REMOTE': '1', 10:33:52 INFO - 'NO_EM_RESTART': '1', 10:33:52 INFO - 'PAGER': '/bin/cat', 10:33:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:52 INFO - 'PWD': '/builds/slave/test', 10:33:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:52 INFO - 'SHELL': '/bin/bash', 10:33:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:52 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:52 INFO - 'USER': 'cltbld', 10:33:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:52 INFO - 'XPC_FLAGS': '0x0', 10:33:52 INFO - 'XPC_SERVICE_NAME': '0', 10:33:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:52 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)) 10:33:52 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)) 10:33:52 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)) 10:33:52 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)) 10:33:52 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)) 10:33:52 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)) 10:33:52 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)) 10:33:52 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)) 10:33:52 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)) 10:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:33:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:33:52 INFO - Cleaning up... 10:33:52 INFO - Return code: 0 10:33:52 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:33:52 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')]} 10:33:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:33:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:52 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')]} 10:33:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:33:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:33:52 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 0x1064c3490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106439570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babd9eff0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, '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.GsBzBShx1r/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.tcvZNZAyAI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 10:33:52 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 10:33:52 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 10:33:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:33:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:33:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:33:52 INFO - 'HOME': '/Users/cltbld', 10:33:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:33:52 INFO - 'LOGNAME': 'cltbld', 10:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:33:52 INFO - 'MOZ_NO_REMOTE': '1', 10:33:52 INFO - 'NO_EM_RESTART': '1', 10:33:52 INFO - 'PAGER': '/bin/cat', 10:33:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:33:52 INFO - 'PWD': '/builds/slave/test', 10:33:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:33:52 INFO - 'SHELL': '/bin/bash', 10:33:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:33:52 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:33:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:33:52 INFO - 'USER': 'cltbld', 10:33:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:33:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:33:52 INFO - 'XPC_FLAGS': '0x0', 10:33:52 INFO - 'XPC_SERVICE_NAME': '0', 10:33:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:33:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:33:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:33:53 INFO - Cleaning up... 10:33:53 INFO - Return code: 0 10:33:53 INFO - Running post-action listener: _resource_record_post_action 10:33:53 INFO - Running post-action listener: _start_resource_monitoring 10:33:53 INFO - Starting resource monitoring. 10:33:53 INFO - [mozharness: 2016-11-30 18:33:53.050603Z] Finished create-virtualenv step (success) 10:33:53 INFO - [mozharness: 2016-11-30 18:33:53.051563Z] Running install step. 10:33:53 INFO - Running pre-action listener: _resource_record_pre_action 10:33:53 INFO - Running main action method: install 10:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:33:53 INFO - Reading from file tmpfile_stdout 10:33:53 INFO - Detecting whether we're running mozinstall >=1.0... 10:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:33:53 INFO - Reading from file tmpfile_stdout 10:33:53 INFO - Output received: 10:33:53 INFO - Usage: mozinstall [options] installer 10:33:53 INFO - Options: 10:33:53 INFO - -h, --help show this help message and exit 10:33:53 INFO - -d DEST, --destination=DEST 10:33:53 INFO - Directory to install application into. [default: 10:33:53 INFO - "/builds/slave/test"] 10:33:53 INFO - --app=APP Application being installed. [default: firefox] 10:33:53 INFO - mkdir: /builds/slave/test/build/application 10:33:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:33:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:34:15 INFO - Reading from file tmpfile_stdout 10:34:15 INFO - Output received: 10:34:15 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:34:15 INFO - Running post-action listener: _resource_record_post_action 10:34:15 INFO - [mozharness: 2016-11-30 18:34:15.417315Z] Finished install step (success) 10:34:15 INFO - [mozharness: 2016-11-30 18:34:15.417477Z] Running run-tests step. 10:34:15 INFO - Running pre-action listener: _resource_record_pre_action 10:34:15 INFO - Running main action method: run_tests 10:34:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:34:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:34:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:34:15 INFO - 2016-11-30 10:34:15.432 screenresolution[1915:12898] starting screenresolution argv=screenresolution get 10:34:15 INFO - 2016-11-30 10:34:15.434 screenresolution[1915:12898] Display 0: 1600x1200x32@60 10:34:15 INFO - 2016-11-30 10:34:15.440 screenresolution[1916:12901] starting screenresolution argv=screenresolution list 10:34:15 INFO - Available Modes on Display 0 10:34:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:34:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:34:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:34:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:34:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:34:15 INFO - Intel Iris: 10:34:15 INFO - Chipset Model: Intel Iris 10:34:15 INFO - Type: GPU 10:34:15 INFO - Bus: Built-In 10:34:15 INFO - VRAM (Dynamic, Max): 1536 MB 10:34:15 INFO - Vendor: Intel (0x8086) 10:34:15 INFO - Device ID: 0x0a2e 10:34:15 INFO - Revision ID: 0x0009 10:34:15 INFO - Displays: 10:34:15 INFO - Display: 10:34:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:34:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:34:15 INFO - Display Serial Number: 1600x1200 60 10:34:15 INFO - Main Display: Yes 10:34:15 INFO - Mirror: Off 10:34:15 INFO - Online: Yes 10:34:15 INFO - Rotation: Supported 10:34:15 INFO - Return code: 0 10:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:34:15 INFO - Python 2.7.3 10:34:15 INFO - Return code: 0 10:34:15 INFO - grabbing minidump binary from tooltool 10:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 10:34:15 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 0x1062d7d30>, '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 0x10613ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1062cfb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:34:15 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 10:34:15 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 10:34:15 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 10:34:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:34:15 INFO - Return code: 0 10:34:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:34:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:34:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:34:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:34:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:34:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0351', '--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 10:34:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0351 --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 10:34:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.GsBzBShx1r/Render', 10:34:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:34:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:34:15 INFO - 'HOME': '/Users/cltbld', 10:34:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:34:15 INFO - 'LOGNAME': 'cltbld', 10:34:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:34:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:34:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:34:15 INFO - 'MOZ_NO_REMOTE': '1', 10:34:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:34:15 INFO - 'NO_EM_RESTART': '1', 10:34:15 INFO - 'PAGER': '/bin/cat', 10:34:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:34:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:34:15 INFO - 'PWD': '/builds/slave/test', 10:34:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:34:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:34:15 INFO - 'SHELL': '/bin/bash', 10:34:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tcvZNZAyAI/Listeners', 10:34:15 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 10:34:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:34:15 INFO - 'USER': 'cltbld', 10:34:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:34:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:34:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:34:15 INFO - 'XPC_FLAGS': '0x0', 10:34:15 INFO - 'XPC_SERVICE_NAME': '0', 10:34:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:34:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0351', '--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 10:34:16 INFO - mozversion application_buildid: 20161130084443 10:34:16 INFO - mozversion application_changeset: aef032ba201c027510f804901477113748db6681 10:34:16 INFO - mozversion application_display_name: Firefox 10:34:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:34:16 INFO - mozversion application_name: Firefox 10:34:16 INFO - mozversion application_remotingname: firefox 10:34:16 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:34:16 INFO - mozversion application_vendor: Mozilla 10:34:16 INFO - mozversion application_version: 51.0 10:34:16 INFO - mozversion platform_buildid: 20161130084443 10:34:16 INFO - mozversion platform_changeset: aef032ba201c027510f804901477113748db6681 10:34:16 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:34:16 INFO - mozversion platform_version: 51.0 10:34:16 INFO - using testdate: 1480530856 10:34:16 INFO - actual date: 1480530856 10:34:16 INFO - starting webserver on 'localhost:49527' 10:34:16 INFO - SUITE-START | Running 2 tests 10:34:16 INFO - TEST-START | dromaeo_css 10:34:16 INFO - operating with platform_type : mac_ 10:34:16 INFO - Initialising browser for dromaeo_css test... 10:34:16 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpfYChU5/profile http://localhost:49527/getInfo.html) 10:34:18 INFO - PROCESS | 1926 | __metrics Screen width/height:1600/1200 10:34:18 INFO - PROCESS | 1926 | colorDepth:24 10:34:18 INFO - PROCESS | 1926 | Browser inner width/height: 1024/689 10:34:18 INFO - PROCESS | 1926 | __metrics 10:34:18 INFO - PROCESS | 1926 | 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" 10:34:18 INFO - PROCESS | 1926 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:34:18 INFO - TEST-INFO | 1926: exit 0 10:34:18 INFO - Browser initialized. 10:34:18 INFO - Running cycle 1/1 for dromaeo_css test... 10:34:18 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpfYChU5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:34:30 INFO - PROCESS | 1928 | RSS: Main: 169058304 10:34:30 INFO - PROCESS | 1928 | 10:35:21 INFO - PROCESS | 1928 | 1480530921569 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] 10:37:33 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49527/tests/dromaeo/cssquery-ext.html) 10:37:34 INFO - PROCESS | 1928 | RSS: Main: 273932288 10:37:34 INFO - PROCESS | 1928 | 10:40:37 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-ext.html (next: http://localhost:49527/tests/dromaeo/cssquery-jquery.html) 10:40:37 INFO - PROCESS | 1928 | RSS: Main: 302370816 10:40:37 INFO - PROCESS | 1928 | 10:43:40 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49527/tests/dromaeo/cssquery-mootools.html) 10:43:40 INFO - PROCESS | 1928 | RSS: Main: 275988480 10:43:40 INFO - PROCESS | 1928 | 10:46:42 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49527/tests/dromaeo/cssquery-prototype.html) 10:46:43 INFO - PROCESS | 1928 | RSS: Main: 274657280 10:46:43 INFO - PROCESS | 1928 | 10:49:46 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49527/tests/dromaeo/cssquery-yui.html) 10:49:47 INFO - PROCESS | 1928 | RSS: Main: 263368704 10:49:47 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:49527/tests/dromaeo/cssquery-yui.html (next: http://localhost:49527/tests/dromaeo/cssquery-dojo.html) 10:52:50 INFO - PROCESS | 1928 | RSS: Main: 307568640 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | __start_tp_report 10:52:50 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 10:52:50 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 10:52:50 INFO - PROCESS | 1928 | |i|pagename|runs| 10:52:50 INFO - PROCESS | 1928 | |0;dojo.html;3430.0395889151036;3440.2603440260345;3466.8786592469255;3477;3502.1419752160723;5754.625949313292;5809.6804675742815;5847.327557330908;5849.853753656161;5850.678212698305;5798.565107616935;5895.322037965635;5897.823065308047;5902.881942361161;5909.143174239733;5253.159494480884;5286.735663216843;5341.439148889369;5353.411124776291;5373.194020896877;5257.395399529046;5265.473452654723;5275.577953763709;5395.10980688186;5400.378956420003;5255.0803609368395;5284.207368894658;5286.101362768339;5323.307969963899;5331.253624492574;5308.336457942757;5355.598330125217;5372.435894231088;5377.435369286247;5379.058664733695;5158.974205128988;5230.476952304777;5280.81517146898;5311.362636483646;5331.360236771612;5727.942720572824;5747.626404283708;5768.855778605526;5789.594728369016;5806.129080637896;6261.686915654199;6284.151639528696;6349.269833969107;6372.553921225516;6373.936260637381;6255.655938923357;6315.842103947392;6321.936780632181;6324.557280990332;6326.588771729823;5827.679477628729;5879.265091863517;5908.291005079418;5942.138389933435;5958;6335.04038014238;6355.841103972345;6358.650274234869;6359.268684101295;6362.968185159045;6301.054841773771;6308.495320374359;6319.905201421982;6320.051992201206;6324.146240257598;6220.688965551704;6275.843103922347;6278.183836101369;6331.525135614847;6335.986242201226;6292.528060395397;6305.306416294204;6314.905276420765;6346.555741098171;6349.682515874188;6309.716062777186;6350.0792385103905;6353.3329000455215;6363.96818015907;6386.552941294158;4945.8516244512;4999.600031997432;5012.8496145115705;5048.72232027242;5071.4928507149725;4532.184206842734;4567.3377360282575;4581.816727330936;4596.8161273548685;4650.953490465052;6034.125051867454;6051.727672254759;6057;6062.9996050652035;6067.908981365283;6249.1563638908165;6278.0269058296035;6287.685615719196;6313.242410910629;6335.873282534323;5856.795012174553;5926.851828704317;5964.522838172936;5985.922533943932;6025.307089684742;5551.361593416808;5558.722063896789;5566.944330556643;5571.220029195916;5584.274044374205;6379.5215358847345;6410.423061924449;6418.775342862978;6427.517936154713;6430.164078669836;6228.750849965951;6235.532335074797;6281.4660753834605;6324.462420694109;6324.778632747832;6322.49420046386;6341.4292713656;6347.809565713036;6350.460210881942;6370.235571731237;6296.811095667137;6302.464290535356;6305.5270854687;6314.400131987454;6321.367863213642;6234.345393733593;6239.844003899939;6307.3377295383325;6331.145295385064;6346.650934198663;6140.232470941132;6187.783427580013;6301.779437719658;6326.398992095744;6328.303886572381;6278.748850045947;6293.685315734287;6295.779647712308;6296.0555916612875;6300.243970723543;5770.5095066919785;5986.970065149646;6042.516598672008;6148.631082135086;6178.505719542336;6117.712680657782;6146.354632763674;6151.784687535915;6248.218972628421;6253.749850006131;6102.938970610415;6108.267007959073;6122.969385153046;6124.448799608057;6128.356522565245 10:52:50 INFO - PROCESS | 1928 | |1;ext.html;487.33089169594143;517.2474050256876;539.7382269599244;546.6037123085766;560.3164139749504;41868.790656046716;43422.56577434225;43642.90892727683;44954.87612809682;45043.09913801722;44005.77997110018;44566;44577.8855528612;44629;44635.214591416385;9328.300377471684;10040.447775372351;10228.87482376938;10245.231607629421;10265.64070257541;9392.90607093927;12328.630141095737;12509.499620015235;12567.43446544903;12582.496700131984;12345.259284442916;12403;12408.689782755459;12408.813867791945;12413.069019823504;12503.312317822516;12589.055820813475;12601.873981260162;12623.873761262454;12632.368381580884;12266.81599776004;12313.261204327679;12321.630351089481;12328.952039076688;12332.136750427473;42557;42757.358639620434;42765.93085172865;42905.35641965373;42969.785151074044;3538.327717733648;3675.3016926783826;3676.3382591133586;3735.589085200626;4409.140217657558;33071.50392744111;33633;33711.32577348464;33839;34117.48823767646;3364.764466487347;3370.679785420381;3390.593128824557;3411.573553305837;3456.844442000116;506136;514659;517458;517588;519315;69787.95318070233;71144.64427677932;71166;71227.6438617814;71265.64367178235;37517.62482375196;38162.23675526474;38177;39263;39272.80363598164;15331.770023449657;18347;18356.541086472676;18370.35703750362;18383;12592.733308004465;12780.297083660302;12820.935895320463;13683.384247708877;13854.03021788465;18901.43295701131;19039.90480047591;20702;21449;21463.89268053681;7569.735059272899;8822.955885220661;8980.955095224483;8986.955065224764;9046.592903319366;917.7934964633038;991.9008099190023;1045.7346610601257;1051.2483574244452;1129.1418521923397;26493.86753066261;27197.45605087887;30857;31385.215369615944;31879.043628691175;938.4369378373058;1050.7478205230843;1108.2002866887417;1116.564539829451;1200.771853347861;12855.742885142432;14714.779278310834;15200.08799472013;15634.9218253908;15900.92049539768;690803;699752;700099;700890;701608;61057.69471152616;61820.072698908654;61823.072653910225;61899.38100619026;62124.68937655373;1308.476609356265;1327.853936067051;1426.5149849051372;1458.4239225506078;1459.1901494670346;32071.83964080258;32122.35755284928;32798.836005820776;33037.33925321432;33787.4931876027;52063.73968130135;52662;52777;52875.73562132165;52910.73544632252;551416;553885;554505.2274738762;554880;555888;25626.359341016625;25951.610725839506;28786.856065719538;29201;29368.26579335534;46791.76604117094;49217.26174107463;49245.26132108093;49468;49799.253011204135;39372.86584908658;40441.39337909993;40691.98270043272;42052.5281615142;42160.78919605505;40320.19359612733;40615.79692101521;40903;42151.946201343984;42204.57795422129;39302.80348598239;39747.60252397439;40213;40320.99197520086;40643.79678101709;33770.83114584412;34956.82521587376;35663.82168089143;35758.28483430265;35815.64184358227;26187.73812261853;26474.338141546614;26547.203583892515;26670.733292666824;26977 10:52:50 INFO - PROCESS | 1928 | |2;jquery.html;383.34830787660974;386.574246602569;387.8913904106851;393.4000649010259;413.35103886897565;15317.92341038296;21013.789862101374;21338.46653833655;22098.889505552488;22221.333359999207;16644.500664980038;19824.801751982475;20752;20937.16251349948;21476;5217.530422261995;6364.172657554512;6365.331640177784;6378.553501254914;6379.744810207586;6012.7294271757655;6242.812715618516;6259.62442253464;6307.905381419282;6330.461910737593;6269.435750782452;6270.811875643715;6279.120923070774;6283.497320214372;6286.3399343069;6009.489193418564;6210.62736235825;6288.496920246369;6303.086052522382;6317.715702793385;5545;5545.972270138664;5555.694436805974;5558.471945165203;7644.770656880247;29213.561796573067;29768.851155744083;30118.698813012026;30694.9256776014;30822.38355232883;2343.7773411525877;2461.3477428481465;2488.228649118779;2539.949201015988;2569.601711734684;16666;17619;17866.464006079837;18391.448256552325;18796.060196990096;2118.364490652798;2193.462601662587;2212.1704360864674;2229.687843701883;2291.7937385635205;139191;143108;150145;155103;158838.41161588352;18382;21793.891030545063;22189.778102219094;22279.10883564639;22653.773462265166;37523.37336386481;37554.061148471505;37849;38196;38320.42519362212;10186.337888037255;10656.78686426267;10723;11143.888561114447;11220.66338009861;9440.24478041755;9527.904720952702;9645.228381729445;9760.170385517311;9818.705438836847;8228.21831925966;10200.897991019994;10274.020534045043;10276.22928280367;10296.948515257376;3158.562853901469;3836.3478208704587;3842.2709780598843;3893.707971902062;3936.6063393660406;821.5481485183126;895.5880295064213;964.9855252171224;970.1559643110539;1022.2026819081128;18272.543186420447;21392.572148557254;22461.88769056144;22591.548169036527;22639.547209056054;941.5857022909897;964.5900492290748;974.3812678948918;984.2175470500969;1039.6621098143135;11395.772084558263;11777.900185099863;11845.644630661094;11926.940365298291;12000.939995299968;543886;546492;551729;636759;670058;120771;154945;155286;157472.21263893606;158378.20810896103;998.1366118307611;1029.7580068683853;1047.245982892301;1047.6542740895486;1048.2766890845292;17776.288948441917;19144.521386965436;19369.225230991167;20123.899380503004;20382.898085509478;54870.90258194893;59101.70449147727;59931.8013639716;60963.47591310253;61012;77245;82956;83181.58409207915;83620.16379836368;85637.57181214304;6342.7780027700655;7608.8478230436185;7697.307242348215;7758.224177582197;8304.252617264476;11125.388103654377;13367.131136476099;13459.259740714355;13798.103123296954;13998.580042598738;5499.725013749377;8289.709860154866;8895.398828210984;11916.52333906634;12010.519579216734;9609.894862090949;9941.701748947544;10885.836712449478;11659.06727461784;11997.340146292037;11248.437578121226;11512.136589755635;11656.18406711522;11817.113716471127;12142.150049496451;6991.510594258557;7461.515001524884;7511.549307041595;7552.509086909334;7903.288704016666;10204.897951020395;10481.109105726098;10630.043296103388;11033.007029367396;11198.776024479628 10:52:50 INFO - PROCESS | 1928 | |3;mootools.html;1461.0868207370393;1568.0278227498948;1775.9289628414856;1930.9034548272582;1941.155597315168;8784.209421152103;9325.81348373032;9335.253179745621;9353.298502612315;9394.71815845524;7367.18960914299;8086.514809111457;8353.624086916088;8364.2472177504;8460.407771456;2385.976140238597;2473.925782226527;2475.183189547454;2480.1691433369842;2484.962725559118;2148.806607405333;2453.619688948207;2460.052879641342;2489.4192187960593;2490.638857365681;2457.533068716947;2464.0636558107894;2474.7648973347505;2476.6780318558654;2493.1523282084086;2439.9512009759706;2452.104981681682;2461.938451538708;2466.5066986602574;2477.2196758021164;2433;2447.192426499251;2453.472503411775;2456.754324567547;2459.7909177719916;9057.909420905773;9264.72205833826;9274.48990305533;9277.860832087525;9278.443293402417;5466.562674985991;5635.295588051494;5635.690037047961;5635.887282254373;5647.152927060933;3665.102049997741;3719.423489359154;3782.9810850945846;3796.8101594920145;3801.4297855321925;1117.7764447110528;1122.3714719756963;1137.9886201137965;1151.6314779270638;1865.533616595851;11869.94065029678;12167.574134905324;12195.512179512898;12203.755924881541;12213;3727.5340582427198;4701.294805779161;4777.713337199779;4792.041591681677;4794.400699912511;9406.858897116548;9408.870935487785;9433.716988490356;9446.527673616429;9465.337426380225;5457.263269458652;5462.918056229159;5465.152901300305;5471.753771080311;5474.2609747683555;4631.861044168681;4704;4990.90018199634;5114.232865070195;5132.820351287762;3899.454076429302;3910.511186101737;3982.5220973482787;4017.5178978522763;4027.617376349242;1032.863849765252;1205.8552973643218;1209.836672049262;1221.6579357779835;1221.9389030548436;816.432579357341;874.3049275825733;929.484136304344;942.34036174678;943.6555657185078;5642.971785141048;5813.7383817728305;5833.854153646193;6084.787032453932;6152.107944348045;450.73181457033013;455.8677983384781;464.9070185962821;470.4589721819866;472.02291257098165;3822.27376798413;4001.959980400217;4041.9191616167514;4062.8171732272117;4084.223997440536;10790.838137427945;10912;11263.155263355116;11275.718107047225;11279.548818047351;9719.659811906691;11086.33481991067;11331.943340283246;11339.092872570174;11352.602658907064;7041.471889608198;8426.620802063799;8449;8575.571221439028;8634.697785577475;5821.854453638523;5910.438508341701;5933.584649074523;6055.364186760503;6086.573939824169;10391.48042597852;10434.739131521468;10480.266381353233;10500.527476263434;10595.15238780911;8128.75613731589;10443.425611591436;10452.372857628567;10486.737831554272;10593.523291452057;7121.216666166821;7326.267373262845;7726.845463090819;7900.4074694397;8051.677932882619;8374.958125209336;8614.267787238156;8752.824943501222;8773.210411063035;8789.296856251613;6786.660666966533;7668.731594394169;7689.231076892266;7789.260020298063;7807.102183248999;7154.678039488132;7171.99592057102;7560.432967527568;7677.117131529945;7759.961200193963;7024.964875175591;7200.7479738211005;7201.279872012757;7201.747938822116;7203.531770434905;5054.469280725618;5084.288199651977;5093.580549239082;5208.8437346879655;5259.684418934876;5181.55956743666;5206.245094461357;5211.296474975829;5213.582913366998;5294.417614062373 10:52:50 INFO - PROCESS | 1928 | |4;prototype.html;271.7729451526359;276.29269071177794;298.4955425331191;319.4999825273447;325.60601671976906;4410.75740834254;4726.929096063562;4846.8125309299185;5125.718085505296;5151.871203219916;4597.678162528624;5079.949200508003;5199.168133098705;5241.633085684004;5294.841154765363;4035.939460908096;4074.775887326196;4078.4290199372113;4110.07523307255;4132.421460995463;3836.7889766062854;4048.0702104318457;4088.632023117919;4090.5909409059004;4100.610442008005;3569.696575791048;3713.1459764254237;3966.0877998060464;4069.532003819569;4081.3877918312196;3954.228925359556;4060.7360521566;4063.674906007512;4075.368317910714;4084.8978775530554;3396.609389920166;3578.8547664747293;3581.803000834953;3585.910352241189;3587.282543491312;5042.520960508746;5049.5455409013;5121.923171152435;5165.431802501722;5236.973815130938;4651.3023046543285;4651.720896746206;4685.461171965234;4709.62323014158;4751.287306903958;4750.64370172235;5079.419009598261;5472.91790623137;5583.302087239095;5589.301337332833;3812.407562857256;3907.6873850091924;3933.5279766427925;3996.080901392667;4000.6999475039197;4444.977775111169;5078.898422031576;5667.178259152441;5673.120666296731;5828.504577110951;4043.2924238258774;4051.108756073659;4060.3706425504092;4063.4514340564238;4084.7957602119777;3946.1515774108702;4131.140986556062;4133.491275684353;4144;4153.626173644387;4650.558196971282;4672.859814205579;4683.625309975262;4718.7168769873915;4779.641526885428;4719.976400117977;5572.5263352614675;5579.888402231933;5580.91628625571;5592.217089607459;1310.6264714556305;1327.396034804181;1359.8844098251561;1371.2869307960004;1404.7848610951658;701.9122609673791;751.0611735330837;781.1719577248135;814.226484839405;830.4436027861227;3907.648311651965;4176.310908700091;4216.47294088239;4305.569443055732;4389.561043895649;3936.3467343715706;4772.49666355104;4785.832495862628;4800.007996681408;4802.639802014863;3699.8335074921692;4123.969007748063;4303.956499121534;4344.370066340363;4418.288637544478;2222.0557012613963;2300.252417964168;2405.001924201437;2490.912818051396;2511.698596168435;4683.929741053887;4821.951780482221;4826.95173048265;4905.55849973497;4940.603807153528;4048.8541073231236;4566.429196350457;4636.026434448736;4818.445878723992;4864.391951006124;4127.277726397929;4278.4865816102265;4632.911265852522;4789.976050119727;4845.618998585386;4213.91572168561;4408.382826404242;4466.6873318867365;4579.564941330568;4616.584507394351;4359.256297481033;4633.328167415639;4640.658725717478;4657.9039432256295;4693.530646935279;3993.6206060424215;4844.716150220124;4877.731919613796;4884.580793444532;4912.238603016538;2731.893583098848;3413.8122403267066;3451.049352803417;3465.878694245689;3468.8439020243645;4476.768888555543;4607.654425918003;4683.297505374221;4709.116353458507;4717.654754355386;3860.9034774130873;4513.774311284488;4590.724556526619;4615.630749540096;4618.9076218474775;3618.764780289273;3958.9406158907063;4134.4831896013;4459.955400445954;4553.567411095941;4299.914001720011;4493.977530112328;4548.88627784308;5161.741912904415;5393.352797664305;5183.356488190974;5398;5638.915416268677;5641.238432811518;5651.8304450866535;5516.310461192351;5519.420460851553;5546.306711661043;5556.638818476786;5559.33288005442 10:52:50 INFO - PROCESS | 1928 | |5;yui.html;647.5046589359141;712.162034293341;766.6971546239239;819.5697258939056;862.5988915154454;16155.75766363504;17236.56908577283;17263.309467621297;17265.13674316284;17292.48122556322;15508.379664813423;15539.456119035836;15562;15585.610359740984;15654.139022353766;730.1639622632083;749.3705287558449;865.9653613855454;878.1789027259501;907.6188001039579;891.6789955615973;906.2161230535605;908.1780988205685;908.3142227618139;909.231699214163;972.4943029624591;973.732223638498;973.8344481438137;973.8490533967247;974.3471873844542;967.5500892085144;967.641972470187;970.2286682087687;970.6651205334149;971.4511301114883;716.5091912040269;717.121526130486;717.9820504487429;718.4503854551273;719.2232389019846;15852;15893.966892151973;15901.20493975308;15905.125218112998;15922.203889805463;13621.387037583234;13636.386362613706;13950.860491395058;14079.043400885826;14230.715385692332;12861.421236044307;13019.739605207842;13334.666633334147;13501.729965400637;13711.108777929403;4825.806967721287;4834;4888.046830867982;4965.106280869442;4998.700077995332;102871;121097.78902210866;121537.39231303876;125309;130879;10657.520411581498;11200.831987520194;11283.153763467773;11523.76952460946;11737.471813768401;22195.778042219372;22207.66688499674;22218.00018999149;22262.55474890493;22264.22075227359;8207.753767386988;8258.504489730636;8269.586520673942;8277.503349799032;8354.081051084377;4547.567981041796;4655.534446555317;4676.579107880307;4683.882902927454;4790.449098353664;3597.8201089945396;3698.6116457771545;3699.500567423417;3700.7224458165747;3702.1114932416026;669.5313280703527;674.8211723893172;675.3516624040976;675.5136301862651;676.922153952292;642.7557528139371;645.8094862015716;651.9902201466982;655.6623338980429;681.3459079283942;8206.507609543447;8936.731898043068;9550.37922535033;9630.036996300454;9737.123658870736;512.3518748782793;571.7884382778399;640.9807705768834;647.5887811239802;669.7053296549502;3990.68074554035;4428.202923473806;4659.534046595381;4672;4721.008588196449;120613;132527;170782;173722.13138934225;179641.1017944928;111292.44353778342;113891;116538.41730791293;131686.34156829154;147372;95091.52454237685;110381;111704;111869;117819.46541603765;9769.2673049523;10093.394396336244;10098.141657959155;10176.949115254376;10214.233932455245;62153.06770398538;62814.68592657008;63563;65340.67329663321;66217.38500072554;88347.55826220827;93480.59779103455;102017;102246.48876755568;103563.48218259162;13234.867651323364;13463.057585968889;13755.79366309486;13790;13830.515931942333;15264.618384540032;15315.909869051264;15482.5355239343;15617.921910390829;16575.83424165791;14001.579952601438;14108.78836817428;14848.40606375733;15025.699486010437;15098.094114353175;14080.788788168391;14747.92626036863;14776.704465910407;14934.402623894923;15217.239138043275;14262.358193881508;14310.49913253031;14310.49913253031;14337.856621433652;14345.354459049158;11620;12083.093767967262;12134.817977730518;12205.450754715881;12273.263604183421;11711.531538738354;11990.700232494257;12106.515739370327;12209.755804884031;12267.57063502773 10:52:50 INFO - PROCESS | 1928 | __end_tp_report 10:52:50 INFO - PROCESS | 1928 | __start_cc_report 10:52:50 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,1182 10:52:50 INFO - PROCESS | 1928 | __end_cc_report 10:52:50 INFO - PROCESS | 1928 | __startTimestamp1480531970411__endTimestamp 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | ------- Summary: start ------- 10:52:50 INFO - PROCESS | 1928 | Number of tests: 6 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | [#0] dojo.html Cycles:165 Average:5868.08 Median:6124.45 stddev:633.11 (10.3%) stddev-sans-first:605.48 10:52:50 INFO - PROCESS | 1928 | Values: 3430.0 3440.3 3466.9 3477.0 3502.1 5754.6 5809.7 5847.3 5849.9 5850.7 5798.6 5895.3 5897.8 5902.9 5909.1 5253.2 5286.7 5341.4 5353.4 5373.2 5257.4 5265.5 5275.6 5395.1 5400.4 5255.1 5284.2 5286.1 5323.3 5331.3 5308.3 5355.6 5372.4 5377.4 5379.1 5159.0 5230.5 5280.8 5311.4 5331.4 5727.9 5747.6 5768.9 5789.6 5806.1 6261.7 6284.2 6349.3 6372.6 6373.9 6255.7 6315.8 6321.9 6324.6 6326.6 5827.7 5879.3 5908.3 5942.1 5958.0 6335.0 6355.8 6358.7 6359.3 6363.0 6301.1 6308.5 6319.9 6320.1 6324.1 6220.7 6275.8 6278.2 6331.5 6336.0 6292.5 6305.3 6314.9 6346.6 6349.7 6309.7 6350.1 6353.3 6364.0 6386.6 4945.9 4999.6 5012.8 5048.7 5071.5 4532.2 4567.3 4581.8 4596.8 4651.0 6034.1 6051.7 6057.0 6063.0 6067.9 6249.2 6278.0 6287.7 6313.2 6335.9 5856.8 5926.9 5964.5 5985.9 6025.3 5551.4 5558.7 5566.9 5571.2 5584.3 6379.5 6410.4 6418.8 6427.5 6430.2 6228.8 6235.5 6281.5 6324.5 6324.8 6322.5 6341.4 6347.8 6350.5 6370.2 6296.8 6302.5 6305.5 6314.4 6321.4 6234.3 6239.8 6307.3 6331.1 6346.7 6140.2 6187.8 6301.8 6326.4 6328.3 6278.7 6293.7 6295.8 6296.1 6300.2 5770.5 5987.0 6042.5 6148.6 6178.5 6117.7 6146.4 6151.8 6248.2 6253.7 6102.9 6108.3 6123.0 6124.4 6128.4 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | [#1] ext.html Cycles:180 Average:72903.27 Median:19745.47 stddev:158822.05 (804.3%) stddev-sans-first:159174.53 10:52:50 INFO - PROCESS | 1928 | Values: 487.3 517.2 539.7 546.6 560.3 41868.8 43422.6 43642.9 44954.9 45043.1 44005.8 44566.0 44577.9 44629.0 44635.2 9328.3 10040.4 10228.9 10245.2 10265.6 9392.9 12328.6 12509.5 12567.4 12582.5 12345.3 12403.0 12408.7 12408.8 12413.1 12503.3 12589.1 12601.9 12623.9 12632.4 12266.8 12313.3 12321.6 12329.0 12332.1 42557.0 42757.4 42765.9 42905.4 42969.8 3538.3 3675.3 3676.3 3735.6 4409.1 33071.5 33633.0 33711.3 33839.0 34117.5 3364.8 3370.7 3390.6 3411.6 3456.8 506136.0 514659.0 517458.0 517588.0 519315.0 69788.0 71144.6 71166.0 71227.6 71265.6 37517.6 38162.2 38177.0 39263.0 39272.8 15331.8 18347.0 18356.5 18370.4 18383.0 12592.7 12780.3 12820.9 13683.4 13854.0 18901.4 19039.9 20702.0 21449.0 21463.9 7569.7 8823.0 8981.0 8987.0 9046.6 917.8 991.9 1045.7 1051.2 1129.1 26493.9 27197.5 30857.0 31385.2 31879.0 938.4 1050.7 1108.2 1116.6 1200.8 12855.7 14714.8 15200.1 15634.9 15900.9 690803.0 699752.0 700099.0 700890.0 701608.0 61057.7 61820.1 61823.1 61899.4 62124.7 1308.5 1327.9 1426.5 1458.4 1459.2 32071.8 32122.4 32798.8 33037.3 33787.5 52063.7 52662.0 52777.0 52875.7 52910.7 551416.0 553885.0 554505.2 554880.0 555888.0 25626.4 25951.6 28786.9 29201.0 29368.3 46791.8 49217.3 49245.3 49468.0 49799.3 39372.9 40441.4 40692.0 42052.5 42160.8 40320.2 40615.8 40903.0 42151.9 42204.6 39302.8 39747.6 40213.0 40321.0 40643.8 33770.8 34956.8 35663.8 35758.3 35815.6 26187.7 26474.3 26547.2 26670.7 26977.0 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | [#2] jquery.html Cycles:180 Average:38167.08 Median:29491.21 stddev:100223.71 (339.8%) stddev-sans-first:100464.71 10:52:50 INFO - PROCESS | 1928 | Values: 383.3 386.6 387.9 393.4 413.4 15317.9 21013.8 21338.5 22098.9 22221.3 16644.5 19824.8 20752.0 20937.2 21476.0 5217.5 6364.2 6365.3 6378.6 6379.7 6012.7 6242.8 6259.6 6307.9 6330.5 6269.4 6270.8 6279.1 6283.5 6286.3 6009.5 6210.6 6288.5 6303.1 6317.7 5545.0 5546.0 5555.7 5558.5 7644.8 29213.6 29768.9 30118.7 30694.9 30822.4 2343.8 2461.3 2488.2 2539.9 2569.6 16666.0 17619.0 17866.5 18391.4 18796.1 2118.4 2193.5 2212.2 2229.7 2291.8 139191.0 143108.0 150145.0 155103.0 158838.4 18382.0 21793.9 22189.8 22279.1 22653.8 37523.4 37554.1 37849.0 38196.0 38320.4 10186.3 10656.8 10723.0 11143.9 11220.7 9440.2 9527.9 9645.2 9760.2 9818.7 8228.2 10200.9 10274.0 10276.2 10296.9 3158.6 3836.3 3842.3 3893.7 3936.6 821.5 895.6 965.0 970.2 1022.2 18272.5 21392.6 22461.9 22591.5 22639.5 941.6 964.6 974.4 984.2 1039.7 11395.8 11777.9 11845.6 11926.9 12000.9 543886.0 546492.0 551729.0 636759.0 670058.0 120771.0 154945.0 155286.0 157472.2 158378.2 998.1 1029.8 1047.2 1047.7 1048.3 17776.3 19144.5 19369.2 20123.9 20382.9 54870.9 59101.7 59931.8 60963.5 61012.0 77245.0 82956.0 83181.6 83620.2 85637.6 6342.8 7608.8 7697.3 7758.2 8304.3 11125.4 13367.1 13459.3 13798.1 13998.6 5499.7 8289.7 8895.4 11916.5 12010.5 9609.9 9941.7 10885.8 11659.1 11997.3 11248.4 11512.1 11656.2 11817.1 12142.2 6991.5 7461.5 7511.5 7552.5 7903.3 10204.9 10481.1 10630.0 11033.0 11198.8 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | [#3] mootools.html Cycles:180 Average:5825.69 Median:5022.68 stddev:3281.88 (65.3%) stddev-sans-first:3274.70 10:52:50 INFO - PROCESS | 1928 | Values: 1461.1 1568.0 1775.9 1930.9 1941.2 8784.2 9325.8 9335.3 9353.3 9394.7 7367.2 8086.5 8353.6 8364.2 8460.4 2386.0 2473.9 2475.2 2480.2 2485.0 2148.8 2453.6 2460.1 2489.4 2490.6 2457.5 2464.1 2474.8 2476.7 2493.2 2440.0 2452.1 2461.9 2466.5 2477.2 2433.0 2447.2 2453.5 2456.8 2459.8 9057.9 9264.7 9274.5 9277.9 9278.4 5466.6 5635.3 5635.7 5635.9 5647.2 3665.1 3719.4 3783.0 3796.8 3801.4 1117.8 1122.4 1138.0 1151.6 1865.5 11869.9 12167.6 12195.5 12203.8 12213.0 3727.5 4701.3 4777.7 4792.0 4794.4 9406.9 9408.9 9433.7 9446.5 9465.3 5457.3 5462.9 5465.2 5471.8 5474.3 4631.9 4704.0 4990.9 5114.2 5132.8 3899.5 3910.5 3982.5 4017.5 4027.6 1032.9 1205.9 1209.8 1221.7 1221.9 816.4 874.3 929.5 942.3 943.7 5643.0 5813.7 5833.9 6084.8 6152.1 450.7 455.9 464.9 470.5 472.0 3822.3 4002.0 4041.9 4062.8 4084.2 10790.8 10912.0 11263.2 11275.7 11279.5 9719.7 11086.3 11331.9 11339.1 11352.6 7041.5 8426.6 8449.0 8575.6 8634.7 5821.9 5910.4 5933.6 6055.4 6086.6 10391.5 10434.7 10480.3 10500.5 10595.2 8128.8 10443.4 10452.4 10486.7 10593.5 7121.2 7326.3 7726.8 7900.4 8051.7 8375.0 8614.3 8752.8 8773.2 8789.3 6786.7 7668.7 7689.2 7789.3 7807.1 7154.7 7172.0 7560.4 7677.1 7760.0 7025.0 7200.7 7201.3 7201.7 7203.5 5054.5 5084.3 5093.6 5208.8 5259.7 5181.6 5206.2 5211.3 5213.6 5294.4 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | [#4] prototype.html Cycles:180 Average:4168.20 Median:4551.23 stddev:1222.16 (26.9%) stddev-sans-first:1190.09 10:52:50 INFO - PROCESS | 1928 | Values: 271.8 276.3 298.5 319.5 325.6 4410.8 4726.9 4846.8 5125.7 5151.9 4597.7 5079.9 5199.2 5241.6 5294.8 4035.9 4074.8 4078.4 4110.1 4132.4 3836.8 4048.1 4088.6 4090.6 4100.6 3569.7 3713.1 3966.1 4069.5 4081.4 3954.2 4060.7 4063.7 4075.4 4084.9 3396.6 3578.9 3581.8 3585.9 3587.3 5042.5 5049.5 5121.9 5165.4 5237.0 4651.3 4651.7 4685.5 4709.6 4751.3 4750.6 5079.4 5472.9 5583.3 5589.3 3812.4 3907.7 3933.5 3996.1 4000.7 4445.0 5078.9 5667.2 5673.1 5828.5 4043.3 4051.1 4060.4 4063.5 4084.8 3946.2 4131.1 4133.5 4144.0 4153.6 4650.6 4672.9 4683.6 4718.7 4779.6 4720.0 5572.5 5579.9 5580.9 5592.2 1310.6 1327.4 1359.9 1371.3 1404.8 701.9 751.1 781.2 814.2 830.4 3907.6 4176.3 4216.5 4305.6 4389.6 3936.3 4772.5 4785.8 4800.0 4802.6 3699.8 4124.0 4304.0 4344.4 4418.3 2222.1 2300.3 2405.0 2490.9 2511.7 4683.9 4822.0 4827.0 4905.6 4940.6 4048.9 4566.4 4636.0 4818.4 4864.4 4127.3 4278.5 4632.9 4790.0 4845.6 4213.9 4408.4 4466.7 4579.6 4616.6 4359.3 4633.3 4640.7 4657.9 4693.5 3993.6 4844.7 4877.7 4884.6 4912.2 2731.9 3413.8 3451.0 3465.9 3468.8 4476.8 4607.7 4683.3 4709.1 4717.7 3860.9 4513.8 4590.7 4615.6 4618.9 3618.8 3958.9 4134.5 4460.0 4553.6 4299.9 4494.0 4548.9 5161.7 5393.4 5183.4 5398.0 5638.9 5641.2 5651.8 5516.3 5519.4 5546.3 5556.6 5559.3 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - PROCESS | 1928 | [#5] yui.html Cycles:180 Average:25831.78 Median:100918.44 stddev:40978.20 (40.6%) stddev-sans-first:41049.52 10:52:50 INFO - PROCESS | 1928 | Values: 647.5 712.2 766.7 819.6 862.6 16155.8 17236.6 17263.3 17265.1 17292.5 15508.4 15539.5 15562.0 15585.6 15654.1 730.2 749.4 866.0 878.2 907.6 891.7 906.2 908.2 908.3 909.2 972.5 973.7 973.8 973.8 974.3 967.6 967.6 970.2 970.7 971.5 716.5 717.1 718.0 718.5 719.2 15852.0 15894.0 15901.2 15905.1 15922.2 13621.4 13636.4 13950.9 14079.0 14230.7 12861.4 13019.7 13334.7 13501.7 13711.1 4825.8 4834.0 4888.0 4965.1 4998.7 102871.0 121097.8 121537.4 125309.0 130879.0 10657.5 11200.8 11283.2 11523.8 11737.5 22195.8 22207.7 22218.0 22262.6 22264.2 8207.8 8258.5 8269.6 8277.5 8354.1 4547.6 4655.5 4676.6 4683.9 4790.4 3597.8 3698.6 3699.5 3700.7 3702.1 669.5 674.8 675.4 675.5 676.9 642.8 645.8 652.0 655.7 681.3 8206.5 8936.7 9550.4 9630.0 9737.1 512.4 571.8 641.0 647.6 669.7 3990.7 4428.2 4659.5 4672.0 4721.0 120613.0 132527.0 170782.0 173722.1 179641.1 111292.4 113891.0 116538.4 131686.3 147372.0 95091.5 110381.0 111704.0 111869.0 117819.5 9769.3 10093.4 10098.1 10176.9 10214.2 62153.1 62814.7 63563.0 65340.7 66217.4 88347.6 93480.6 102017.0 102246.5 103563.5 13234.9 13463.1 13755.8 13790.0 13830.5 15264.6 15315.9 15482.5 15617.9 16575.8 14001.6 14108.8 14848.4 15025.7 15098.1 14080.8 14747.9 14776.7 14934.4 15217.2 14262.4 14310.5 14310.5 14337.9 14345.4 11620.0 12083.1 12134.8 12205.5 12273.3 11711.5 11990.7 12106.5 12209.8 12267.6 10:52:50 INFO - PROCESS | 1928 | -------- Summary: end -------- 10:52:50 INFO - PROCESS | 1928 | 10:52:50 INFO - TEST-INFO | 1928: exit 0 10:52:50 INFO - TEST-OK | dromaeo_css | took 1114909ms 10:52:50 INFO - TEST-START | kraken 10:52:50 INFO - operating with platform_type : mac_ 10:52:50 INFO - Initialising browser for kraken test... 10:52:50 INFO - TEST-INFO | started process 1932 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmp0ejr9J/profile http://localhost:49527/getInfo.html) 10:52:53 INFO - PROCESS | 1932 | __metrics Screen width/height:1600/1200 10:52:53 INFO - PROCESS | 1932 | colorDepth:24 10:52:53 INFO - PROCESS | 1932 | Browser inner width/height: 1024/689 10:52:53 INFO - PROCESS | 1932 | __metrics 10:52:53 INFO - PROCESS | 1932 | 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" 10:52:53 INFO - PROCESS | 1932 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:52:53 INFO - TEST-INFO | 1932: exit 0 10:52:53 INFO - Browser initialized. 10:52:53 INFO - Running cycle 1/1 for kraken test... 10:52:53 INFO - TEST-INFO | started process 1934 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmp0ejr9J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:53:05 INFO - PROCESS | 1934 | RSS: Main: 168816640 10:53:05 INFO - PROCESS | 1934 | 10:53:08 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-beat-detection) 10:53:09 INFO - PROCESS | 1934 | RSS: Main: 218873856 10:53:09 INFO - PROCESS | 1934 | 10:53:12 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-dft) 10:53:12 INFO - PROCESS | 1934 | RSS: Main: 232583168 10:53:12 INFO - PROCESS | 1934 | 10:53:15 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-fft) 10:53:16 INFO - PROCESS | 1934 | RSS: Main: 330199040 10:53:16 INFO - PROCESS | 1934 | 10:53:18 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49527/tests/kraken/driver.html?testName=audio-oscillator) 10:53:19 INFO - PROCESS | 1934 | RSS: Main: 229105664 10:53:19 INFO - PROCESS | 1934 | 10:53:21 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49527/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:53:21 INFO - PROCESS | 1934 | RSS: Main: 230338560 10:53:21 INFO - PROCESS | 1934 | 10:53:24 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49527/tests/kraken/driver.html?testName=imaging-darkroom) 10:53:25 INFO - PROCESS | 1934 | RSS: Main: 266424320 10:53:25 INFO - PROCESS | 1934 | 10:53:27 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49527/tests/kraken/driver.html?testName=imaging-desaturate) 10:53:28 INFO - PROCESS | 1934 | RSS: Main: 268365824 10:53:28 INFO - PROCESS | 1934 | 10:53:31 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49527/tests/kraken/driver.html?testName=json-parse-financial) 10:53:31 INFO - PROCESS | 1934 | RSS: Main: 267825152 10:53:31 INFO - PROCESS | 1934 | 10:53:33 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49527/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:53:34 INFO - PROCESS | 1934 | RSS: Main: 243208192 10:53:34 INFO - PROCESS | 1934 | 10:53:35 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:53:36 INFO - PROCESS | 1934 | RSS: Main: 245575680 10:53:36 INFO - PROCESS | 1934 | 10:53:38 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:53:39 INFO - PROCESS | 1934 | RSS: Main: 255909888 10:53:39 INFO - PROCESS | 1934 | 10:53:42 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:53:42 INFO - PROCESS | 1934 | RSS: Main: 266354688 10:53:42 INFO - PROCESS | 1934 | 10:53:45 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:53:46 INFO - PROCESS | 1934 | RSS: Main: 260509696 10:53:46 INFO - PROCESS | 1934 | 10:53:47 INFO - PROCESS | 1934 | Cycle 1(1): loaded http://localhost:49527/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49527/tests/kraken/driver.html?testName=ai-astar) 10:53:48 INFO - PROCESS | 1934 | RSS: Main: 304685056 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | __start_tp_report 10:53:48 INFO - PROCESS | 1934 | _x_x_mozilla_page_load 10:53:48 INFO - PROCESS | 1934 | _x_x_mozilla_page_load_details 10:53:48 INFO - PROCESS | 1934 | |i|pagename|runs| 10:53:48 INFO - PROCESS | 1934 | |0;ai-astar;113;114;113;112;112;113;112;112;107;106 10:53:48 INFO - PROCESS | 1934 | |1;audio-beat-detection;144;108;111;141;106;126;133;136;167;107 10:53:48 INFO - PROCESS | 1934 | |2;audio-dft;183;182;181;183;184;184;182;181;181;183 10:53:48 INFO - PROCESS | 1934 | |3;audio-fft;81;58;76;111;54;52;74;80;105;80 10:53:48 INFO - PROCESS | 1934 | |4;audio-oscillator;85;69;93;91;97;98;99;67;67;90 10:53:48 INFO - PROCESS | 1934 | |5;imaging-gaussian-blur;88;85;88;86;104;126;123;85;88;84 10:53:48 INFO - PROCESS | 1934 | |6;imaging-darkroom;93;93;94;94;92;92;93;94;93;93 10:53:48 INFO - PROCESS | 1934 | |7;imaging-desaturate;86;86;86;85;84;85;83;80;89;87 10:53:48 INFO - PROCESS | 1934 | |8;json-parse-financial;52;52;56;54;57;57;57;56;57;57 10:53:48 INFO - PROCESS | 1934 | |9;json-stringify-tinderbox;62;68;67;75;70;67;69;69;69;69 10:53:48 INFO - PROCESS | 1934 | |10;stanford-crypto-aes;83;82;84;80;84;83;97;99;87;87 10:53:48 INFO - PROCESS | 1934 | |11;stanford-crypto-ccm;133;135;134;134;133;131;142;144;196;161 10:53:48 INFO - PROCESS | 1934 | |12;stanford-crypto-pbkdf2;201;158;160;159;161;162;163;165;160;159 10:53:48 INFO - PROCESS | 1934 | |13;stanford-crypto-sha256-iterative;65;67;65;65;65;66;64;66;65;66 10:53:48 INFO - PROCESS | 1934 | __end_tp_report 10:53:48 INFO - PROCESS | 1934 | __start_cc_report 10:53:48 INFO - PROCESS | 1934 | _x_x_mozilla_cycle_collect,1930 10:53:48 INFO - PROCESS | 1934 | __end_cc_report 10:53:48 INFO - PROCESS | 1934 | __startTimestamp1480532028212__endTimestamp 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | ------- Summary: start ------- 10:53:48 INFO - PROCESS | 1934 | Number of tests: 14 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:2.67 (2.4%) stddev-sans-first:2.77 10:53:48 INFO - PROCESS | 1934 | Values: 113.0 114.0 113.0 112.0 112.0 113.0 112.0 112.0 107.0 106.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#1] audio-beat-detection Cycles:10 Average:127.90 Median:134.50 stddev:20.15 (15.0%) stddev-sans-first:20.51 10:53:48 INFO - PROCESS | 1934 | Values: 144.0 108.0 111.0 141.0 106.0 126.0 133.0 136.0 167.0 107.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.00 stddev:1.17 (0.6%) stddev-sans-first:1.22 10:53:48 INFO - PROCESS | 1934 | Values: 183.0 182.0 181.0 183.0 184.0 184.0 182.0 181.0 181.0 183.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#3] audio-fft Cycles:10 Average:77.10 Median:75.00 stddev:19.72 (26.3%) stddev-sans-first:20.86 10:53:48 INFO - PROCESS | 1934 | Values: 81.0 58.0 76.0 111.0 54.0 52.0 74.0 80.0 105.0 80.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#4] audio-oscillator Cycles:10 Average:85.60 Median:92.00 stddev:13.06 (14.2%) stddev-sans-first:13.85 10:53:48 INFO - PROCESS | 1934 | Values: 85.0 69.0 93.0 91.0 97.0 98.0 99.0 67.0 67.0 90.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:85.50 stddev:16.23 (19.0%) stddev-sans-first:16.97 10:53:48 INFO - PROCESS | 1934 | Values: 88.0 85.0 88.0 86.0 104.0 126.0 123.0 85.0 88.0 84.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 10:53:48 INFO - PROCESS | 1934 | Values: 93.0 93.0 94.0 94.0 92.0 92.0 93.0 94.0 93.0 93.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:86.00 stddev:2.42 (2.8%) stddev-sans-first:2.55 10:53:48 INFO - PROCESS | 1934 | Values: 86.0 86.0 86.0 85.0 84.0 85.0 83.0 80.0 89.0 87.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:57.00 stddev:2.07 (3.6%) stddev-sans-first:1.76 10:53:48 INFO - PROCESS | 1934 | Values: 52.0 52.0 56.0 54.0 57.0 57.0 57.0 56.0 57.0 57.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:3.21 (4.6%) stddev-sans-first:2.39 10:53:48 INFO - PROCESS | 1934 | Values: 62.0 68.0 67.0 75.0 70.0 67.0 69.0 69.0 69.0 69.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.50 stddev:6.38 (7.5%) stddev-sans-first:6.63 10:53:48 INFO - PROCESS | 1934 | Values: 83.0 82.0 84.0 80.0 84.0 83.0 97.0 99.0 87.0 87.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#11] stanford-crypto-ccm Cycles:10 Average:144.30 Median:138.50 stddev:20.24 (14.6%) stddev-sans-first:21.05 10:53:48 INFO - PROCESS | 1934 | Values: 133.0 135.0 134.0 134.0 133.0 131.0 142.0 144.0 196.0 161.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:161.50 stddev:12.89 (8.0%) stddev-sans-first:2.22 10:53:48 INFO - PROCESS | 1934 | Values: 201.0 158.0 160.0 159.0 161.0 162.0 163.0 165.0 160.0 159.0 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - PROCESS | 1934 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:65.50 stddev:0.84 (1.3%) stddev-sans-first:0.88 10:53:48 INFO - PROCESS | 1934 | Values: 65.0 67.0 65.0 65.0 65.0 66.0 64.0 66.0 65.0 66.0 10:53:48 INFO - PROCESS | 1934 | -------- Summary: end -------- 10:53:48 INFO - PROCESS | 1934 | 10:53:48 INFO - TEST-INFO | 1934: exit 0 10:53:49 INFO - TEST-OK | kraken | took 58087ms 10:53:49 INFO - SUITE-END | took 1172s 10:53:49 INFO - Completed test suite (00:19:33) 10:53:49 INFO - javascript benchmark 10:53:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3430.0395889151036, 3440.2603440260345, 3466.8786592469255, 3477.0, 3502.1419752160723, 5754.625949313292, 5809.6804675742815, 5847.327557330908, 5849.853753656161, 5850.678212698305, 5798.565107616935, 5895.322037965635, 5897.823065308047, 5902.881942361161, 5909.143174239733, 5253.159494480884, 5286.735663216843, 5341.439148889369, 5353.411124776291, 5373.194020896877, 5257.395399529046, 5265.473452654723, 5275.577953763709, 5395.10980688186, 5400.378956420003, 5255.0803609368395, 5284.207368894658, 5286.101362768339, 5323.307969963899, 5331.253624492574, 5308.336457942757, 5355.598330125217, 5372.435894231088, 5377.435369286247, 5379.058664733695, 5158.974205128988, 5230.476952304777, 5280.81517146898, 5311.362636483646, 5331.360236771612, 5727.942720572824, 5747.626404283708, 5768.855778605526, 5789.594728369016, 5806.129080637896, 6261.686915654199, 6284.151639528696, 6349.269833969107, 6372.553921225516, 6373.936260637381, 6255.655938923357, 6315.842103947392, 6321.936780632181, 6324.557280990332, 6326.588771729823, 5827.679477628729, 5879.265091863517, 5908.291005079418, 5942.138389933435, 5958.0, 6335.04038014238, 6355.841103972345, 6358.650274234869, 6359.268684101295, 6362.968185159045, 6301.054841773771, 6308.495320374359, 6319.905201421982, 6320.051992201206, 6324.146240257598, 6220.688965551704, 6275.843103922347, 6278.183836101369, 6331.525135614847, 6335.986242201226, 6292.528060395397, 6305.306416294204, 6314.905276420765, 6346.555741098171, 6349.682515874188, 6309.716062777186, 6350.0792385103905, 6353.3329000455215, 6363.96818015907, 6386.552941294158, 4945.8516244512, 4999.600031997432, 5012.8496145115705, 5048.72232027242, 5071.4928507149725, 4532.184206842734, 4567.3377360282575, 4581.816727330936, 4596.8161273548685, 4650.953490465052, 6034.125051867454, 6051.727672254759, 6057.0, 6062.9996050652035, 6067.908981365283, 6249.1563638908165, 6278.0269058296035, 6287.685615719196, 6313.242410910629, 6335.873282534323, 5856.795012174553, 5926.851828704317, 5964.522838172936, 5985.922533943932, 6025.307089684742, 5551.361593416808, 5558.722063896789, 5566.944330556643, 5571.220029195916, 5584.274044374205, 6379.5215358847345, 6410.423061924449, 6418.775342862978, 6427.517936154713, 6430.164078669836, 6228.750849965951, 6235.532335074797, 6281.4660753834605, 6324.462420694109, 6324.778632747832, 6322.49420046386, 6341.4292713656, 6347.809565713036, 6350.460210881942, 6370.235571731237, 6296.811095667137, 6302.464290535356, 6305.5270854687, 6314.400131987454, 6321.367863213642, 6234.345393733593, 6239.844003899939, 6307.3377295383325, 6331.145295385064, 6346.650934198663, 6140.232470941132, 6187.783427580013, 6301.779437719658, 6326.398992095744, 6328.303886572381, 6278.748850045947, 6293.685315734287, 6295.779647712308, 6296.0555916612875, 6300.243970723543, 5770.5095066919785, 5986.970065149646, 6042.516598672008, 6148.631082135086, 6178.505719542336, 6117.712680657782, 6146.354632763674, 6151.784687535915, 6248.218972628421, 6253.749850006131, 6102.938970610415, 6108.267007959073, 6122.969385153046, 6124.448799608057, 6128.356522565245], "value": 5827.666705184993, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [487.33089169594143, 517.2474050256876, 539.7382269599244, 546.6037123085766, 560.3164139749504, 41868.790656046716, 43422.56577434225, 43642.90892727683, 44954.87612809682, 45043.09913801722, 44005.77997110018, 44566.0, 44577.8855528612, 44629.0, 44635.214591416385, 9328.300377471684, 10040.447775372351, 10228.87482376938, 10245.231607629421, 10265.64070257541, 9392.90607093927, 12328.630141095737, 12509.499620015235, 12567.43446544903, 12582.496700131984, 12345.259284442916, 12403.0, 12408.689782755459, 12408.813867791945, 12413.069019823504, 12503.312317822516, 12589.055820813475, 12601.873981260162, 12623.873761262454, 12632.368381580884, 12266.81599776004, 12313.261204327679, 12321.630351089481, 12328.952039076688, 12332.136750427473, 42557.0, 42757.358639620434, 42765.93085172865, 42905.35641965373, 42969.785151074044, 3538.327717733648, 3675.3016926783826, 3676.3382591133586, 3735.589085200626, 4409.140217657558, 33071.50392744111, 33633.0, 33711.32577348464, 33839.0, 34117.48823767646, 3364.764466487347, 3370.679785420381, 3390.593128824557, 3411.573553305837, 3456.844442000116, 506136.0, 514659.0, 517458.0, 517588.0, 519315.0, 69787.95318070233, 71144.64427677932, 71166.0, 71227.6438617814, 71265.64367178235, 37517.62482375196, 38162.23675526474, 38177.0, 39263.0, 39272.80363598164, 15331.770023449657, 18347.0, 18356.541086472676, 18370.35703750362, 18383.0, 12592.733308004465, 12780.297083660302, 12820.935895320463, 13683.384247708877, 13854.03021788465, 18901.43295701131, 19039.90480047591, 20702.0, 21449.0, 21463.89268053681, 7569.735059272899, 8822.955885220661, 8980.955095224483, 8986.955065224764, 9046.592903319366, 917.7934964633038, 991.9008099190023, 1045.7346610601257, 1051.2483574244452, 1129.1418521923397, 26493.86753066261, 27197.45605087887, 30857.0, 31385.215369615944, 31879.043628691175, 938.4369378373058, 1050.7478205230843, 1108.2002866887417, 1116.564539829451, 1200.771853347861, 12855.742885142432, 14714.779278310834, 15200.08799472013, 15634.9218253908, 15900.92049539768, 690803.0, 699752.0, 700099.0, 700890.0, 701608.0, 61057.69471152616, 61820.072698908654, 61823.072653910225, 61899.38100619026, 62124.68937655373, 1308.476609356265, 1327.853936067051, 1426.5149849051372, 1458.4239225506078, 1459.1901494670346, 32071.83964080258, 32122.35755284928, 32798.836005820776, 33037.33925321432, 33787.4931876027, 52063.73968130135, 52662.0, 52777.0, 52875.73562132165, 52910.73544632252, 551416.0, 553885.0, 554505.2274738762, 554880.0, 555888.0, 25626.359341016625, 25951.610725839506, 28786.856065719538, 29201.0, 29368.26579335534, 46791.76604117094, 49217.26174107463, 49245.26132108093, 49468.0, 49799.253011204135, 39372.86584908658, 40441.39337909993, 40691.98270043272, 42052.5281615142, 42160.78919605505, 40320.19359612733, 40615.79692101521, 40903.0, 42151.946201343984, 42204.57795422129, 39302.80348598239, 39747.60252397439, 40213.0, 40320.99197520086, 40643.79678101709, 33770.83114584412, 34956.82521587376, 35663.82168089143, 35758.28483430265, 35815.64184358227, 26187.73812261853, 26474.338141546614, 26547.203583892515, 26670.733292666824, 26977.0], "value": 21258.999124802638, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.34830787660974, 386.574246602569, 387.8913904106851, 393.4000649010259, 413.35103886897565, 15317.92341038296, 21013.789862101374, 21338.46653833655, 22098.889505552488, 22221.333359999207, 16644.500664980038, 19824.801751982475, 20752.0, 20937.16251349948, 21476.0, 5217.530422261995, 6364.172657554512, 6365.331640177784, 6378.553501254914, 6379.744810207586, 6012.7294271757655, 6242.812715618516, 6259.62442253464, 6307.905381419282, 6330.461910737593, 6269.435750782452, 6270.811875643715, 6279.120923070774, 6283.497320214372, 6286.3399343069, 6009.489193418564, 6210.62736235825, 6288.496920246369, 6303.086052522382, 6317.715702793385, 5545.0, 5545.972270138664, 5555.694436805974, 5558.471945165203, 7644.770656880247, 29213.561796573067, 29768.851155744083, 30118.698813012026, 30694.9256776014, 30822.38355232883, 2343.7773411525877, 2461.3477428481465, 2488.228649118779, 2539.949201015988, 2569.601711734684, 16666.0, 17619.0, 17866.464006079837, 18391.448256552325, 18796.060196990096, 2118.364490652798, 2193.462601662587, 2212.1704360864674, 2229.687843701883, 2291.7937385635205, 139191.0, 143108.0, 150145.0, 155103.0, 158838.41161588352, 18382.0, 21793.891030545063, 22189.778102219094, 22279.10883564639, 22653.773462265166, 37523.37336386481, 37554.061148471505, 37849.0, 38196.0, 38320.42519362212, 10186.337888037255, 10656.78686426267, 10723.0, 11143.888561114447, 11220.66338009861, 9440.24478041755, 9527.904720952702, 9645.228381729445, 9760.170385517311, 9818.705438836847, 8228.21831925966, 10200.897991019994, 10274.020534045043, 10276.22928280367, 10296.948515257376, 3158.562853901469, 3836.3478208704587, 3842.2709780598843, 3893.707971902062, 3936.6063393660406, 821.5481485183126, 895.5880295064213, 964.9855252171224, 970.1559643110539, 1022.2026819081128, 18272.543186420447, 21392.572148557254, 22461.88769056144, 22591.548169036527, 22639.547209056054, 941.5857022909897, 964.5900492290748, 974.3812678948918, 984.2175470500969, 1039.6621098143135, 11395.772084558263, 11777.900185099863, 11845.644630661094, 11926.940365298291, 12000.939995299968, 543886.0, 546492.0, 551729.0, 636759.0, 670058.0, 120771.0, 154945.0, 155286.0, 157472.21263893606, 158378.20810896103, 998.1366118307611, 1029.7580068683853, 1047.245982892301, 1047.6542740895486, 1048.2766890845292, 17776.288948441917, 19144.521386965436, 19369.225230991167, 20123.899380503004, 20382.898085509478, 54870.90258194893, 59101.70449147727, 59931.8013639716, 60963.47591310253, 61012.0, 77245.0, 82956.0, 83181.58409207915, 83620.16379836368, 85637.57181214304, 6342.7780027700655, 7608.8478230436185, 7697.307242348215, 7758.224177582197, 8304.252617264476, 11125.388103654377, 13367.131136476099, 13459.259740714355, 13798.103123296954, 13998.580042598738, 5499.725013749377, 8289.709860154866, 8895.398828210984, 11916.52333906634, 12010.519579216734, 9609.894862090949, 9941.701748947544, 10885.836712449478, 11659.06727461784, 11997.340146292037, 11248.437578121226, 11512.136589755635, 11656.18406711522, 11817.113716471127, 12142.150049496451, 6991.510594258557, 7461.515001524884, 7511.549307041595, 7552.509086909334, 7903.288704016666, 10204.897951020395, 10481.109105726098, 10630.043296103388, 11033.007029367396, 11198.776024479628], "value": 11053.063372882587, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.0868207370393, 1568.0278227498948, 1775.9289628414856, 1930.9034548272582, 1941.155597315168, 8784.209421152103, 9325.81348373032, 9335.253179745621, 9353.298502612315, 9394.71815845524, 7367.18960914299, 8086.514809111457, 8353.624086916088, 8364.2472177504, 8460.407771456, 2385.976140238597, 2473.925782226527, 2475.183189547454, 2480.1691433369842, 2484.962725559118, 2148.806607405333, 2453.619688948207, 2460.052879641342, 2489.4192187960593, 2490.638857365681, 2457.533068716947, 2464.0636558107894, 2474.7648973347505, 2476.6780318558654, 2493.1523282084086, 2439.9512009759706, 2452.104981681682, 2461.938451538708, 2466.5066986602574, 2477.2196758021164, 2433.0, 2447.192426499251, 2453.472503411775, 2456.754324567547, 2459.7909177719916, 9057.909420905773, 9264.72205833826, 9274.48990305533, 9277.860832087525, 9278.443293402417, 5466.562674985991, 5635.295588051494, 5635.690037047961, 5635.887282254373, 5647.152927060933, 3665.102049997741, 3719.423489359154, 3782.9810850945846, 3796.8101594920145, 3801.4297855321925, 1117.7764447110528, 1122.3714719756963, 1137.9886201137965, 1151.6314779270638, 1865.533616595851, 11869.94065029678, 12167.574134905324, 12195.512179512898, 12203.755924881541, 12213.0, 3727.5340582427198, 4701.294805779161, 4777.713337199779, 4792.041591681677, 4794.400699912511, 9406.858897116548, 9408.870935487785, 9433.716988490356, 9446.527673616429, 9465.337426380225, 5457.263269458652, 5462.918056229159, 5465.152901300305, 5471.753771080311, 5474.2609747683555, 4631.861044168681, 4704.0, 4990.90018199634, 5114.232865070195, 5132.820351287762, 3899.454076429302, 3910.511186101737, 3982.5220973482787, 4017.5178978522763, 4027.617376349242, 1032.863849765252, 1205.8552973643218, 1209.836672049262, 1221.6579357779835, 1221.9389030548436, 816.432579357341, 874.3049275825733, 929.484136304344, 942.34036174678, 943.6555657185078, 5642.971785141048, 5813.7383817728305, 5833.854153646193, 6084.787032453932, 6152.107944348045, 450.73181457033013, 455.8677983384781, 464.9070185962821, 470.4589721819866, 472.02291257098165, 3822.27376798413, 4001.959980400217, 4041.9191616167514, 4062.8171732272117, 4084.223997440536, 10790.838137427945, 10912.0, 11263.155263355116, 11275.718107047225, 11279.548818047351, 9719.659811906691, 11086.33481991067, 11331.943340283246, 11339.092872570174, 11352.602658907064, 7041.471889608198, 8426.620802063799, 8449.0, 8575.571221439028, 8634.697785577475, 5821.854453638523, 5910.438508341701, 5933.584649074523, 6055.364186760503, 6086.573939824169, 10391.48042597852, 10434.739131521468, 10480.266381353233, 10500.527476263434, 10595.15238780911, 8128.75613731589, 10443.425611591436, 10452.372857628567, 10486.737831554272, 10593.523291452057, 7121.216666166821, 7326.267373262845, 7726.845463090819, 7900.4074694397, 8051.677932882619, 8374.958125209336, 8614.267787238156, 8752.824943501222, 8773.210411063035, 8789.296856251613, 6786.660666966533, 7668.731594394169, 7689.231076892266, 7789.260020298063, 7807.102183248999, 7154.678039488132, 7171.99592057102, 7560.432967527568, 7677.117131529945, 7759.961200193963, 7024.964875175591, 7200.7479738211005, 7201.279872012757, 7201.747938822116, 7203.531770434905, 5054.469280725618, 5084.288199651977, 5093.580549239082, 5208.8437346879655, 5259.684418934876, 5181.55956743666, 5206.245094461357, 5211.296474975829, 5213.582913366998, 5294.417614062373], "value": 4617.833353621072, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [271.7729451526359, 276.29269071177794, 298.4955425331191, 319.4999825273447, 325.60601671976906, 4410.75740834254, 4726.929096063562, 4846.8125309299185, 5125.718085505296, 5151.871203219916, 4597.678162528624, 5079.949200508003, 5199.168133098705, 5241.633085684004, 5294.841154765363, 4035.939460908096, 4074.775887326196, 4078.4290199372113, 4110.07523307255, 4132.421460995463, 3836.7889766062854, 4048.0702104318457, 4088.632023117919, 4090.5909409059004, 4100.610442008005, 3569.696575791048, 3713.1459764254237, 3966.0877998060464, 4069.532003819569, 4081.3877918312196, 3954.228925359556, 4060.7360521566, 4063.674906007512, 4075.368317910714, 4084.8978775530554, 3396.609389920166, 3578.8547664747293, 3581.803000834953, 3585.910352241189, 3587.282543491312, 5042.520960508746, 5049.5455409013, 5121.923171152435, 5165.431802501722, 5236.973815130938, 4651.3023046543285, 4651.720896746206, 4685.461171965234, 4709.62323014158, 4751.287306903958, 4750.64370172235, 5079.419009598261, 5472.91790623137, 5583.302087239095, 5589.301337332833, 3812.407562857256, 3907.6873850091924, 3933.5279766427925, 3996.080901392667, 4000.6999475039197, 4444.977775111169, 5078.898422031576, 5667.178259152441, 5673.120666296731, 5828.504577110951, 4043.2924238258774, 4051.108756073659, 4060.3706425504092, 4063.4514340564238, 4084.7957602119777, 3946.1515774108702, 4131.140986556062, 4133.491275684353, 4144.0, 4153.626173644387, 4650.558196971282, 4672.859814205579, 4683.625309975262, 4718.7168769873915, 4779.641526885428, 4719.976400117977, 5572.5263352614675, 5579.888402231933, 5580.91628625571, 5592.217089607459, 1310.6264714556305, 1327.396034804181, 1359.8844098251561, 1371.2869307960004, 1404.7848610951658, 701.9122609673791, 751.0611735330837, 781.1719577248135, 814.226484839405, 830.4436027861227, 3907.648311651965, 4176.310908700091, 4216.47294088239, 4305.569443055732, 4389.561043895649, 3936.3467343715706, 4772.49666355104, 4785.832495862628, 4800.007996681408, 4802.639802014863, 3699.8335074921692, 4123.969007748063, 4303.956499121534, 4344.370066340363, 4418.288637544478, 2222.0557012613963, 2300.252417964168, 2405.001924201437, 2490.912818051396, 2511.698596168435, 4683.929741053887, 4821.951780482221, 4826.95173048265, 4905.55849973497, 4940.603807153528, 4048.8541073231236, 4566.429196350457, 4636.026434448736, 4818.445878723992, 4864.391951006124, 4127.277726397929, 4278.4865816102265, 4632.911265852522, 4789.976050119727, 4845.618998585386, 4213.91572168561, 4408.382826404242, 4466.6873318867365, 4579.564941330568, 4616.584507394351, 4359.256297481033, 4633.328167415639, 4640.658725717478, 4657.9039432256295, 4693.530646935279, 3993.6206060424215, 4844.716150220124, 4877.731919613796, 4884.580793444532, 4912.238603016538, 2731.893583098848, 3413.8122403267066, 3451.049352803417, 3465.878694245689, 3468.8439020243645, 4476.768888555543, 4607.654425918003, 4683.297505374221, 4709.116353458507, 4717.654754355386, 3860.9034774130873, 4513.774311284488, 4590.724556526619, 4615.630749540096, 4618.9076218474775, 3618.764780289273, 3958.9406158907063, 4134.4831896013, 4459.955400445954, 4553.567411095941, 4299.914001720011, 4493.977530112328, 4548.88627784308, 5161.741912904415, 5393.352797664305, 5183.356488190974, 5398.0, 5638.915416268677, 5641.238432811518, 5651.8304450866535, 5516.310461192351, 5519.420460851553, 5546.306711661043, 5556.638818476786, 5559.33288005442], "value": 3780.7445455468182, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.5046589359141, 712.162034293341, 766.6971546239239, 819.5697258939056, 862.5988915154454, 16155.75766363504, 17236.56908577283, 17263.309467621297, 17265.13674316284, 17292.48122556322, 15508.379664813423, 15539.456119035836, 15562.0, 15585.610359740984, 15654.139022353766, 730.1639622632083, 749.3705287558449, 865.9653613855454, 878.1789027259501, 907.6188001039579, 891.6789955615973, 906.2161230535605, 908.1780988205685, 908.3142227618139, 909.231699214163, 972.4943029624591, 973.732223638498, 973.8344481438137, 973.8490533967247, 974.3471873844542, 967.5500892085144, 967.641972470187, 970.2286682087687, 970.6651205334149, 971.4511301114883, 716.5091912040269, 717.121526130486, 717.9820504487429, 718.4503854551273, 719.2232389019846, 15852.0, 15893.966892151973, 15901.20493975308, 15905.125218112998, 15922.203889805463, 13621.387037583234, 13636.386362613706, 13950.860491395058, 14079.043400885826, 14230.715385692332, 12861.421236044307, 13019.739605207842, 13334.666633334147, 13501.729965400637, 13711.108777929403, 4825.806967721287, 4834.0, 4888.046830867982, 4965.106280869442, 4998.700077995332, 102871.0, 121097.78902210866, 121537.39231303876, 125309.0, 130879.0, 10657.520411581498, 11200.831987520194, 11283.153763467773, 11523.76952460946, 11737.471813768401, 22195.778042219372, 22207.66688499674, 22218.00018999149, 22262.55474890493, 22264.22075227359, 8207.753767386988, 8258.504489730636, 8269.586520673942, 8277.503349799032, 8354.081051084377, 4547.567981041796, 4655.534446555317, 4676.579107880307, 4683.882902927454, 4790.449098353664, 3597.8201089945396, 3698.6116457771545, 3699.500567423417, 3700.7224458165747, 3702.1114932416026, 669.5313280703527, 674.8211723893172, 675.3516624040976, 675.5136301862651, 676.922153952292, 642.7557528139371, 645.8094862015716, 651.9902201466982, 655.6623338980429, 681.3459079283942, 8206.507609543447, 8936.731898043068, 9550.37922535033, 9630.036996300454, 9737.123658870736, 512.3518748782793, 571.7884382778399, 640.9807705768834, 647.5887811239802, 669.7053296549502, 3990.68074554035, 4428.202923473806, 4659.534046595381, 4672.0, 4721.008588196449, 120613.0, 132527.0, 170782.0, 173722.13138934225, 179641.1017944928, 111292.44353778342, 113891.0, 116538.41730791293, 131686.34156829154, 147372.0, 95091.52454237685, 110381.0, 111704.0, 111869.0, 117819.46541603765, 9769.2673049523, 10093.394396336244, 10098.141657959155, 10176.949115254376, 10214.233932455245, 62153.06770398538, 62814.68592657008, 63563.0, 65340.67329663321, 66217.38500072554, 88347.55826220827, 93480.59779103455, 102017.0, 102246.48876755568, 103563.48218259162, 13234.867651323364, 13463.057585968889, 13755.79366309486, 13790.0, 13830.515931942333, 15264.618384540032, 15315.909869051264, 15482.5355239343, 15617.921910390829, 16575.83424165791, 14001.579952601438, 14108.78836817428, 14848.40606375733, 15025.699486010437, 15098.094114353175, 14080.788788168391, 14747.92626036863, 14776.704465910407, 14934.402623894923, 15217.239138043275, 14262.358193881508, 14310.49913253031, 14310.49913253031, 14337.856621433652, 14345.354459049158, 11620.0, 12083.093767967262, 12134.817977730518, 12205.450754715881, 12273.263604183421, 11711.531538738354, 11990.700232494257, 12106.515739370327, 12209.755804884031, 12267.57063502773], "value": 8231.581990385806, "unit": "score"}], "name": "dromaeo_css", "value": 7626.8561379199045, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 113.0, 112.0, 112.0, 113.0, 112.0, 112.0, 107.0, 106.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 108.0, 111.0, 141.0, 106.0, 126.0, 133.0, 136.0, 167.0, 107.0], "value": 127.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 181.0, 183.0, 184.0, 184.0, 182.0, 181.0, 181.0, 183.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 76.0, 111.0, 54.0, 52.0, 74.0, 80.0, 105.0, 80.0], "value": 77.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 93.0, 91.0, 97.0, 98.0, 99.0, 67.0, 67.0, 90.0], "value": 85.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 104.0, 126.0, 123.0, 85.0, 88.0, 84.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 92.0, 92.0, 93.0, 94.0, 93.0, 93.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 84.0, 85.0, 83.0, 80.0, 89.0, 87.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 56.0, 54.0, 57.0, 57.0, 57.0, 56.0, 57.0, 57.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 68.0, 67.0, 75.0, 70.0, 67.0, 69.0, 69.0, 69.0, 69.0], "value": 68.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 84.0, 80.0, 84.0, 83.0, 97.0, 99.0, 87.0, 87.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 135.0, 134.0, 134.0, 133.0, 131.0, 142.0, 144.0, 196.0, 161.0], "value": 144.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [201.0, 158.0, 160.0, 159.0, 161.0, 162.0, 163.0, 165.0, 160.0, 159.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 65.0, 65.0, 65.0, 66.0, 64.0, 66.0, 65.0, 66.0], "value": 65.4, "unit": "score"}], "name": "kraken", "value": 1443.4, "alertThreshold": 2.0}]} 10:53:49 INFO - Return code: 0 10:53:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:53:49 INFO - # TBPL SUCCESS # 10:53:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:53:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:53:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:53:49 INFO - 2016-11-30 10:53:49.560 screenresolution[1938:15045] starting screenresolution argv=screenresolution get 10:53:49 INFO - 2016-11-30 10:53:49.563 screenresolution[1938:15045] Display 0: 1600x1200x32@60 10:53:49 INFO - 2016-11-30 10:53:49.569 screenresolution[1939:15048] starting screenresolution argv=screenresolution list 10:53:49 INFO - Available Modes on Display 0 10:53:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:53:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:53:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:53:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:53:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:53:49 INFO - Intel Iris: 10:53:49 INFO - Chipset Model: Intel Iris 10:53:49 INFO - Type: GPU 10:53:49 INFO - Bus: Built-In 10:53:49 INFO - VRAM (Dynamic, Max): 1536 MB 10:53:49 INFO - Vendor: Intel (0x8086) 10:53:49 INFO - Device ID: 0x0a2e 10:53:49 INFO - Revision ID: 0x0009 10:53:49 INFO - Displays: 10:53:49 INFO - Display: 10:53:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:53:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:53:49 INFO - Display Serial Number: 1600x1200 60 10:53:49 INFO - Main Display: Yes 10:53:49 INFO - Mirror: Off 10:53:49 INFO - Online: Yes 10:53:49 INFO - Rotation: Supported 10:53:49 INFO - Return code: 0 10:53:49 INFO - Running post-action listener: _resource_record_post_action 10:53:49 INFO - [mozharness: 2016-11-30 18:53:49.805271Z] Finished run-tests step (success) 10:53:49 INFO - Running post-run listener: _resource_record_post_run 10:53:49 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 1048576; Write bytes: 494297088; Read time: 12; Write time: 1554 10:53:49 INFO - TinderboxPrint: CPU usage
53.4% 10:53:49 INFO - TinderboxPrint: I/O read bytes / time
1,048,576 / 12 10:53:49 INFO - TinderboxPrint: I/O write bytes / time
494,297,088 / 1,554 10:53:49 INFO - TinderboxPrint: CPU idle
2,229.8 (46.6%) 10:53:49 INFO - TinderboxPrint: CPU system
953.8 (19.9%) 10:53:49 INFO - TinderboxPrint: CPU user
1,602.2 (33.5%) 10:53:49 INFO - TinderboxPrint: Swap in / out
196,718,592 / 0 10:53:49 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192162304; Write bytes: 187774976; Read time: 17818; Write time: 408 10:53:49 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 1048576; Write bytes: 295237632; Read time: 12; Write time: 1107 10:53:50 INFO - Running post-run listener: _upload_blobber_files 10:53:50 INFO - Blob upload gear active. 10:53:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:53:50 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 10:53:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:53:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:53:50 INFO - (blobuploader) - INFO - Open directory for files ... 10:53:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:53:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:53:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:53 INFO - (blobuploader) - INFO - Done attempting. 10:53:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:53:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:53:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:54 INFO - (blobuploader) - INFO - Done attempting. 10:53:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:53:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:53:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:53:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:53:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:53:56 INFO - (blobuploader) - INFO - Done attempting. 10:53:56 INFO - (blobuploader) - INFO - Iteration through files over. 10:53:56 INFO - Return code: 0 10:53:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:53:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:53:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12e210fff3d4c3d9a0feca967194fcc2b49e4946ab510fb953d89dde2930c7bbb4a70617da89cc9f99c3e34d43a7e4ee24d9c9b09ec66868afdcb753fbf2057a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f212781a551045ce68fcc0fc6cb9ed451ce1151d880c7b0597e9c4c4eb3cda09556500ac2476297a670aa9dc1bad3ab4ef3348ded6e92c9190815db01c353587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc7203efa499394181f935346de972df8e04dca2f0727bd80f571ebb2f38ae12f0553b9c63001f072a63b73de59380cb79406f4b1d8269c21767d2a3a0f717ed"} 10:53:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:53:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:53:56 INFO - Contents: 10:53:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12e210fff3d4c3d9a0feca967194fcc2b49e4946ab510fb953d89dde2930c7bbb4a70617da89cc9f99c3e34d43a7e4ee24d9c9b09ec66868afdcb753fbf2057a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f212781a551045ce68fcc0fc6cb9ed451ce1151d880c7b0597e9c4c4eb3cda09556500ac2476297a670aa9dc1bad3ab4ef3348ded6e92c9190815db01c353587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc7203efa499394181f935346de972df8e04dca2f0727bd80f571ebb2f38ae12f0553b9c63001f072a63b73de59380cb79406f4b1d8269c21767d2a3a0f717ed"} 10:53:56 INFO - Running post-run listener: copy_logs_to_upload_dir 10:53:56 INFO - Copying logs to upload dir... 10:53:56 INFO - mkdir: /builds/slave/test/build/upload/logs 10:53:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.430034 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-30 10:53:56.796048) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 10:53:56.799088) ========= 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.GsBzBShx1r/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.tcvZNZAyAI/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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-Beta/sha512/12e210fff3d4c3d9a0feca967194fcc2b49e4946ab510fb953d89dde2930c7bbb4a70617da89cc9f99c3e34d43a7e4ee24d9c9b09ec66868afdcb753fbf2057a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f212781a551045ce68fcc0fc6cb9ed451ce1151d880c7b0597e9c4c4eb3cda09556500ac2476297a670aa9dc1bad3ab4ef3348ded6e92c9190815db01c353587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc7203efa499394181f935346de972df8e04dca2f0727bd80f571ebb2f38ae12f0553b9c63001f072a63b73de59380cb79406f4b1d8269c21767d2a3a0f717ed"} build_url:https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011532 build_url: 'https://queue.taskcluster.net/v1/task/DcH_e5IURS21SLbhYe53Cg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/12e210fff3d4c3d9a0feca967194fcc2b49e4946ab510fb953d89dde2930c7bbb4a70617da89cc9f99c3e34d43a7e4ee24d9c9b09ec66868afdcb753fbf2057a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f212781a551045ce68fcc0fc6cb9ed451ce1151d880c7b0597e9c4c4eb3cda09556500ac2476297a670aa9dc1bad3ab4ef3348ded6e92c9190815db01c353587", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/bc7203efa499394181f935346de972df8e04dca2f0727bd80f571ebb2f38ae12f0553b9c63001f072a63b73de59380cb79406f4b1d8269c21767d2a3a0f717ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 10:53:56.833906) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:53:56.834219) ========= 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.GsBzBShx1r/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.tcvZNZAyAI/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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.005318 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 10:53:56.882503) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 10:53:56.882817) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 10:53:56.883127) ========= ========= Total master_lag: 0.28 =========