builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0028 starttime: 1487612014.28 results: success (0) buildid: 20170220075356 builduid: fae64d779cf54cc6a6f1b5a6a4845479 revision: d57841320b5495f190734e16e3f5eb25a008379a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.279674) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.280126) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.280399) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.307591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.307993) ========= 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.cB4Psa6xuy/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.vct6OFjm9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 --2017-02-20 09:33:34-- 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% 21.5M=0.001s 2017-02-20 09:33:34 (21.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122851 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.455981) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.456293) ========= 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.cB4Psa6xuy/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.vct6OFjm9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.027322 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:34.505669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-20 09:33:34.506029) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d57841320b5495f190734e16e3f5eb25a008379a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev d57841320b5495f190734e16e3f5eb25a008379a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cB4Psa6xuy/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.vct6OFjm9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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 2017-02-20 09:33:34,608 truncating revision to first 12 chars 2017-02-20 09:33:34,609 Setting DEBUG logging. 2017-02-20 09:33:34,609 attempt 1/10 2017-02-20 09:33:34,609 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/d57841320b54?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-20 09:33:36,513 unpacking tar archive at: mozilla-aurora-d57841320b54/testing/mozharness/ program finished with exit code 0 elapsedTime=2.176015 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-20 09:33:36.706020) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:36.706359) ========= script_repo_revision: d57841320b5495f190734e16e3f5eb25a008379a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:36.706784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:36.707063) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-20 09:33:36.727749) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-20 09:33:36.728207) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cB4Psa6xuy/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.vct6OFjm9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:33:36 INFO - MultiFileLogger online at 20170220 09:33:36 in /builds/slave/test 09:33:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:33:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:33:36 INFO - {'append_to_log': False, 09:33:36 INFO - 'base_work_dir': '/builds/slave/test', 09:33:36 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:33:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:33:36 INFO - 'branch': 'Mozilla-Aurora', 09:33:36 INFO - 'buildbot_json_path': 'buildprops.json', 09:33:36 INFO - 'config_files': ('talos/mac_config.py',), 09:33:36 INFO - 'default_actions': ('clobber', 09:33:36 INFO - 'read-buildbot-config', 09:33:36 INFO - 'download-and-extract', 09:33:36 INFO - 'populate-webroot', 09:33:36 INFO - 'create-virtualenv', 09:33:36 INFO - 'install', 09:33:36 INFO - 'run-tests'), 09:33:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:33:36 INFO - 'download_minidump_stackwalk': True, 09:33:36 INFO - 'download_symbols': 'ondemand', 09:33:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:33:36 INFO - 'tooltool.py': '/tools/tooltool.py', 09:33:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:33:36 INFO - '/tools/misc-python/virtualenv.py')}, 09:33:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:33:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:33:36 INFO - 'installer_path': 'installer.exe', 09:33:36 INFO - 'log_level': 'info', 09:33:36 INFO - 'log_name': 'talos', 09:33:36 INFO - 'log_to_console': True, 09:33:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:33:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:33:36 INFO - 'opt_config_files': (), 09:33:36 INFO - 'pip_index': False, 09:33:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:36 INFO - 'cmd': ('bash', 09:33:36 INFO - '-c', 09:33:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:36 INFO - 'enabled': True, 09:33:36 INFO - 'halt_on_failure': False, 09:33:36 INFO - 'name': 'check_screen_resolution'},), 09:33:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:33:36 INFO - 'cmd': ('bash', 09:33:36 INFO - '-c', 09:33:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:33:36 INFO - 'enabled': True, 09:33:36 INFO - 'halt_on_failure': False, 09:33:36 INFO - 'name': 'check_screen_resolution'},), 09:33:36 INFO - 'run_cmd_checks_enabled': True, 09:33:36 INFO - 'sps_profile': False, 09:33:36 INFO - 'sps_profile_interval': 0, 09:33:36 INFO - 'suite': 'dromaeojs', 09:33:36 INFO - 'system_bits': '32', 09:33:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:33:36 INFO - 'title': 't-yosemite-r7-0028', 09:33:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:33:36 INFO - 'use_talos_json': True, 09:33:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:33:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:33:36 INFO - 'work_dir': 'build'} 09:33:36 INFO - [mozharness: 2017-02-20 17:33:36.945288Z] Running clobber step. 09:33:36 INFO - Running pre-action listener: _resource_record_pre_action 09:33:36 INFO - Running main action method: clobber 09:33:36 INFO - rmtree: /builds/slave/test/build 09:33:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:33:39 INFO - Running post-action listener: _resource_record_post_action 09:33:39 INFO - [mozharness: 2017-02-20 17:33:39.416008Z] Finished clobber step (success) 09:33:39 INFO - [mozharness: 2017-02-20 17:33:39.416180Z] Running read-buildbot-config step. 09:33:39 INFO - Running pre-action listener: _resource_record_pre_action 09:33:39 INFO - Running main action method: read_buildbot_config 09:33:39 INFO - Using buildbot properties: 09:33:39 INFO - { 09:33:39 INFO - "project": "", 09:33:39 INFO - "product": "firefox", 09:33:39 INFO - "script_repo_revision": "production", 09:33:39 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:33:39 INFO - "repository": "", 09:33:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:33:39 INFO - "buildid": "20170220075356", 09:33:39 INFO - "pgo_build": "False", 09:33:39 INFO - "basedir": "/builds/slave/test", 09:33:39 INFO - "buildnumber": 8, 09:33:39 INFO - "slavename": "t-yosemite-r7-0028", 09:33:39 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 09:33:39 INFO - "platform": "yosemite_r7", 09:33:39 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:33:39 INFO - "branch": "mozilla-aurora", 09:33:39 INFO - "repo_path": "releases/mozilla-aurora", 09:33:39 INFO - "revision": "d57841320b5495f190734e16e3f5eb25a008379a", 09:33:39 INFO - "stage_platform": "macosx64", 09:33:39 INFO - "builduid": "fae64d779cf54cc6a6f1b5a6a4845479", 09:33:39 INFO - "slavebuilddir": "test" 09:33:39 INFO - } 09:33:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:33:39 INFO - Running post-action listener: _resource_record_post_action 09:33:39 INFO - [mozharness: 2017-02-20 17:33:39.419396Z] Finished read-buildbot-config step (success) 09:33:39 INFO - [mozharness: 2017-02-20 17:33:39.419511Z] Running download-and-extract step. 09:33:39 INFO - Running pre-action listener: _resource_record_pre_action 09:33:39 INFO - Running main action method: download_and_extract 09:33:39 INFO - mkdir: /builds/slave/test/build/tests 09:33:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:39 INFO - trying https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:33:39 INFO - Downloading https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:33:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:33:40 INFO - Downloaded 1199 bytes. 09:33:40 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:33:40 INFO - Using the following test package requirements: 09:33:40 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:33:40 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:33:40 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:33:40 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'jsshell-mac.zip'], 09:33:40 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:33:40 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:33:40 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:33:40 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:33:40 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:33:40 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:33:40 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:33:40 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:33:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:33:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:33:40 INFO - Fetch https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:33:41 INFO - Expected file size: 16359151 09:33:41 INFO - Obtained file size: 16359151 09:33:48 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:33:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:33:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:33:48 INFO - Fetch https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:33:49 INFO - Expected file size: 16359151 09:33:49 INFO - Obtained file size: 16359151 09:33:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:33:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:33:55 INFO - Fetch https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:33:56 INFO - Expected file size: 14403485 09:33:56 INFO - Obtained file size: 14403485 09:33:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:57 INFO - trying https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:33:57 INFO - Downloading https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:33:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:33:59 INFO - Downloaded 73963666 bytes. 09:33:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:33:59 INFO - mkdir: /builds/slave/test/properties 09:33:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:33:59 INFO - Writing to file /builds/slave/test/properties/build_url 09:33:59 INFO - Contents: 09:33:59 INFO - build_url:https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:34:00 INFO - Running post-action listener: _resource_record_post_action 09:34:00 INFO - Running post-action listener: set_extra_try_arguments 09:34:00 INFO - [mozharness: 2017-02-20 17:34:00.071033Z] Finished download-and-extract step (success) 09:34:00 INFO - [mozharness: 2017-02-20 17:34:00.071204Z] Running populate-webroot step. 09:34:00 INFO - Running pre-action listener: _resource_record_pre_action 09:34:00 INFO - Running main action method: populate_webroot 09:34:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:34:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:34:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:34:00 INFO - '--tppagecycles', 09:34:00 INFO - '7'], 09:34:00 INFO - 'tests': ['tsvgm']}}, 09:34:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:34:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:34:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:34:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:34:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:34:00 INFO - 'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:34:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:34:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:34:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:34:00 INFO - 'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['damp', 'tps']}, 09:34:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:34:00 INFO - 'tests': ['damp', 'tps']}, 09:34:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['dromaeo_dom']}, 09:34:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:34:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['basic_compositor_video']}, 09:34:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:34:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['a11yr', 09:34:00 INFO - 'ts_paint', 09:34:00 INFO - 'tpaint', 09:34:00 INFO - 'sessionrestore', 09:34:00 INFO - 'sessionrestore_no_auto_restore', 09:34:00 INFO - 'tabpaint']}, 09:34:00 INFO - 'other-e10s': {'tests': ['a11yr', 09:34:00 INFO - 'ts_paint', 09:34:00 INFO - 'tpaint', 09:34:00 INFO - 'sessionrestore', 09:34:00 INFO - 'sessionrestore_no_auto_restore', 09:34:00 INFO - 'tabpaint']}, 09:34:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:34:00 INFO - 'ts_paint', 09:34:00 INFO - 'tpaint', 09:34:00 INFO - 'sessionrestore', 09:34:00 INFO - 'sessionrestore_no_auto_restore', 09:34:00 INFO - 'tabpaint']}, 09:34:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:34:00 INFO - 'ts_paint', 09:34:00 INFO - 'tpaint', 09:34:00 INFO - 'sessionrestore', 09:34:00 INFO - 'sessionrestore_no_auto_restore', 09:34:00 INFO - 'tabpaint']}, 09:34:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['a11yr', 09:34:00 INFO - 'ts_paint', 09:34:00 INFO - 'tpaint', 09:34:00 INFO - 'sessionrestore', 09:34:00 INFO - 'sessionrestore_no_auto_restore', 09:34:00 INFO - 'tabpaint']}, 09:34:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['a11yr', 09:34:00 INFO - 'ts_paint', 09:34:00 INFO - 'tpaint', 09:34:00 INFO - 'sessionrestore', 09:34:00 INFO - 'sessionrestore_no_auto_restore', 09:34:00 INFO - 'tabpaint']}, 09:34:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['tsvgx', 09:34:00 INFO - 'tsvgr_opacity', 09:34:00 INFO - 'tart', 09:34:00 INFO - 'tscrollx', 09:34:00 INFO - 'cart', 09:34:00 INFO - 'tsvg_static']}, 09:34:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:34:00 INFO - 'tsvgr_opacity', 09:34:00 INFO - 'tart', 09:34:00 INFO - 'tscrollx', 09:34:00 INFO - 'cart', 09:34:00 INFO - 'tsvg_static']}, 09:34:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:34:00 INFO - 'talos_options': ['--disable-e10s'], 09:34:00 INFO - 'tests': ['tp5o']}, 09:34:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:34:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:34:00 INFO - 'talos_options': ['--disable-e10s', 09:34:00 INFO - '--xperf_path', 09:34:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:34:00 INFO - 'tests': ['tp5n']}, 09:34:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:34:00 INFO - 'talos_options': ['--xperf_path', 09:34:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:34:00 INFO - 'tests': ['tp5n']}}, 09:34:00 INFO - 'talos.zip': {'path': '', 09:34:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:34:00 INFO - Running post-action listener: _resource_record_post_action 09:34:00 INFO - [mozharness: 2017-02-20 17:34:00.089895Z] Finished populate-webroot step (success) 09:34:00 INFO - [mozharness: 2017-02-20 17:34:00.090031Z] Running create-virtualenv step. 09:34:00 INFO - Running pre-action listener: _resource_record_pre_action 09:34:00 INFO - Running main action method: create_virtualenv 09:34:00 INFO - Creating virtualenv /builds/slave/test/build/venv 09:34:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:34:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:34:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:34:00 INFO - Using real prefix '/tools/python27' 09:34:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:34:00 INFO - Installing distribute.............................................................................................................................................................................................done. 09:34:03 INFO - Installing pip.................done. 09:34:03 INFO - Return code: 0 09:34:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:34:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:34:04 INFO - Reading from file tmpfile_stdout 09:34:04 INFO - Output received: 09:34:04 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:34:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:04 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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:34:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:04 INFO - 'HOME': '/Users/cltbld', 09:34:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:04 INFO - 'LOGNAME': 'cltbld', 09:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:04 INFO - 'MOZ_NO_REMOTE': '1', 09:34:04 INFO - 'NO_EM_RESTART': '1', 09:34:04 INFO - 'PAGER': '/bin/cat', 09:34:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:04 INFO - 'PWD': '/builds/slave/test', 09:34:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:04 INFO - 'SHELL': '/bin/bash', 09:34:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:04 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:04 INFO - 'USER': 'cltbld', 09:34:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:04 INFO - 'XPC_FLAGS': '0x0', 09:34:04 INFO - 'XPC_SERVICE_NAME': '0', 09:34:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:34:04 INFO - Cleaning up... 09:34:04 INFO - Return code: 0 09:34:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:04 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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:34:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:34:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:04 INFO - 'HOME': '/Users/cltbld', 09:34:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:04 INFO - 'LOGNAME': 'cltbld', 09:34:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:04 INFO - 'MOZ_NO_REMOTE': '1', 09:34:04 INFO - 'NO_EM_RESTART': '1', 09:34:04 INFO - 'PAGER': '/bin/cat', 09:34:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:04 INFO - 'PWD': '/builds/slave/test', 09:34:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:04 INFO - 'SHELL': '/bin/bash', 09:34:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:04 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:04 INFO - 'USER': 'cltbld', 09:34:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:04 INFO - 'XPC_FLAGS': '0x0', 09:34:04 INFO - 'XPC_SERVICE_NAME': '0', 09:34:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:04 INFO - Downloading/unpacking psutil>=3.1.1 09:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:34:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:34:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:34:08 INFO - Installing collected packages: psutil 09:34:08 INFO - Running setup.py install for psutil 09:34:08 INFO - building 'psutil._psutil_osx' extension 09:34:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:34:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:34:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:34:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:34:08 INFO - building 'psutil._psutil_posix' extension 09:34:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:34:09 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:34:09 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:34:09 INFO - ^ 09:34:09 INFO - 1 warning generated. 09:34:09 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:34:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:34:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:34:09 INFO - Successfully installed psutil 09:34:09 INFO - Cleaning up... 09:34:09 INFO - Return code: 0 09:34:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:34:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:09 INFO - 'HOME': '/Users/cltbld', 09:34:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:09 INFO - 'LOGNAME': 'cltbld', 09:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:09 INFO - 'MOZ_NO_REMOTE': '1', 09:34:09 INFO - 'NO_EM_RESTART': '1', 09:34:09 INFO - 'PAGER': '/bin/cat', 09:34:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:09 INFO - 'PWD': '/builds/slave/test', 09:34:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:09 INFO - 'SHELL': '/bin/bash', 09:34:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:09 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:09 INFO - 'USER': 'cltbld', 09:34:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:09 INFO - 'XPC_FLAGS': '0x0', 09:34:09 INFO - 'XPC_SERVICE_NAME': '0', 09:34:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:34:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:34:12 INFO - Installing collected packages: mozsystemmonitor 09:34:12 INFO - Running setup.py install for mozsystemmonitor 09:34:12 INFO - Successfully installed mozsystemmonitor 09:34:12 INFO - Cleaning up... 09:34:12 INFO - Return code: 0 09:34:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:34:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:34:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:12 INFO - 'HOME': '/Users/cltbld', 09:34:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:12 INFO - 'LOGNAME': 'cltbld', 09:34:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:12 INFO - 'MOZ_NO_REMOTE': '1', 09:34:12 INFO - 'NO_EM_RESTART': '1', 09:34:12 INFO - 'PAGER': '/bin/cat', 09:34:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:12 INFO - 'PWD': '/builds/slave/test', 09:34:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:12 INFO - 'SHELL': '/bin/bash', 09:34:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:12 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:12 INFO - 'USER': 'cltbld', 09:34:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:12 INFO - 'XPC_FLAGS': '0x0', 09:34:12 INFO - 'XPC_SERVICE_NAME': '0', 09:34:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:34:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:15 INFO - Downloading functools32-3.2.3-2.tar.gz 09:34:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:34:15 INFO - warning: no files found matching '*.txt' 09:34:15 INFO - no previously-included directories found matching 'build' 09:34:15 INFO - no previously-included directories found matching 'dist' 09:34:15 INFO - no previously-included directories found matching '.git*' 09:34:15 INFO - Installing collected packages: jsonschema, functools32 09:34:16 INFO - Running setup.py install for functools32 09:34:16 INFO - warning: no files found matching '*.txt' 09:34:16 INFO - no previously-included directories found matching 'build' 09:34:16 INFO - no previously-included directories found matching 'dist' 09:34:16 INFO - no previously-included directories found matching '.git*' 09:34:16 INFO - Successfully installed jsonschema functools32 09:34:16 INFO - Cleaning up... 09:34:16 INFO - Return code: 0 09:34:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:16 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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:16 INFO - 'HOME': '/Users/cltbld', 09:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:16 INFO - 'LOGNAME': 'cltbld', 09:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:16 INFO - 'MOZ_NO_REMOTE': '1', 09:34:16 INFO - 'NO_EM_RESTART': '1', 09:34:16 INFO - 'PAGER': '/bin/cat', 09:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:16 INFO - 'PWD': '/builds/slave/test', 09:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:16 INFO - 'SHELL': '/bin/bash', 09:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:16 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:16 INFO - 'USER': 'cltbld', 09:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:16 INFO - 'XPC_FLAGS': '0x0', 09:34:16 INFO - 'XPC_SERVICE_NAME': '0', 09:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:34:16 INFO - Cleaning up... 09:34:16 INFO - Return code: 0 09:34:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:16 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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:34:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:34:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:16 INFO - 'HOME': '/Users/cltbld', 09:34:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:16 INFO - 'LOGNAME': 'cltbld', 09:34:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:16 INFO - 'MOZ_NO_REMOTE': '1', 09:34:16 INFO - 'NO_EM_RESTART': '1', 09:34:16 INFO - 'PAGER': '/bin/cat', 09:34:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:16 INFO - 'PWD': '/builds/slave/test', 09:34:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:16 INFO - 'SHELL': '/bin/bash', 09:34:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:16 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:16 INFO - 'USER': 'cltbld', 09:34:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:16 INFO - 'XPC_FLAGS': '0x0', 09:34:16 INFO - 'XPC_SERVICE_NAME': '0', 09:34:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:16 INFO - Downloading/unpacking blobuploader==1.2.4 09:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:19 INFO - Downloading blobuploader-1.2.4.tar.gz 09:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:34:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:34:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:20 INFO - Downloading docopt-0.6.1.tar.gz 09:34:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:34:20 INFO - Installing collected packages: blobuploader, requests, docopt 09:34:20 INFO - Running setup.py install for blobuploader 09:34:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:34:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:34:21 INFO - Running setup.py install for requests 09:34:21 INFO - Running setup.py install for docopt 09:34:21 INFO - Successfully installed blobuploader requests docopt 09:34:21 INFO - Cleaning up... 09:34:21 INFO - Return code: 0 09:34:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:21 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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:34:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:21 INFO - 'HOME': '/Users/cltbld', 09:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:21 INFO - 'LOGNAME': 'cltbld', 09:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:21 INFO - 'MOZ_NO_REMOTE': '1', 09:34:21 INFO - 'NO_EM_RESTART': '1', 09:34:21 INFO - 'PAGER': '/bin/cat', 09:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:21 INFO - 'PWD': '/builds/slave/test', 09:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:21 INFO - 'SHELL': '/bin/bash', 09:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:21 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:21 INFO - 'USER': 'cltbld', 09:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:21 INFO - 'XPC_FLAGS': '0x0', 09:34:21 INFO - 'XPC_SERVICE_NAME': '0', 09:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ZKq1sW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Z7AoNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-K0TQAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-8d2zxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-4evw5p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-FiUQCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ema3Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ClnQyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:22 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7XYK87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DLd2bF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-K4Xnau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-o0FtDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-yccuhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DvAOfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-SMXX0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-qVHlx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:23 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-5eCCty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:34:23 INFO - Running setup.py install for manifestparser 09:34:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for mozcrash 09:34:24 INFO - Running setup.py install for mozdebug 09:34:24 INFO - Running setup.py install for mozdevice 09:34:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for mozfile 09:34:24 INFO - Running setup.py install for mozhttpd 09:34:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for mozinfo 09:34:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:34:24 INFO - Running setup.py install for mozInstall 09:34:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Running setup.py install for mozleak 09:34:25 INFO - Running setup.py install for mozlog 09:34:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Running setup.py install for moznetwork 09:34:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Running setup.py install for mozprocess 09:34:25 INFO - Running setup.py install for mozprofile 09:34:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Running setup.py install for mozrunner 09:34:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:34:25 INFO - Running setup.py install for mozscreenshot 09:34:26 INFO - Running setup.py install for moztest 09:34:26 INFO - Running setup.py install for mozversion 09:34:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:34:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:34:26 INFO - Cleaning up... 09:34:26 INFO - Return code: 0 09:34:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34: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')]} 09:34:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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')]} 09:34:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:26 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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:34:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:26 INFO - 'HOME': '/Users/cltbld', 09:34:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:26 INFO - 'LOGNAME': 'cltbld', 09:34:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:26 INFO - 'MOZ_NO_REMOTE': '1', 09:34:26 INFO - 'NO_EM_RESTART': '1', 09:34:26 INFO - 'PAGER': '/bin/cat', 09:34:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:26 INFO - 'PWD': '/builds/slave/test', 09:34:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:26 INFO - 'SHELL': '/bin/bash', 09:34:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:26 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:26 INFO - 'USER': 'cltbld', 09:34:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:26 INFO - 'XPC_FLAGS': '0x0', 09:34:26 INFO - 'XPC_SERVICE_NAME': '0', 09:34:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:34:26 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7QTN5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:34:26 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-lomSVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:34:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:34:26 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-7Iifmg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ZGGIPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-DEUC9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-XRtkOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-1aMJff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-9RuKj2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-mWIx71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-ytpuOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-fkfQem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:34:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:34:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:34:27 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-Klguhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:34:28 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-YF97Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:34:28 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-C1c2Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:28 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-mpBA7v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:34:28 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-6IADpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:34:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:34:28 INFO - Running setup.py (path:/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/pip-1sHlnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:34:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:28 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:34:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:34:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:34:31 INFO - Downloading blessings-1.6.tar.gz 09:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:34:31 INFO - Installing collected packages: blessings 09:34:31 INFO - Running setup.py install for blessings 09:34:31 INFO - Successfully installed blessings 09:34:31 INFO - Cleaning up... 09:34:31 INFO - Return code: 0 09:34:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:34:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:31 INFO - Reading from file tmpfile_stdout 09:34:31 INFO - Current package versions: 09:34:31 INFO - blessings == 1.6 09:34:31 INFO - blobuploader == 1.2.4 09:34:31 INFO - docopt == 0.6.1 09:34:31 INFO - functools32 == 3.2.3-2 09:34:31 INFO - jsonschema == 2.5.1 09:34:31 INFO - manifestparser == 1.1 09:34:31 INFO - mozInstall == 1.12 09:34:31 INFO - mozcrash == 1.0 09:34:31 INFO - mozdebug == 0.1 09:34:31 INFO - mozdevice == 0.49 09:34:31 INFO - mozfile == 1.2 09:34:31 INFO - mozhttpd == 0.7 09:34:31 INFO - mozinfo == 0.9 09:34:31 INFO - mozleak == 0.1 09:34:31 INFO - mozlog == 3.4 09:34:31 INFO - moznetwork == 0.27 09:34:31 INFO - mozprocess == 0.24 09:34:31 INFO - mozprofile == 0.28 09:34:31 INFO - mozrunner == 6.13 09:34:31 INFO - mozscreenshot == 0.1 09:34:31 INFO - mozsystemmonitor == 0.3 09:34:31 INFO - moztest == 0.8 09:34:31 INFO - mozversion == 1.4 09:34:31 INFO - psutil == 3.1.1 09:34:31 INFO - requests == 1.2.3 09:34:31 INFO - wsgiref == 0.1.2 09:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:32 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 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:34:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:34:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:32 INFO - 'HOME': '/Users/cltbld', 09:34:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:32 INFO - 'LOGNAME': 'cltbld', 09:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:32 INFO - 'MOZ_NO_REMOTE': '1', 09:34:32 INFO - 'NO_EM_RESTART': '1', 09:34:32 INFO - 'PAGER': '/bin/cat', 09:34:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:32 INFO - 'PWD': '/builds/slave/test', 09:34:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:32 INFO - 'SHELL': '/bin/bash', 09:34:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:32 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:32 INFO - 'USER': 'cltbld', 09:34:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:32 INFO - 'XPC_FLAGS': '0x0', 09:34:32 INFO - 'XPC_SERVICE_NAME': '0', 09:34:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:34:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:34:32 INFO - Cleaning up... 09:34:32 INFO - Return code: 0 09:34:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:34:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:34:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:34: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f040b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f043768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff7f0c82ec0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, '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.cB4Psa6xuy/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.vct6OFjm9O/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:34: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'] in /builds/slave/test/build 09:34: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 09:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:33 INFO - 'HOME': '/Users/cltbld', 09:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:33 INFO - 'LOGNAME': 'cltbld', 09:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:33 INFO - 'MOZ_NO_REMOTE': '1', 09:34:33 INFO - 'NO_EM_RESTART': '1', 09:34:33 INFO - 'PAGER': '/bin/cat', 09:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:33 INFO - 'PWD': '/builds/slave/test', 09:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:33 INFO - 'SHELL': '/bin/bash', 09:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:33 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:33 INFO - 'USER': 'cltbld', 09:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:33 INFO - 'XPC_FLAGS': '0x0', 09:34:33 INFO - 'XPC_SERVICE_NAME': '0', 09:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:34:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:34:33 INFO - Cleaning up... 09:34:33 INFO - Return code: 0 09:34:33 INFO - Running post-action listener: _resource_record_post_action 09:34:33 INFO - Running post-action listener: _start_resource_monitoring 09:34:33 INFO - Starting resource monitoring. 09:34:33 INFO - [mozharness: 2017-02-20 17:34:33.428805Z] Finished create-virtualenv step (success) 09:34:33 INFO - [mozharness: 2017-02-20 17:34:33.429832Z] Running install step. 09:34:33 INFO - Running pre-action listener: _resource_record_pre_action 09:34:33 INFO - Running main action method: install 09:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:34:33 INFO - Reading from file tmpfile_stdout 09:34:33 INFO - Detecting whether we're running mozinstall >=1.0... 09:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:34:33 INFO - Reading from file tmpfile_stdout 09:34:33 INFO - Output received: 09:34:33 INFO - Usage: mozinstall [options] installer 09:34:33 INFO - Options: 09:34:33 INFO - -h, --help show this help message and exit 09:34:33 INFO - -d DEST, --destination=DEST 09:34:33 INFO - Directory to install application into. [default: 09:34:33 INFO - "/builds/slave/test"] 09:34:33 INFO - --app=APP Application being installed. [default: firefox] 09:34:33 INFO - mkdir: /builds/slave/test/build/application 09:34:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:34:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:34:53 INFO - Reading from file tmpfile_stdout 09:34:53 INFO - Output received: 09:34:53 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:34:53 INFO - Running post-action listener: _resource_record_post_action 09:34:53 INFO - [mozharness: 2017-02-20 17:34:53.793898Z] Finished install step (success) 09:34:53 INFO - [mozharness: 2017-02-20 17:34:53.794041Z] Running run-tests step. 09:34:53 INFO - Running pre-action listener: _resource_record_pre_action 09:34:53 INFO - Running main action method: run_tests 09:34:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:34:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:34:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:34:53 INFO - 2017-02-20 09:34:53.807 screenresolution[1623:7322] starting screenresolution argv=screenresolution get 09:34:53 INFO - 2017-02-20 09:34:53.810 screenresolution[1623:7322] Display 0: 1600x1200x32@60 09:34:53 INFO - 2017-02-20 09:34:53.816 screenresolution[1624:7325] starting screenresolution argv=screenresolution list 09:34:53 INFO - Available Modes on Display 0 09:34:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:34:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:34:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:34:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:34:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:34:54 INFO - Intel Iris: 09:34:54 INFO - Chipset Model: Intel Iris 09:34:54 INFO - Type: GPU 09:34:54 INFO - Bus: Built-In 09:34:54 INFO - VRAM (Dynamic, Max): 1536 MB 09:34:54 INFO - Vendor: Intel (0x8086) 09:34:54 INFO - Device ID: 0x0a2e 09:34:54 INFO - Revision ID: 0x0009 09:34:54 INFO - Displays: 09:34:54 INFO - Display: 09:34:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:34:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:34:54 INFO - Display Serial Number: 1600x1200 60 09:34:54 INFO - Main Display: Yes 09:34:54 INFO - Mirror: Off 09:34:54 INFO - Online: Yes 09:34:54 INFO - Rotation: Supported 09:34:54 INFO - Return code: 0 09:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:34:54 INFO - Python 2.7.3 09:34:54 INFO - Return code: 0 09:34:54 INFO - grabbing minidump binary from tooltool 09:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:34:54 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 0x10ee1ed30>, '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 0x10ed45db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ee13be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:34:54 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:34:54 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:34:54 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:34:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:34:54 INFO - Return code: 0 09:34:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:34:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:34:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:34:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:34:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:34:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cB4Psa6xuy/Render', 09:34:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:34:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:34:54 INFO - 'HOME': '/Users/cltbld', 09:34:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:34:54 INFO - 'LOGNAME': 'cltbld', 09:34:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:34:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:34:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:34:54 INFO - 'MOZ_NO_REMOTE': '1', 09:34:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:34:54 INFO - 'NO_EM_RESTART': '1', 09:34:54 INFO - 'PAGER': '/bin/cat', 09:34:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:34:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:34:54 INFO - 'PWD': '/builds/slave/test', 09:34:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:34:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:34:54 INFO - 'SHELL': '/bin/bash', 09:34:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vct6OFjm9O/Listeners', 09:34:54 INFO - 'TMPDIR': '/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/', 09:34:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:34:54 INFO - 'USER': 'cltbld', 09:34:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:34:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:34:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:34:54 INFO - 'XPC_FLAGS': '0x0', 09:34:54 INFO - 'XPC_SERVICE_NAME': '0', 09:34:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:34:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:34:54 INFO - mozversion application_buildid: 20170220075356 09:34:54 INFO - mozversion application_changeset: d57841320b5495f190734e16e3f5eb25a008379a 09:34:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:34:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:34:54 INFO - mozversion application_name: Firefox 09:34:54 INFO - mozversion application_remotingname: firefox-dev 09:34:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:34:54 INFO - mozversion application_vendor: Mozilla 09:34:54 INFO - mozversion application_version: 53.0a2 09:34:54 INFO - mozversion platform_buildid: 20170220075356 09:34:54 INFO - mozversion platform_changeset: d57841320b5495f190734e16e3f5eb25a008379a 09:34:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:34:54 INFO - mozversion platform_version: 53.0a2 09:34:54 INFO - using testdate: 1487612094 09:34:54 INFO - actual date: 1487612094 09:34:54 INFO - starting webserver on 'localhost:49241' 09:34:54 INFO - SUITE-START | Running 2 tests 09:34:54 INFO - TEST-START | dromaeo_css 09:34:54 INFO - operating with platform_type : mac_ 09:34:54 INFO - Initialising browser for dromaeo_css test... 09:34:54 INFO - TEST-INFO | started process 1634 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpE5YHl5/profile http://localhost:49241/getInfo.html) 09:34:56 INFO - PROCESS | 1634 | __metrics Screen width/height:1600/1200 09:34:56 INFO - PROCESS | 1634 | colorDepth:24 09:34:56 INFO - PROCESS | 1634 | Browser inner width/height: 1024/689 09:34:56 INFO - PROCESS | 1634 | __metrics 09:34:57 INFO - PROCESS | 1634 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:34:57 INFO - PROCESS | 1634 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:34:57 INFO - TEST-INFO | 1634: exit 0 09:34:57 INFO - Browser initialized. 09:34:57 INFO - Running cycle 1/1 for dromaeo_css test... 09:34:57 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmpE5YHl5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:35:09 INFO - PROCESS | 1636 | RSS: Main: 213200896 09:35:09 INFO - PROCESS | 1636 | 09:38:13 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 09:38:15 INFO - PROCESS | 1636 | RSS: Main: 332734464 09:38:15 INFO - PROCESS | 1636 | 09:39:59 INFO - PROCESS | 1636 | ************************* 09:39:59 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 09:39:59 INFO - PROCESS | 1636 | 09:39:59 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:39:59 INFO - PROCESS | 1636 | Full stack: 09:39:59 INFO - PROCESS | 1636 | ************************* 09:41:18 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 09:41:19 INFO - PROCESS | 1636 | RSS: Main: 354344960 09:41:19 INFO - PROCESS | 1636 | 09:44:21 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 09:44:21 INFO - PROCESS | 1636 | RSS: Main: 313114624 09:44:21 INFO - PROCESS | 1636 | 09:47:24 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 09:47:24 INFO - PROCESS | 1636 | RSS: Main: 316579840 09:47:24 INFO - PROCESS | 1636 | 09:50:28 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 09:50:29 INFO - PROCESS | 1636 | RSS: Main: 315613184 09:50:29 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 09:53:32 INFO - PROCESS | 1636 | RSS: Main: 527269888 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | __start_tp_report 09:53:32 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 09:53:32 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 09:53:32 INFO - PROCESS | 1636 | |i|pagename|runs| 09:53:32 INFO - PROCESS | 1636 | |0;dojo.html;2975.4495418347606;3321.136504508827;3346.9163270918225;3363.545921300624;3390.847411866467;4630.398048253731;5388.649737767052;5559.388467268603;5699.658020518761;5712.200291959124;4968.30443737877;5600.439956004408;5644.491995720385;5651.491365777079;5698.059820129673;3571.0893722100827;5176.637635365526;5191.792328306863;5216.895662086756;5240.816571420001;5093.414257360414;5120.846374608749;5134.717590532519;5134.768935397916;5302.045631786296;5194.454582268864;5206.245094461301;5211;5246.658967167122;5275.340582427197;5237.4500677428705;5260.842174734745;5276.81531146408;5281.709505977151;5303.496167864047;5138.3577052868395;5219.869503262411;5249.790008399659;5254.028004819121;5306.018386598453;5546.77812887488;5595.356533998561;5735.11105778605;5758.452946970031;5810.33181184165;6121.879793613194;6122.1338301444075;6153.446189842935;6186.876262474771;6210.9068363974575;6220.875582488325;6313.084602732624;6314.62112273265;6321.146645202884;6323.083152942843;5742.483176514133;5774.797882074107;5778.479936805666;5800.24596802413;5814.854628634233;6222.160008398899;6275.3724627536885;6299.653519056405;6316.05259211122;6318.178636777189;6164.969175154185;6167.167432396659;6174.289956655042;6177.104319873593;6198.039303907902;6301.684915754194;6305;6305.684715764193;6317.5893566918;6329.335419780857;5931.762729490858;6016.458518733335;6089.48239399656;6097.7865774697675;6162.938370616326;5908.14331921869;6005.789797357072;6012.488938440194;6034.668093254913;6059.606125601822;4895.534924182197;4900.583450406684;4905.9018819624125;4911.50884911506;4941.530554597308;4359.825606975749;4361.454818147731;4380.956190438055;4387.517373088957;4408.58118478744;5636.520895723909;5667.093265077568;5693.316801983706;5708.343540492813;5778.711064446761;6117.766507567544;6248.343923887926;6305.117283580303;6313.684315784192;6318.399752023551;5681.0626246668835;5727.828165155052;5741.569382296345;5774.855628609318;5786.537077033827;5451.400345961941;5466.426025267289;5468.988237176135;5476.67139971603;5479.75341109651;6299.055141728777;6335.081413194969;6340.365963403623;6357.777477788255;6365.522585806083;6179.474744646755;6186.628802271878;6234.407731265523;6295.559310848196;6304.432601065926;6325.652089135142;6325.778597749057;6325.936740632535;6329.082283069021;6338.239411270677;6220.937790622036;6227.564070515021;6230.06549017651;6235.376462353728;6236.126942228001;6031;6128.564234752123;6131.693415329305;6160.353162918008;6201.255849298113;5941.405859414024;5964.284285885721;6118.9846826261555;6127.769884593299;6136.365905528278;5874;5886.52907767369;5887.381824908323;5896.970515147397;6006.549508786946;5736.397678243891;5786.1899334094105;5827.271591051119;5830.941690583039;5906.232189815297;6041.577089603686;6075.908861366995;6086.969565152146;6106.1451396803595;6133.754649813957;5887.087501437284;5898.9115163273445;5907;5908.5568582357355;5921.111833224878 09:53:32 INFO - PROCESS | 1636 | |1;ext.html;501.8544622059602;507.9288899554063;511.0622008614193;520.3027942556973;522.9215617657349;28343.29141771457;35337.82331088341;41426.79286603566;43466.695999120035;45538.544614553844;43268.91827704309;43514.782426087826;43528;43537.34693979593;43636;9331.440113593206;9497.762555936088;9532.285078619097;9546.474943878084;9546.761330966712;8508.74473765788;8716.302695784321;10541.31481453703;11227.887721122766;11504.367259800707;10926.235163538555;11702.648920532398;11703.94148029263;11710.590129345475;11719.765604687902;11495.965363117359;11608.6517404478;11670.533178672842;11691.298522088659;11692.415379231004;8431.241188293083;8630.697925572638;8641.222289993868;8754.299656027566;11199.384033878134;40331.7983410084;42685.35971960423;42752.57247427517;42829;43030.56969430297;3870.767753934773;3974.3641017437362;4020.9195816083807;4025.5169379674626;4056.310427227349;27905.604719764135;27942.88228470879;28013;28556.71443285582;28681.426371472455;3128.8592013359453;3149.685031496855;3248.2529018325918;3282.5240340150785;3285.9342813143603;418938;421227;421874;422131;422646.9999999969;46789;56643.15035274474;56780;56880;57015.14477282844;60700;60757.69621151866;60824.69587652033;60931;60938;16008;16214;16273.186340683154;16273.674526509403;16278.348866045462;11342.432878356049;12480.126391152713;12547.184433011826;12552.748945021049;12571.559995400117;15993.600159996093;18021.923406135327;22068.779312206672;22299.665505017438;22877.656835147485;6869.175698916162;8532.488050716853;8648.956755216184;8728.519931403835;8730.388872778845;823.798169448477;830.339879795564;848.855694531931;896.8027034052498;906.0486489186328;30482;31189;31255.062348129137;31315.373692526024;32103;824.9133840946614;1029.9588016479256;1076.1444651502075;1080.1642563827806;1203.3802591665299;12356.505739770488;13996.440142394395;15952.2821473034;16058.839411605735;16355.427560035341;664708;669400;669808;670575;671378;62744;63245.051324230175;63372.68313658494;63449.68275158595;63477.04784428237;1399.5031763723935;1421;1426.1158081989026;1432.7206194792125;1442.7114577084415;24826.131085411926;28696.99560515372;29601.703982959894;30062.849685751433;31680.841595791873;52769;54248.45751542592;54378;54499.72750136224;57724.71137644285;524360;610502;617438;617730;617874;34441;34499;41773.955651107746;42175.94560136021;42444.39222666108;43162.352564712186;44132;44572.77713611411;44706.2914483001;45205;34322;34357.48463773095;36727.45292368682;37000.44499332566;37652.81173594115;32156.83921580377;35510;36013;37199.25601487901;37772;35397.64602353943;35646.465303020996;36451.27097457983;36606.450903237004;36792.89621311365;28446.43107137887;30581.847090765295;32768;32833.835830820695;33170.83414583008;22890.427739305986;23809.52380952356;24116.638250425905;24394.51210975806;24606 09:53:32 INFO - PROCESS | 1636 | |2;jquery.html;365.69647192829956;389.2565200467108;389.5092183848351;396.2234021318215;420.58572306278313;14689.412423503061;15050.999999999985;17365.479035628934;19934.003299834985;20496.925461180832;19072.809271907277;19455.513612159702;21121.57756844862;21394.46513837151;21433.928303584835;4547.931781023287;5684.630499017571;5896;5896.056630939051;5917;5821.650700957956;5894.027485464893;5914.556408269375;5928.6739229342365;5948.494377977855;5610;5707.543396528268;5889.528837692996;5898.911516327258;5906.350301466835;5743.971280143614;5770.2210201622665;5773.682447465388;5804.100364443518;5810.1865738796605;4917.7786999585105;5062.822801201977;5113.795448182068;5125.103106956268;5131.897362052738;24674.889629966696;24902.37744056395;25646.743532564808;25928;26146.607800883;2564.640950266964;2588.6634737484005;2597.5454295498403;2600.5189040027467;2617.306413800344;8425.536595487245;9801.215902727765;9821.312508124434;10284.074433300964;10309.020643038974;1685.8735594830437;1699.9320027199021;1755.262789628359;1792.8476079533255;1801.3515134551683;114548.42725786318;118653.40673296664;119536.80463195343;121519.17721234189;121578.39210803978;11747;11937.820932686016;11995.580154694544;12032.81950770739;12103.092268079929;15760.92119539395;15852.52442426729;15879.444219452263;15912.443064492687;15962.882598218246;8525.829483410296;8685.826283474422;8704.738857834274;8718.869216961624;8891.866622000674;8349.03986041601;8372.706955256659;8542;8569.871451928226;8569.95715021421;4721.5986641135205;4831.4202295724735;4832.34763306949;4846.103470857832;4950.158473059589;1986.632472992501;2037.3378651938178;2038.337540299379;2040.6734922412343;2043.8773673579633;983.7737320416344;990.1484723138095;998.1615443027746;999.4552968632113;1040.193849766437;20460.38618841437;21010.579788404146;21033.469819309892;21158;21310.467238318855;1009.6415772400838;1018.9235807314333;1049.884512703602;1053.4416759117526;1068.58859339155;10562.577496900192;11290.943545282222;12247.632571022883;12474.688132796753;12633.684157896127;772648;773058;774160;778406;808003;103817.48091259495;103955;104743.4762826181;160290;162382;942.32623674072;1017.5675337981477;1039.8908114648004;1054.6466933577185;1057.4025675493322;19403.90298048557;19719.60560788805;19728.506787329858;20029.59940801205;20034.89982550078;57228.42771572398;57609.135862962925;59268.40731592629;61082;61238.38761612505;79836.4032719354;85088.57455712682;85645.14354856372;85744.57127714322;89845;7345.375643070399;7937.682492700227;8136.308413784895;8354.916450835413;8610;9012.684556040507;10189.388636681526;12996.02529810287;13193.274369909746;13329.200247985153;10699.94650026745;11204.607838725931;11312.15158863072;11436;11470.197086203885;9136.223421009288;10945;11217.943910280397;11695.12286578527;11732.472038758106;10695.94652026735;11131.777364452828;11362.091032717197;11738.354390508604;11837.348945808064;8272.131426200162;8381.455205411628;8495.617697203765;8598.484090954562;8785.341099417441;7855.410844186595;10353.275270730977;10804.351738895692;11326.37704926237;11479.25384849982 09:53:32 INFO - PROCESS | 1636 | |3;mootools.html;1437.8562143785616;1438.129931391508;1444.2056868722204;1451.8693317601421;1469.5958611381868;7563.357114645261;7816.062072551302;8166.183381661838;8585.957070214648;8620.698275560364;7748.341390981759;8148.4703494272835;8378.832423351545;8383.874241886377;8481.067082620906;2310.838241323104;2348.6946696929376;2349.2247558305717;2351.776581224781;2351.988240058797;2077.542940553076;2352.5765362234793;2380.3573035280465;2386.72552656445;2393.80849532037;2041.4794227471973;2075.0454790796252;2274.4541310085624;2349.7650234976536;2357.705286839145;2093.1522733292963;2139.358192542247;2306.8385213035012;2315.7452680205165;2316.6756654068445;2264.4338915271182;2347.741748407691;2349.941251468727;2355.6702061711376;2357.6934998450265;8419.663213471455;8488.108748581433;8506.191911768372;8513.914860851373;8524.445911015826;4952;5112.718800465973;5113.284140220372;5125.743712814345;5126.154184559543;3330.7596829523277;3355.1947532592244;3505.0711561435983;3524.0837382280533;3557.1996300832366;1116.6705821782593;1131.0273165078108;1154.2497376705126;1185.0460379394583;1236.437420973455;10815.026647601753;10956.780864382668;10966.451677416177;10972.780544389068;10983.340999540053;4507.301368287855;4628.328892310664;4706.599939005155;4709.246520556694;4776.665633405698;9615.086566776145;9618.038196180327;9625.663101791404;9627.085426884434;9670.371425857296;5317.282166907496;5320.2817619620855;5325;5329.520343169133;5329.733513324319;3865.3235683755793;4666.626669866402;4765.475797662254;4857.2228443449585;4901.166801643729;3335.2662414269307;3851.8251933160655;3923.862664806718;3952.4268980997595;4005.419214213981;1276.16411250631;1276.4894042382934;1278.6995056161795;1283.595667364777;1287.3048553780854;686.821426429132;756.7237958145347;775.3680750188691;778.0313509680371;845.6194712379454;5301.807093403953;5412.810551630674;5786.450287222707;5815.273090863642;5890.263717035371;950.3252690589759;985.0887928665956;999.8650182225307;1013.7262939006426;1017.9847302290472;3361.9831900840827;3664.6074491692984;3666.211764470652;3811.0472381904524;3857.691384689218;9926.751831204134;10249.077583017415;10261.640842570623;10271.691849244535;10297.279190456746;10198.694039178836;10214.744631384126;10218.846717299246;10219.7445063874;10229.48852557384;7588.317051465284;7777.455578109591;7986.840263194704;7992.24073713008;8006.879896801553;5419.187121931742;5442.12925931849;5484.341878974548;5588.245586845724;5628.418573082742;9173.908260917573;9187.265018798347;9236.72289831306;9354.579043942902;9502.572384242863;9284;9455.14903658674;9467.431954082776;9591.328606997444;9595.952020239854;5916.585838991401;6803.591784492946;6878.105846239957;6949.270326615835;6951.270116637883;7539.472236943361;7786.727464538714;7835.098963619257;7889.842203156019;7967.482113662593;6666.200055993312;6782.626955517297;6811.318868113149;6830.897536536857;6878.518503704692;6012.969935150296;7041.119860017498;7110.112359550561;7122.964385178041;7179.784606461814;6337.96831015842;6343.841403964938;6388.616682999035;6525.967370163119;6528.934710653023;4786.593139583175;4833.250846118857;4925.359703238556;4983.75081245929;5198.246254293182;4315.956840431555;5037.949620503748;5039.665887336961;5059.139946209079;5162.174052151638 09:53:32 INFO - PROCESS | 1636 | |4;prototype.html;346.50622862421045;349.5944704143194;353.39040155731357;355.0732587945462;357.8693776771479;3875.8062096895114;4480.148771733377;5108.007876927996;5125.384953805544;5136.4093129290095;5039.72281524516;5047.873803154923;5068.923966140502;5069.822556210534;5081.8221362252325;3658.0671928658153;3777.017975326414;3921.9215615687667;3964.762114273138;4028.2346354192755;3397.13373089863;4014.257362387953;4016.598340165989;4026.9597304027025;4042.3532234842432;3995.40068989651;4022.4368588397647;4037;4042.575529569397;4061.9187616247805;3302.5046243063493;3505.3164632896596;3609.3864043112735;3640.908977275563;3991.6207960243732;2961.016119200141;2988.4609426145553;3189.521571764231;3300.372929143455;3519.208178159919;3954.822033008493;4522.3668686383935;4540.409746732937;4981.576565991895;4984.900301993976;4037.596240375939;4315.525292217853;4486.685931984763;4567.223571992769;4583.152116858392;5305.373839949211;5340.786368545254;5344.518993290583;5371.382291036542;5375.3280839895015;3545.53907991962;3748.175401411685;3812.84748610058;3912.960870391288;3931.3906344516645;4918.877028074291;4968.1554135797005;5042.571381432619;5632.295963004624;5676.262085928803;3494.8602055917986;3764.981175094107;3892.5282445647217;3971.7418367806;3993.281209382339;3887.7084218683713;4013.9197216055513;4037.4145748866836;4045.4943132108488;4047.5547689754103;4548.499665036843;4556.977215113903;4558.361829343895;4563.626914004699;4581.74800385982;4770.76146192689;4931.852044438672;5344.247712428102;5444.673319600836;5450.127979523337;1166.8133098704336;1225.1194416570522;1317.3413293353324;1333.0535319922963;1346.3133801761173;876;924.4176169013613;935.7520257131865;938.3947353956796;943.2312665177858;4198.916021679549;4263.189993901211;4343.609075183249;4404.757738324423;4850.927236091461;4902.509749025069;5021.573166280834;5442.401335853053;5459.3994660587305;5500.917486237709;4274.487061552633;4438.755868427267;4641.791119399635;4802.591779698765;5036.967421678547;2514.2331588865204;2574.9828817617313;2606.244189185115;2690.757831795148;2744.163030275785;5425.945740542623;5432.283858070965;5436.580721578859;5458.099413596791;5508.862278443071;4773.594244489257;5426.554138122321;5426.593005524523;5438.009094997736;5496.862578435491;4928.901421971541;5082.695038297714;5367.248585197997;5451.672899626035;5467.917981230285;4180;4492.5515594002;5078.6420326555835;5207.29701490294;5244.160934250502;4719.796451904743;4942.046362909586;5172.19830926192;5178.896422071462;5225.399079105951;4825.227963525819;5052.408491325221;5193.714345710871;5380.493461830693;5434.456554344534;3501.457274122515;3517.43721004638;3523.436250199956;3539.6283390243652;3545.8404371802817;4462.576055274743;4748.667593268577;4895.755212239303;5218.530332270114;5219.895602087861;4148.854790082332;4790.880227994328;4901.534354236342;5043.957197335085;5061.089003979319;4728.40894888139;5010.448850626501;5027.296178535081;5039.143345631325;5072.54347108762;4793.520647935318;4811.615070794398;4962.181240095489;4998.425495968758;5021.430498246578;4803.1354356214815;5019.870529130916;5027.49725027509;5040.756863195843;5175.4806731423;4190.329547272422;5063.417706963746;5079.034983353151;5196.298499702491;5213.895722085613 09:53:32 INFO - PROCESS | 1636 | |5;yui.html;654.5745265577372;678.1794029224641;735.0371013971697;807.2008711375738;824.8845161677366;14953.5513934582;15616.765748513753;15617.21913904303;15644;15663.21683915804;14385.1368917865;14405.567832965002;14457;14576;14576.344064517096;679.2460368990417;702.3468174597622;707.1902671441197;861.6639510590875;877.2806298834957;835.7200337886785;863.3740538109882;865.2688478235881;876.5003947749785;878.2534845381439;910.9089091090905;932.911373419524;937.9577918993662;938.005713943219;938.8357037518407;712.3446429285018;888.8355654203993;906.542196190926;926.1988380051274;930.367350201859;546.8222827581012;658.4600627485416;681.2200030964518;685.6571714142929;686.498855835243;14806.407743690239;14810.629734256621;15048.924755376263;15256.466023689118;15305.693886122326;13850.515231966832;13867.653308667364;13870.237136957463;13892.305384730824;13973.161610303414;12304.753904921852;12387.19483233587;12454.750904981849;12611.432485538173;12882;4294.162638285536;4405.823767049346;4418.447694038246;4427.667924905612;4541.069080838453;105667.47166264197;108083.45958270159;110647;111390;111818.44090779494;10941.12471002318;10995.780084398268;11027.779444411068;11183.384913829817;11219.60731374398;18699.34552290663;21212.78787212139;22310.10759569599;22394.216202432835;22963.655545166836;7691.653875575613;7809.80475488106;7890.763277101696;7899.407544434191;8108.5945702714625;4054.8986275343354;4200.3699445082875;4200.369944508348;4209.894752631209;4224.852130175429;3610.2779444111284;3673.9081522962138;3674.4304632781427;3713.405855063177;3716.331060409152;672.6737532296833;675.1493118670412;681.8670359279992;683.5727670206121;691.498663468991;634.3973225435855;671.7783131566571;672.5998031171445;681.8678806433031;692.4529621598881;10015.449150296658;10181.643642472478;10288.639897603547;10351.378917264989;10380.740481488023;655.1090516897016;677.6510097299895;686.2931180883697;720.7873677265114;741.2513361504812;4671.43942726875;5281.9207711884355;5340.279062326614;5546.140348246028;5690.573207009491;68974.65512672404;93003.13993720087;98995.50502247443;102935.4853225729;105482;75847;93677;94069.58895616571;94107;96154.55768163483;81903.18096818955;82227.3554528918;82798;83866;85340;9809.705708828747;9913.008699130029;10838;11138.554457821596;11161.441927903736;46185;46261.3368492547;47131;47246;49138.50861491339;66587;67286;68494;69788;69877;12259.509619615472;12399.938000309941;13026.54407095785;13084.214947103204;13408.061435699798;14017.859821401655;14139.222342771247;14320.785188221977;14526.983111182115;15095.773563396338;13103.672408189872;13548.322583870964;13729.313534323444;13739.313034348443;13954.441822326993;12844.614661560168;13669.453221871014;13694.794578081535;13733.107348022346;13973.371198296305;12578.496860125859;13115.306476388834;13259.535916242885;13285.269310187647;13515.729685406433;10448.529816158443;10777.204134212812;10911.945440272748;11094.667159985212;11242.55029798799;9669.323147379617;10750.247482676137;10867.945660271647;11035.779284414106;11066.557337706401 09:53:32 INFO - PROCESS | 1636 | __end_tp_report 09:53:32 INFO - PROCESS | 1636 | __start_cc_report 09:53:32 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1380 09:53:32 INFO - PROCESS | 1636 | __end_cc_report 09:53:32 INFO - PROCESS | 1636 | __startTimestamp1487613212424__endTimestamp 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | ------- Summary: start ------- 09:53:32 INFO - PROCESS | 1636 | Number of tests: 6 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5704.05 Median:5887.38 stddev:670.57 (11.4%) stddev-sans-first:637.55 09:53:32 INFO - PROCESS | 1636 | Values: 2975.4 3321.1 3346.9 3363.5 3390.8 4630.4 5388.6 5559.4 5699.7 5712.2 4968.3 5600.4 5644.5 5651.5 5698.1 3571.1 5176.6 5191.8 5216.9 5240.8 5093.4 5120.8 5134.7 5134.8 5302.0 5194.5 5206.2 5211.0 5246.7 5275.3 5237.5 5260.8 5276.8 5281.7 5303.5 5138.4 5219.9 5249.8 5254.0 5306.0 5546.8 5595.4 5735.1 5758.5 5810.3 6121.9 6122.1 6153.4 6186.9 6210.9 6220.9 6313.1 6314.6 6321.1 6323.1 5742.5 5774.8 5778.5 5800.2 5814.9 6222.2 6275.4 6299.7 6316.1 6318.2 6165.0 6167.2 6174.3 6177.1 6198.0 6301.7 6305.0 6305.7 6317.6 6329.3 5931.8 6016.5 6089.5 6097.8 6162.9 5908.1 6005.8 6012.5 6034.7 6059.6 4895.5 4900.6 4905.9 4911.5 4941.5 4359.8 4361.5 4381.0 4387.5 4408.6 5636.5 5667.1 5693.3 5708.3 5778.7 6117.8 6248.3 6305.1 6313.7 6318.4 5681.1 5727.8 5741.6 5774.9 5786.5 5451.4 5466.4 5469.0 5476.7 5479.8 6299.1 6335.1 6340.4 6357.8 6365.5 6179.5 6186.6 6234.4 6295.6 6304.4 6325.7 6325.8 6325.9 6329.1 6338.2 6220.9 6227.6 6230.1 6235.4 6236.1 6031.0 6128.6 6131.7 6160.4 6201.3 5941.4 5964.3 6119.0 6127.8 6136.4 5874.0 5886.5 5887.4 5897.0 6006.5 5736.4 5786.2 5827.3 5830.9 5906.2 6041.6 6075.9 6087.0 6106.1 6133.8 5887.1 5898.9 5907.0 5908.6 5921.1 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:69908.04 Median:37712.41 stddev:153188.44 (406.2%) stddev-sans-first:153529.54 09:53:32 INFO - PROCESS | 1636 | Values: 501.9 507.9 511.1 520.3 522.9 28343.3 35337.8 41426.8 43466.7 45538.5 43268.9 43514.8 43528.0 43537.3 43636.0 9331.4 9497.8 9532.3 9546.5 9546.8 8508.7 8716.3 10541.3 11227.9 11504.4 10926.2 11702.6 11703.9 11710.6 11719.8 11496.0 11608.7 11670.5 11691.3 11692.4 8431.2 8630.7 8641.2 8754.3 11199.4 40331.8 42685.4 42752.6 42829.0 43030.6 3870.8 3974.4 4020.9 4025.5 4056.3 27905.6 27942.9 28013.0 28556.7 28681.4 3128.9 3149.7 3248.3 3282.5 3285.9 418938.0 421227.0 421874.0 422131.0 422647.0 46789.0 56643.2 56780.0 56880.0 57015.1 60700.0 60757.7 60824.7 60931.0 60938.0 16008.0 16214.0 16273.2 16273.7 16278.3 11342.4 12480.1 12547.2 12552.7 12571.6 15993.6 18021.9 22068.8 22299.7 22877.7 6869.2 8532.5 8649.0 8728.5 8730.4 823.8 830.3 848.9 896.8 906.0 30482.0 31189.0 31255.1 31315.4 32103.0 824.9 1030.0 1076.1 1080.2 1203.4 12356.5 13996.4 15952.3 16058.8 16355.4 664708.0 669400.0 669808.0 670575.0 671378.0 62744.0 63245.1 63372.7 63449.7 63477.0 1399.5 1421.0 1426.1 1432.7 1442.7 24826.1 28697.0 29601.7 30062.8 31680.8 52769.0 54248.5 54378.0 54499.7 57724.7 524360.0 610502.0 617438.0 617730.0 617874.0 34441.0 34499.0 41774.0 42175.9 42444.4 43162.4 44132.0 44572.8 44706.3 45205.0 34322.0 34357.5 36727.5 37000.4 37652.8 32156.8 35510.0 36013.0 37199.3 37772.0 35397.6 35646.5 36451.3 36606.5 36792.9 28446.4 30581.8 32768.0 32833.8 33170.8 22890.4 23809.5 24116.6 24394.5 24606.0 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:40495.33 Median:13733.51 stddev:129177.32 (940.6%) stddev-sans-first:129504.55 09:53:32 INFO - PROCESS | 1636 | Values: 365.7 389.3 389.5 396.2 420.6 14689.4 15051.0 17365.5 19934.0 20496.9 19072.8 19455.5 21121.6 21394.5 21433.9 4547.9 5684.6 5896.0 5896.1 5917.0 5821.7 5894.0 5914.6 5928.7 5948.5 5610.0 5707.5 5889.5 5898.9 5906.4 5744.0 5770.2 5773.7 5804.1 5810.2 4917.8 5062.8 5113.8 5125.1 5131.9 24674.9 24902.4 25646.7 25928.0 26146.6 2564.6 2588.7 2597.5 2600.5 2617.3 8425.5 9801.2 9821.3 10284.1 10309.0 1685.9 1699.9 1755.3 1792.8 1801.4 114548.4 118653.4 119536.8 121519.2 121578.4 11747.0 11937.8 11995.6 12032.8 12103.1 15760.9 15852.5 15879.4 15912.4 15962.9 8525.8 8685.8 8704.7 8718.9 8891.9 8349.0 8372.7 8542.0 8569.9 8570.0 4721.6 4831.4 4832.3 4846.1 4950.2 1986.6 2037.3 2038.3 2040.7 2043.9 983.8 990.1 998.2 999.5 1040.2 20460.4 21010.6 21033.5 21158.0 21310.5 1009.6 1018.9 1049.9 1053.4 1068.6 10562.6 11290.9 12247.6 12474.7 12633.7 772648.0 773058.0 774160.0 778406.0 808003.0 103817.5 103955.0 104743.5 160290.0 162382.0 942.3 1017.6 1039.9 1054.6 1057.4 19403.9 19719.6 19728.5 20029.6 20034.9 57228.4 57609.1 59268.4 61082.0 61238.4 79836.4 85088.6 85645.1 85744.6 89845.0 7345.4 7937.7 8136.3 8354.9 8610.0 9012.7 10189.4 12996.0 13193.3 13329.2 10699.9 11204.6 11312.2 11436.0 11470.2 9136.2 10945.0 11217.9 11695.1 11732.5 10695.9 11131.8 11362.1 11738.4 11837.3 8272.1 8381.5 8495.6 8598.5 8785.3 7855.4 10353.3 10804.4 11326.4 11479.3 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5440.77 Median:5113.00 stddev:3001.28 (58.7%) stddev-sans-first:2994.62 09:53:32 INFO - PROCESS | 1636 | Values: 1437.9 1438.1 1444.2 1451.9 1469.6 7563.4 7816.1 8166.2 8586.0 8620.7 7748.3 8148.5 8378.8 8383.9 8481.1 2310.8 2348.7 2349.2 2351.8 2352.0 2077.5 2352.6 2380.4 2386.7 2393.8 2041.5 2075.0 2274.5 2349.8 2357.7 2093.2 2139.4 2306.8 2315.7 2316.7 2264.4 2347.7 2349.9 2355.7 2357.7 8419.7 8488.1 8506.2 8513.9 8524.4 4952.0 5112.7 5113.3 5125.7 5126.2 3330.8 3355.2 3505.1 3524.1 3557.2 1116.7 1131.0 1154.2 1185.0 1236.4 10815.0 10956.8 10966.5 10972.8 10983.3 4507.3 4628.3 4706.6 4709.2 4776.7 9615.1 9618.0 9625.7 9627.1 9670.4 5317.3 5320.3 5325.0 5329.5 5329.7 3865.3 4666.6 4765.5 4857.2 4901.2 3335.3 3851.8 3923.9 3952.4 4005.4 1276.2 1276.5 1278.7 1283.6 1287.3 686.8 756.7 775.4 778.0 845.6 5301.8 5412.8 5786.5 5815.3 5890.3 950.3 985.1 999.9 1013.7 1018.0 3362.0 3664.6 3666.2 3811.0 3857.7 9926.8 10249.1 10261.6 10271.7 10297.3 10198.7 10214.7 10218.8 10219.7 10229.5 7588.3 7777.5 7986.8 7992.2 8006.9 5419.2 5442.1 5484.3 5588.2 5628.4 9173.9 9187.3 9236.7 9354.6 9502.6 9284.0 9455.1 9467.4 9591.3 9596.0 5916.6 6803.6 6878.1 6949.3 6951.3 7539.5 7786.7 7835.1 7889.8 7967.5 6666.2 6782.6 6811.3 6830.9 6878.5 6013.0 7041.1 7110.1 7123.0 7179.8 6338.0 6343.8 6388.6 6526.0 6528.9 4786.6 4833.3 4925.4 4983.8 5198.2 4316.0 5037.9 5039.7 5059.1 5162.2 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4250.97 Median:4772.18 stddev:1250.92 (26.2%) stddev-sans-first:1219.62 09:53:32 INFO - PROCESS | 1636 | Values: 346.5 349.6 353.4 355.1 357.9 3875.8 4480.1 5108.0 5125.4 5136.4 5039.7 5047.9 5068.9 5069.8 5081.8 3658.1 3777.0 3921.9 3964.8 4028.2 3397.1 4014.3 4016.6 4027.0 4042.4 3995.4 4022.4 4037.0 4042.6 4061.9 3302.5 3505.3 3609.4 3640.9 3991.6 2961.0 2988.5 3189.5 3300.4 3519.2 3954.8 4522.4 4540.4 4981.6 4984.9 4037.6 4315.5 4486.7 4567.2 4583.2 5305.4 5340.8 5344.5 5371.4 5375.3 3545.5 3748.2 3812.8 3913.0 3931.4 4918.9 4968.2 5042.6 5632.3 5676.3 3494.9 3765.0 3892.5 3971.7 3993.3 3887.7 4013.9 4037.4 4045.5 4047.6 4548.5 4557.0 4558.4 4563.6 4581.7 4770.8 4931.9 5344.2 5444.7 5450.1 1166.8 1225.1 1317.3 1333.1 1346.3 876.0 924.4 935.8 938.4 943.2 4198.9 4263.2 4343.6 4404.8 4850.9 4902.5 5021.6 5442.4 5459.4 5500.9 4274.5 4438.8 4641.8 4802.6 5037.0 2514.2 2575.0 2606.2 2690.8 2744.2 5425.9 5432.3 5436.6 5458.1 5508.9 4773.6 5426.6 5426.6 5438.0 5496.9 4928.9 5082.7 5367.2 5451.7 5467.9 4180.0 4492.6 5078.6 5207.3 5244.2 4719.8 4942.0 5172.2 5178.9 5225.4 4825.2 5052.4 5193.7 5380.5 5434.5 3501.5 3517.4 3523.4 3539.6 3545.8 4462.6 4748.7 4895.8 5218.5 5219.9 4148.9 4790.9 4901.5 5044.0 5061.1 4728.4 5010.4 5027.3 5039.1 5072.5 4793.5 4811.6 4962.2 4998.4 5021.4 4803.1 5019.9 5027.5 5040.8 5175.5 4190.3 5063.4 5079.0 5196.3 5213.9 09:53:32 INFO - PROCESS | 1636 | 09:53:32 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:20537.64 Median:4200.37 stddev:29455.88 (701.3%) stddev-sans-first:29500.68 09:53:32 INFO - PROCESS | 1636 | Values: 654.6 678.2 735.0 807.2 824.9 14953.6 15616.8 15617.2 15644.0 15663.2 14385.1 14405.6 14457.0 14576.0 14576.3 679.2 702.3 707.2 861.7 877.3 835.7 863.4 865.3 876.5 878.3 910.9 932.9 938.0 938.0 938.8 712.3 888.8 906.5 926.2 930.4 546.8 658.5 681.2 685.7 686.5 14806.4 14810.6 15048.9 15256.5 15305.7 13850.5 13867.7 13870.2 13892.3 13973.2 12304.8 12387.2 12454.8 12611.4 12882.0 4294.2 4405.8 4418.4 4427.7 4541.1 105667.5 108083.5 110647.0 111390.0 111818.4 10941.1 10995.8 11027.8 11183.4 11219.6 18699.3 21212.8 22310.1 22394.2 22963.7 7691.7 7809.8 7890.8 7899.4 8108.6 4054.9 4200.4 4200.4 4209.9 4224.9 3610.3 3673.9 3674.4 3713.4 3716.3 672.7 675.1 681.9 683.6 691.5 634.4 671.8 672.6 681.9 692.5 10015.4 10181.6 10288.6 10351.4 10380.7 655.1 677.7 686.3 720.8 741.3 4671.4 5281.9 5340.3 5546.1 5690.6 68974.7 93003.1 98995.5 102935.5 105482.0 75847.0 93677.0 94069.6 94107.0 96154.6 81903.2 82227.4 82798.0 83866.0 85340.0 9809.7 9913.0 10838.0 11138.6 11161.4 46185.0 46261.3 47131.0 47246.0 49138.5 66587.0 67286.0 68494.0 69788.0 69877.0 12259.5 12399.9 13026.5 13084.2 13408.1 14017.9 14139.2 14320.8 14527.0 15095.8 13103.7 13548.3 13729.3 13739.3 13954.4 12844.6 13669.5 13694.8 13733.1 13973.4 12578.5 13115.3 13259.5 13285.3 13515.7 10448.5 10777.2 10911.9 11094.7 11242.6 9669.3 10750.2 10867.9 11035.8 11066.6 09:53:32 INFO - PROCESS | 1636 | -------- Summary: end -------- 09:53:32 INFO - PROCESS | 1636 | 09:53:33 INFO - TEST-INFO | 1636: exit 0 09:53:33 INFO - TEST-OK | dromaeo_css | took 1118687ms 09:53:33 INFO - TEST-START | kraken 09:53:33 INFO - operating with platform_type : mac_ 09:53:33 INFO - Initialising browser for kraken test... 09:53:33 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp9ZjF8X/profile http://localhost:49241/getInfo.html) 09:53:35 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 09:53:35 INFO - PROCESS | 1646 | colorDepth:24 09:53:35 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 09:53:35 INFO - PROCESS | 1646 | __metrics 09:53:35 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:53:35 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:53:36 INFO - TEST-INFO | 1646: exit 0 09:53:36 INFO - Browser initialized. 09:53:36 INFO - Running cycle 1/1 for kraken test... 09:53:36 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/tmp9ZjF8X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:53:48 INFO - PROCESS | 1647 | RSS: Main: 213516288 09:53:48 INFO - PROCESS | 1647 | 09:53:51 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 09:53:51 INFO - PROCESS | 1647 | RSS: Main: 266293248 09:53:51 INFO - PROCESS | 1647 | 09:53:54 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 09:53:55 INFO - PROCESS | 1647 | RSS: Main: 274997248 09:53:55 INFO - PROCESS | 1647 | 09:53:58 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 09:53:59 INFO - PROCESS | 1647 | RSS: Main: 372690944 09:53:59 INFO - PROCESS | 1647 | 09:54:01 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 09:54:01 INFO - PROCESS | 1647 | RSS: Main: 275750912 09:54:01 INFO - PROCESS | 1647 | 09:54:03 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:54:04 INFO - PROCESS | 1647 | RSS: Main: 278028288 09:54:04 INFO - PROCESS | 1647 | 09:54:07 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 09:54:07 INFO - PROCESS | 1647 | RSS: Main: 317763584 09:54:07 INFO - PROCESS | 1647 | 09:54:10 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 09:54:11 INFO - PROCESS | 1647 | RSS: Main: 318681088 09:54:11 INFO - PROCESS | 1647 | 09:54:14 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 09:54:14 INFO - PROCESS | 1647 | RSS: Main: 315699200 09:54:14 INFO - PROCESS | 1647 | 09:54:16 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:54:16 INFO - PROCESS | 1647 | RSS: Main: 295481344 09:54:16 INFO - PROCESS | 1647 | 09:54:18 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:54:19 INFO - PROCESS | 1647 | RSS: Main: 297705472 09:54:19 INFO - PROCESS | 1647 | 09:54:21 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:54:22 INFO - PROCESS | 1647 | RSS: Main: 303857664 09:54:22 INFO - PROCESS | 1647 | 09:54:25 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:54:25 INFO - PROCESS | 1647 | RSS: Main: 317079552 09:54:25 INFO - PROCESS | 1647 | 09:54:28 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:54:29 INFO - PROCESS | 1647 | RSS: Main: 311259136 09:54:29 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 09:54:31 INFO - PROCESS | 1647 | RSS: Main: 355192832 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | __start_tp_report 09:54:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load 09:54:31 INFO - PROCESS | 1647 | _x_x_mozilla_page_load_details 09:54:31 INFO - PROCESS | 1647 | |i|pagename|runs| 09:54:31 INFO - PROCESS | 1647 | |0;ai-astar;115;113;113;112;112;114;113;113;113;110 09:54:31 INFO - PROCESS | 1647 | |1;audio-beat-detection;138;109;108;143;111;112;109;110;127;130 09:54:31 INFO - PROCESS | 1647 | |2;audio-dft;186;184;182;184;185;184;183;184;203;259 09:54:31 INFO - PROCESS | 1647 | |3;audio-fft;81;60;59;90;61;60;59;58;74;58 09:54:31 INFO - PROCESS | 1647 | |4;audio-oscillator;88;70;85;71;68;69;81;68;68;83 09:54:31 INFO - PROCESS | 1647 | |5;imaging-gaussian-blur;89;86;88;87;90;85;89;87;89;87 09:54:31 INFO - PROCESS | 1647 | |6;imaging-darkroom;97;97;143;97;97;97;97;107;97;97 09:54:31 INFO - PROCESS | 1647 | |7;imaging-desaturate;85;87;87;86;85;85;85;86;87;85 09:54:31 INFO - PROCESS | 1647 | |8;json-parse-financial;56;52;53;54;58;56;57;58;57;57 09:54:31 INFO - PROCESS | 1647 | |9;json-stringify-tinderbox;64;71;75;75;71;68;68;71;69;71 09:54:31 INFO - PROCESS | 1647 | |10;stanford-crypto-aes;85;86;83;83;82;86;82;84;85;83 09:54:31 INFO - PROCESS | 1647 | |11;stanford-crypto-ccm;132;144;140;149;140;132;137;139;181;158 09:54:31 INFO - PROCESS | 1647 | |12;stanford-crypto-pbkdf2;161;198;163;175;228;208;167;221;219;165 09:54:31 INFO - PROCESS | 1647 | |13;stanford-crypto-sha256-iterative;65;65;66;65;66;65;65;63;65;64 09:54:31 INFO - PROCESS | 1647 | __end_tp_report 09:54:31 INFO - PROCESS | 1647 | __start_cc_report 09:54:31 INFO - PROCESS | 1647 | _x_x_mozilla_cycle_collect,2050 09:54:31 INFO - PROCESS | 1647 | __end_cc_report 09:54:31 INFO - PROCESS | 1647 | __startTimestamp1487613271541__endTimestamp 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | ------- Summary: start ------- 09:54:31 INFO - PROCESS | 1647 | Number of tests: 14 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.32 (1.2%) stddev-sans-first:1.13 09:54:31 INFO - PROCESS | 1647 | Values: 115.0 113.0 113.0 112.0 112.0 114.0 113.0 113.0 113.0 110.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#1] audio-beat-detection Cycles:10 Average:119.70 Median:119.50 stddev:13.47 (11.3%) stddev-sans-first:12.55 09:54:31 INFO - PROCESS | 1647 | Values: 138.0 109.0 108.0 143.0 111.0 112.0 109.0 110.0 127.0 130.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#2] audio-dft Cycles:10 Average:193.40 Median:184.50 stddev:23.83 (12.9%) stddev-sans-first:25.13 09:54:31 INFO - PROCESS | 1647 | Values: 186.0 184.0 182.0 184.0 185.0 184.0 183.0 184.0 203.0 259.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:11.49 (19.0%) stddev-sans-first:10.83 09:54:31 INFO - PROCESS | 1647 | Values: 81.0 60.0 59.0 90.0 61.0 60.0 59.0 58.0 74.0 58.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#4] audio-oscillator Cycles:10 Average:75.10 Median:76.00 stddev:8.12 (10.7%) stddev-sans-first:7.14 09:54:31 INFO - PROCESS | 1647 | Values: 88.0 70.0 85.0 71.0 68.0 69.0 81.0 68.0 68.0 83.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.50 stddev:1.57 (1.8%) stddev-sans-first:1.59 09:54:31 INFO - PROCESS | 1647 | Values: 89.0 86.0 88.0 87.0 90.0 85.0 89.0 87.0 89.0 87.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#6] imaging-darkroom Cycles:10 Average:102.60 Median:97.00 stddev:14.54 (15.0%) stddev-sans-first:15.28 09:54:31 INFO - PROCESS | 1647 | Values: 97.0 97.0 143.0 97.0 97.0 97.0 97.0 107.0 97.0 97.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:0.92 (1.1%) stddev-sans-first:0.93 09:54:31 INFO - PROCESS | 1647 | Values: 85.0 87.0 87.0 86.0 85.0 85.0 85.0 86.0 87.0 85.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:57.00 stddev:2.10 (3.7%) stddev-sans-first:2.22 09:54:31 INFO - PROCESS | 1647 | Values: 56.0 52.0 53.0 54.0 58.0 56.0 57.0 58.0 57.0 57.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:3.30 (4.7%) stddev-sans-first:2.60 09:54:31 INFO - PROCESS | 1647 | Values: 64.0 71.0 75.0 75.0 71.0 68.0 68.0 71.0 69.0 71.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.50 stddev:1.52 (1.8%) stddev-sans-first:1.56 09:54:31 INFO - PROCESS | 1647 | Values: 85.0 86.0 83.0 83.0 82.0 86.0 82.0 84.0 85.0 83.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:142.00 stddev:14.79 (10.4%) stddev-sans-first:14.90 09:54:31 INFO - PROCESS | 1647 | Values: 132.0 144.0 140.0 149.0 140.0 132.0 137.0 139.0 181.0 158.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:190.50 Median:203.00 stddev:27.04 (13.3%) stddev-sans-first:26.49 09:54:31 INFO - PROCESS | 1647 | Values: 161.0 198.0 163.0 175.0 228.0 208.0 167.0 221.0 219.0 165.0 09:54:31 INFO - PROCESS | 1647 | 09:54:31 INFO - PROCESS | 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 09:54:31 INFO - PROCESS | 1647 | Values: 65.0 65.0 66.0 65.0 66.0 65.0 65.0 63.0 65.0 64.0 09:54:31 INFO - PROCESS | 1647 | -------- Summary: end -------- 09:54:31 INFO - PROCESS | 1647 | 09:54:32 INFO - TEST-INFO | 1647: exit 0 09:54:32 INFO - TEST-OK | kraken | took 59350ms 09:54:32 INFO - SUITE-END | took 1178s 09:54:32 INFO - Completed test suite (00:19:38) 09:54:32 INFO - javascript benchmark 09:54:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2975.4495418347606, 3321.136504508827, 3346.9163270918225, 3363.545921300624, 3390.847411866467, 4630.398048253731, 5388.649737767052, 5559.388467268603, 5699.658020518761, 5712.200291959124, 4968.30443737877, 5600.439956004408, 5644.491995720385, 5651.491365777079, 5698.059820129673, 3571.0893722100827, 5176.637635365526, 5191.792328306863, 5216.895662086756, 5240.816571420001, 5093.414257360414, 5120.846374608749, 5134.717590532519, 5134.768935397916, 5302.045631786296, 5194.454582268864, 5206.245094461301, 5211.0, 5246.658967167122, 5275.340582427197, 5237.4500677428705, 5260.842174734745, 5276.81531146408, 5281.709505977151, 5303.496167864047, 5138.3577052868395, 5219.869503262411, 5249.790008399659, 5254.028004819121, 5306.018386598453, 5546.77812887488, 5595.356533998561, 5735.11105778605, 5758.452946970031, 5810.33181184165, 6121.879793613194, 6122.1338301444075, 6153.446189842935, 6186.876262474771, 6210.9068363974575, 6220.875582488325, 6313.084602732624, 6314.62112273265, 6321.146645202884, 6323.083152942843, 5742.483176514133, 5774.797882074107, 5778.479936805666, 5800.24596802413, 5814.854628634233, 6222.160008398899, 6275.3724627536885, 6299.653519056405, 6316.05259211122, 6318.178636777189, 6164.969175154185, 6167.167432396659, 6174.289956655042, 6177.104319873593, 6198.039303907902, 6301.684915754194, 6305.0, 6305.684715764193, 6317.5893566918, 6329.335419780857, 5931.762729490858, 6016.458518733335, 6089.48239399656, 6097.7865774697675, 6162.938370616326, 5908.14331921869, 6005.789797357072, 6012.488938440194, 6034.668093254913, 6059.606125601822, 4895.534924182197, 4900.583450406684, 4905.9018819624125, 4911.50884911506, 4941.530554597308, 4359.825606975749, 4361.454818147731, 4380.956190438055, 4387.517373088957, 4408.58118478744, 5636.520895723909, 5667.093265077568, 5693.316801983706, 5708.343540492813, 5778.711064446761, 6117.766507567544, 6248.343923887926, 6305.117283580303, 6313.684315784192, 6318.399752023551, 5681.0626246668835, 5727.828165155052, 5741.569382296345, 5774.855628609318, 5786.537077033827, 5451.400345961941, 5466.426025267289, 5468.988237176135, 5476.67139971603, 5479.75341109651, 6299.055141728777, 6335.081413194969, 6340.365963403623, 6357.777477788255, 6365.522585806083, 6179.474744646755, 6186.628802271878, 6234.407731265523, 6295.559310848196, 6304.432601065926, 6325.652089135142, 6325.778597749057, 6325.936740632535, 6329.082283069021, 6338.239411270677, 6220.937790622036, 6227.564070515021, 6230.06549017651, 6235.376462353728, 6236.126942228001, 6031.0, 6128.564234752123, 6131.693415329305, 6160.353162918008, 6201.255849298113, 5941.405859414024, 5964.284285885721, 6118.9846826261555, 6127.769884593299, 6136.365905528278, 5874.0, 5886.52907767369, 5887.381824908323, 5896.970515147397, 6006.549508786946, 5736.397678243891, 5786.1899334094105, 5827.271591051119, 5830.941690583039, 5906.232189815297, 6041.577089603686, 6075.908861366995, 6086.969565152146, 6106.1451396803595, 6133.754649813957, 5887.087501437284, 5898.9115163273445, 5907.0, 5908.5568582357355, 5921.111833224878], "value": 5659.661489820613, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.8544622059602, 507.9288899554063, 511.0622008614193, 520.3027942556973, 522.9215617657349, 28343.29141771457, 35337.82331088341, 41426.79286603566, 43466.695999120035, 45538.544614553844, 43268.91827704309, 43514.782426087826, 43528.0, 43537.34693979593, 43636.0, 9331.440113593206, 9497.762555936088, 9532.285078619097, 9546.474943878084, 9546.761330966712, 8508.74473765788, 8716.302695784321, 10541.31481453703, 11227.887721122766, 11504.367259800707, 10926.235163538555, 11702.648920532398, 11703.94148029263, 11710.590129345475, 11719.765604687902, 11495.965363117359, 11608.6517404478, 11670.533178672842, 11691.298522088659, 11692.415379231004, 8431.241188293083, 8630.697925572638, 8641.222289993868, 8754.299656027566, 11199.384033878134, 40331.7983410084, 42685.35971960423, 42752.57247427517, 42829.0, 43030.56969430297, 3870.767753934773, 3974.3641017437362, 4020.9195816083807, 4025.5169379674626, 4056.310427227349, 27905.604719764135, 27942.88228470879, 28013.0, 28556.71443285582, 28681.426371472455, 3128.8592013359453, 3149.685031496855, 3248.2529018325918, 3282.5240340150785, 3285.9342813143603, 418938.0, 421227.0, 421874.0, 422131.0, 422646.9999999969, 46789.0, 56643.15035274474, 56780.0, 56880.0, 57015.14477282844, 60700.0, 60757.69621151866, 60824.69587652033, 60931.0, 60938.0, 16008.0, 16214.0, 16273.186340683154, 16273.674526509403, 16278.348866045462, 11342.432878356049, 12480.126391152713, 12547.184433011826, 12552.748945021049, 12571.559995400117, 15993.600159996093, 18021.923406135327, 22068.779312206672, 22299.665505017438, 22877.656835147485, 6869.175698916162, 8532.488050716853, 8648.956755216184, 8728.519931403835, 8730.388872778845, 823.798169448477, 830.339879795564, 848.855694531931, 896.8027034052498, 906.0486489186328, 30482.0, 31189.0, 31255.062348129137, 31315.373692526024, 32103.0, 824.9133840946614, 1029.9588016479256, 1076.1444651502075, 1080.1642563827806, 1203.3802591665299, 12356.505739770488, 13996.440142394395, 15952.2821473034, 16058.839411605735, 16355.427560035341, 664708.0, 669400.0, 669808.0, 670575.0, 671378.0, 62744.0, 63245.051324230175, 63372.68313658494, 63449.68275158595, 63477.04784428237, 1399.5031763723935, 1421.0, 1426.1158081989026, 1432.7206194792125, 1442.7114577084415, 24826.131085411926, 28696.99560515372, 29601.703982959894, 30062.849685751433, 31680.841595791873, 52769.0, 54248.45751542592, 54378.0, 54499.72750136224, 57724.71137644285, 524360.0, 610502.0, 617438.0, 617730.0, 617874.0, 34441.0, 34499.0, 41773.955651107746, 42175.94560136021, 42444.39222666108, 43162.352564712186, 44132.0, 44572.77713611411, 44706.2914483001, 45205.0, 34322.0, 34357.48463773095, 36727.45292368682, 37000.44499332566, 37652.81173594115, 32156.83921580377, 35510.0, 36013.0, 37199.25601487901, 37772.0, 35397.64602353943, 35646.465303020996, 36451.27097457983, 36606.450903237004, 36792.89621311365, 28446.43107137887, 30581.847090765295, 32768.0, 32833.835830820695, 33170.83414583008, 22890.427739305986, 23809.52380952356, 24116.638250425905, 24394.51210975806, 24606.0], "value": 20253.616631966615, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [365.69647192829956, 389.2565200467108, 389.5092183848351, 396.2234021318215, 420.58572306278313, 14689.412423503061, 15050.999999999985, 17365.479035628934, 19934.003299834985, 20496.925461180832, 19072.809271907277, 19455.513612159702, 21121.57756844862, 21394.46513837151, 21433.928303584835, 4547.931781023287, 5684.630499017571, 5896.0, 5896.056630939051, 5917.0, 5821.650700957956, 5894.027485464893, 5914.556408269375, 5928.6739229342365, 5948.494377977855, 5610.0, 5707.543396528268, 5889.528837692996, 5898.911516327258, 5906.350301466835, 5743.971280143614, 5770.2210201622665, 5773.682447465388, 5804.100364443518, 5810.1865738796605, 4917.7786999585105, 5062.822801201977, 5113.795448182068, 5125.103106956268, 5131.897362052738, 24674.889629966696, 24902.37744056395, 25646.743532564808, 25928.0, 26146.607800883, 2564.640950266964, 2588.6634737484005, 2597.5454295498403, 2600.5189040027467, 2617.306413800344, 8425.536595487245, 9801.215902727765, 9821.312508124434, 10284.074433300964, 10309.020643038974, 1685.8735594830437, 1699.9320027199021, 1755.262789628359, 1792.8476079533255, 1801.3515134551683, 114548.42725786318, 118653.40673296664, 119536.80463195343, 121519.17721234189, 121578.39210803978, 11747.0, 11937.820932686016, 11995.580154694544, 12032.81950770739, 12103.092268079929, 15760.92119539395, 15852.52442426729, 15879.444219452263, 15912.443064492687, 15962.882598218246, 8525.829483410296, 8685.826283474422, 8704.738857834274, 8718.869216961624, 8891.866622000674, 8349.03986041601, 8372.706955256659, 8542.0, 8569.871451928226, 8569.95715021421, 4721.5986641135205, 4831.4202295724735, 4832.34763306949, 4846.103470857832, 4950.158473059589, 1986.632472992501, 2037.3378651938178, 2038.337540299379, 2040.6734922412343, 2043.8773673579633, 983.7737320416344, 990.1484723138095, 998.1615443027746, 999.4552968632113, 1040.193849766437, 20460.38618841437, 21010.579788404146, 21033.469819309892, 21158.0, 21310.467238318855, 1009.6415772400838, 1018.9235807314333, 1049.884512703602, 1053.4416759117526, 1068.58859339155, 10562.577496900192, 11290.943545282222, 12247.632571022883, 12474.688132796753, 12633.684157896127, 772648.0, 773058.0, 774160.0, 778406.0, 808003.0, 103817.48091259495, 103955.0, 104743.4762826181, 160290.0, 162382.0, 942.32623674072, 1017.5675337981477, 1039.8908114648004, 1054.6466933577185, 1057.4025675493322, 19403.90298048557, 19719.60560788805, 19728.506787329858, 20029.59940801205, 20034.89982550078, 57228.42771572398, 57609.135862962925, 59268.40731592629, 61082.0, 61238.38761612505, 79836.4032719354, 85088.57455712682, 85645.14354856372, 85744.57127714322, 89845.0, 7345.375643070399, 7937.682492700227, 8136.308413784895, 8354.916450835413, 8610.0, 9012.684556040507, 10189.388636681526, 12996.02529810287, 13193.274369909746, 13329.200247985153, 10699.94650026745, 11204.607838725931, 11312.15158863072, 11436.0, 11470.197086203885, 9136.223421009288, 10945.0, 11217.943910280397, 11695.12286578527, 11732.472038758106, 10695.94652026735, 11131.777364452828, 11362.091032717197, 11738.354390508604, 11837.348945808064, 8272.131426200162, 8381.455205411628, 8495.617697203765, 8598.484090954562, 8785.341099417441, 7855.410844186595, 10353.275270730977, 10804.351738895692, 11326.37704926237, 11479.25384849982], "value": 9779.506824373546, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1437.8562143785616, 1438.129931391508, 1444.2056868722204, 1451.8693317601421, 1469.5958611381868, 7563.357114645261, 7816.062072551302, 8166.183381661838, 8585.957070214648, 8620.698275560364, 7748.341390981759, 8148.4703494272835, 8378.832423351545, 8383.874241886377, 8481.067082620906, 2310.838241323104, 2348.6946696929376, 2349.2247558305717, 2351.776581224781, 2351.988240058797, 2077.542940553076, 2352.5765362234793, 2380.3573035280465, 2386.72552656445, 2393.80849532037, 2041.4794227471973, 2075.0454790796252, 2274.4541310085624, 2349.7650234976536, 2357.705286839145, 2093.1522733292963, 2139.358192542247, 2306.8385213035012, 2315.7452680205165, 2316.6756654068445, 2264.4338915271182, 2347.741748407691, 2349.941251468727, 2355.6702061711376, 2357.6934998450265, 8419.663213471455, 8488.108748581433, 8506.191911768372, 8513.914860851373, 8524.445911015826, 4952.0, 5112.718800465973, 5113.284140220372, 5125.743712814345, 5126.154184559543, 3330.7596829523277, 3355.1947532592244, 3505.0711561435983, 3524.0837382280533, 3557.1996300832366, 1116.6705821782593, 1131.0273165078108, 1154.2497376705126, 1185.0460379394583, 1236.437420973455, 10815.026647601753, 10956.780864382668, 10966.451677416177, 10972.780544389068, 10983.340999540053, 4507.301368287855, 4628.328892310664, 4706.599939005155, 4709.246520556694, 4776.665633405698, 9615.086566776145, 9618.038196180327, 9625.663101791404, 9627.085426884434, 9670.371425857296, 5317.282166907496, 5320.2817619620855, 5325.0, 5329.520343169133, 5329.733513324319, 3865.3235683755793, 4666.626669866402, 4765.475797662254, 4857.2228443449585, 4901.166801643729, 3335.2662414269307, 3851.8251933160655, 3923.862664806718, 3952.4268980997595, 4005.419214213981, 1276.16411250631, 1276.4894042382934, 1278.6995056161795, 1283.595667364777, 1287.3048553780854, 686.821426429132, 756.7237958145347, 775.3680750188691, 778.0313509680371, 845.6194712379454, 5301.807093403953, 5412.810551630674, 5786.450287222707, 5815.273090863642, 5890.263717035371, 950.3252690589759, 985.0887928665956, 999.8650182225307, 1013.7262939006426, 1017.9847302290472, 3361.9831900840827, 3664.6074491692984, 3666.211764470652, 3811.0472381904524, 3857.691384689218, 9926.751831204134, 10249.077583017415, 10261.640842570623, 10271.691849244535, 10297.279190456746, 10198.694039178836, 10214.744631384126, 10218.846717299246, 10219.7445063874, 10229.48852557384, 7588.317051465284, 7777.455578109591, 7986.840263194704, 7992.24073713008, 8006.879896801553, 5419.187121931742, 5442.12925931849, 5484.341878974548, 5588.245586845724, 5628.418573082742, 9173.908260917573, 9187.265018798347, 9236.72289831306, 9354.579043942902, 9502.572384242863, 9284.0, 9455.14903658674, 9467.431954082776, 9591.328606997444, 9595.952020239854, 5916.585838991401, 6803.591784492946, 6878.105846239957, 6949.270326615835, 6951.270116637883, 7539.472236943361, 7786.727464538714, 7835.098963619257, 7889.842203156019, 7967.482113662593, 6666.200055993312, 6782.626955517297, 6811.318868113149, 6830.897536536857, 6878.518503704692, 6012.969935150296, 7041.119860017498, 7110.112359550561, 7122.964385178041, 7179.784606461814, 6337.96831015842, 6343.841403964938, 6388.616682999035, 6525.967370163119, 6528.934710653023, 4786.593139583175, 4833.250846118857, 4925.359703238556, 4983.75081245929, 5198.246254293182, 4315.956840431555, 5037.949620503748, 5039.665887336961, 5059.139946209079, 5162.174052151638], "value": 4404.380696669612, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.50622862421045, 349.5944704143194, 353.39040155731357, 355.0732587945462, 357.8693776771479, 3875.8062096895114, 4480.148771733377, 5108.007876927996, 5125.384953805544, 5136.4093129290095, 5039.72281524516, 5047.873803154923, 5068.923966140502, 5069.822556210534, 5081.8221362252325, 3658.0671928658153, 3777.017975326414, 3921.9215615687667, 3964.762114273138, 4028.2346354192755, 3397.13373089863, 4014.257362387953, 4016.598340165989, 4026.9597304027025, 4042.3532234842432, 3995.40068989651, 4022.4368588397647, 4037.0, 4042.575529569397, 4061.9187616247805, 3302.5046243063493, 3505.3164632896596, 3609.3864043112735, 3640.908977275563, 3991.6207960243732, 2961.016119200141, 2988.4609426145553, 3189.521571764231, 3300.372929143455, 3519.208178159919, 3954.822033008493, 4522.3668686383935, 4540.409746732937, 4981.576565991895, 4984.900301993976, 4037.596240375939, 4315.525292217853, 4486.685931984763, 4567.223571992769, 4583.152116858392, 5305.373839949211, 5340.786368545254, 5344.518993290583, 5371.382291036542, 5375.3280839895015, 3545.53907991962, 3748.175401411685, 3812.84748610058, 3912.960870391288, 3931.3906344516645, 4918.877028074291, 4968.1554135797005, 5042.571381432619, 5632.295963004624, 5676.262085928803, 3494.8602055917986, 3764.981175094107, 3892.5282445647217, 3971.7418367806, 3993.281209382339, 3887.7084218683713, 4013.9197216055513, 4037.4145748866836, 4045.4943132108488, 4047.5547689754103, 4548.499665036843, 4556.977215113903, 4558.361829343895, 4563.626914004699, 4581.74800385982, 4770.76146192689, 4931.852044438672, 5344.247712428102, 5444.673319600836, 5450.127979523337, 1166.8133098704336, 1225.1194416570522, 1317.3413293353324, 1333.0535319922963, 1346.3133801761173, 876.0, 924.4176169013613, 935.7520257131865, 938.3947353956796, 943.2312665177858, 4198.916021679549, 4263.189993901211, 4343.609075183249, 4404.757738324423, 4850.927236091461, 4902.509749025069, 5021.573166280834, 5442.401335853053, 5459.3994660587305, 5500.917486237709, 4274.487061552633, 4438.755868427267, 4641.791119399635, 4802.591779698765, 5036.967421678547, 2514.2331588865204, 2574.9828817617313, 2606.244189185115, 2690.757831795148, 2744.163030275785, 5425.945740542623, 5432.283858070965, 5436.580721578859, 5458.099413596791, 5508.862278443071, 4773.594244489257, 5426.554138122321, 5426.593005524523, 5438.009094997736, 5496.862578435491, 4928.901421971541, 5082.695038297714, 5367.248585197997, 5451.672899626035, 5467.917981230285, 4180.0, 4492.5515594002, 5078.6420326555835, 5207.29701490294, 5244.160934250502, 4719.796451904743, 4942.046362909586, 5172.19830926192, 5178.896422071462, 5225.399079105951, 4825.227963525819, 5052.408491325221, 5193.714345710871, 5380.493461830693, 5434.456554344534, 3501.457274122515, 3517.43721004638, 3523.436250199956, 3539.6283390243652, 3545.8404371802817, 4462.576055274743, 4748.667593268577, 4895.755212239303, 5218.530332270114, 5219.895602087861, 4148.854790082332, 4790.880227994328, 4901.534354236342, 5043.957197335085, 5061.089003979319, 4728.40894888139, 5010.448850626501, 5027.296178535081, 5039.143345631325, 5072.54347108762, 4793.520647935318, 4811.615070794398, 4962.181240095489, 4998.425495968758, 5021.430498246578, 4803.1354356214815, 5019.870529130916, 5027.49725027509, 5040.756863195843, 5175.4806731423, 4190.329547272422, 5063.417706963746, 5079.034983353151, 5196.298499702491, 5213.895722085613], "value": 3874.7715181068766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [654.5745265577372, 678.1794029224641, 735.0371013971697, 807.2008711375738, 824.8845161677366, 14953.5513934582, 15616.765748513753, 15617.21913904303, 15644.0, 15663.21683915804, 14385.1368917865, 14405.567832965002, 14457.0, 14576.0, 14576.344064517096, 679.2460368990417, 702.3468174597622, 707.1902671441197, 861.6639510590875, 877.2806298834957, 835.7200337886785, 863.3740538109882, 865.2688478235881, 876.5003947749785, 878.2534845381439, 910.9089091090905, 932.911373419524, 937.9577918993662, 938.005713943219, 938.8357037518407, 712.3446429285018, 888.8355654203993, 906.542196190926, 926.1988380051274, 930.367350201859, 546.8222827581012, 658.4600627485416, 681.2200030964518, 685.6571714142929, 686.498855835243, 14806.407743690239, 14810.629734256621, 15048.924755376263, 15256.466023689118, 15305.693886122326, 13850.515231966832, 13867.653308667364, 13870.237136957463, 13892.305384730824, 13973.161610303414, 12304.753904921852, 12387.19483233587, 12454.750904981849, 12611.432485538173, 12882.0, 4294.162638285536, 4405.823767049346, 4418.447694038246, 4427.667924905612, 4541.069080838453, 105667.47166264197, 108083.45958270159, 110647.0, 111390.0, 111818.44090779494, 10941.12471002318, 10995.780084398268, 11027.779444411068, 11183.384913829817, 11219.60731374398, 18699.34552290663, 21212.78787212139, 22310.10759569599, 22394.216202432835, 22963.655545166836, 7691.653875575613, 7809.80475488106, 7890.763277101696, 7899.407544434191, 8108.5945702714625, 4054.8986275343354, 4200.3699445082875, 4200.369944508348, 4209.894752631209, 4224.852130175429, 3610.2779444111284, 3673.9081522962138, 3674.4304632781427, 3713.405855063177, 3716.331060409152, 672.6737532296833, 675.1493118670412, 681.8670359279992, 683.5727670206121, 691.498663468991, 634.3973225435855, 671.7783131566571, 672.5998031171445, 681.8678806433031, 692.4529621598881, 10015.449150296658, 10181.643642472478, 10288.639897603547, 10351.378917264989, 10380.740481488023, 655.1090516897016, 677.6510097299895, 686.2931180883697, 720.7873677265114, 741.2513361504812, 4671.43942726875, 5281.9207711884355, 5340.279062326614, 5546.140348246028, 5690.573207009491, 68974.65512672404, 93003.13993720087, 98995.50502247443, 102935.4853225729, 105482.0, 75847.0, 93677.0, 94069.58895616571, 94107.0, 96154.55768163483, 81903.18096818955, 82227.3554528918, 82798.0, 83866.0, 85340.0, 9809.705708828747, 9913.008699130029, 10838.0, 11138.554457821596, 11161.441927903736, 46185.0, 46261.3368492547, 47131.0, 47246.0, 49138.50861491339, 66587.0, 67286.0, 68494.0, 69788.0, 69877.0, 12259.509619615472, 12399.938000309941, 13026.54407095785, 13084.214947103204, 13408.061435699798, 14017.859821401655, 14139.222342771247, 14320.785188221977, 14526.983111182115, 15095.773563396338, 13103.672408189872, 13548.322583870964, 13729.313534323444, 13739.313034348443, 13954.441822326993, 12844.614661560168, 13669.453221871014, 13694.794578081535, 13733.107348022346, 13973.371198296305, 12578.496860125859, 13115.306476388834, 13259.535916242885, 13285.269310187647, 13515.729685406433, 10448.529816158443, 10777.204134212812, 10911.945440272748, 11094.667159985212, 11242.55029798799, 9669.323147379617, 10750.247482676137, 10867.945660271647, 11035.779284414106, 11066.557337706401], "value": 7582.137400537136, "unit": "score"}], "name": "dromaeo_css", "value": 7248.763703107095, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 113.0, 112.0, 112.0, 114.0, 113.0, 113.0, 113.0, 110.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 109.0, 108.0, 143.0, 111.0, 112.0, 109.0, 110.0, 127.0, 130.0], "value": 119.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 182.0, 184.0, 185.0, 184.0, 183.0, 184.0, 203.0, 259.0], "value": 193.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 59.0, 90.0, 61.0, 60.0, 59.0, 58.0, 74.0, 58.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 71.0, 68.0, 69.0, 81.0, 68.0, 68.0, 83.0], "value": 75.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 87.0, 90.0, 85.0, 89.0, 87.0, 89.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 143.0, 97.0, 97.0, 97.0, 97.0, 107.0, 97.0, 97.0], "value": 102.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 86.0, 85.0, 85.0, 85.0, 86.0, 87.0, 85.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 53.0, 54.0, 58.0, 56.0, 57.0, 58.0, 57.0, 57.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 75.0, 75.0, 71.0, 68.0, 68.0, 71.0, 69.0, 71.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 83.0, 83.0, 82.0, 86.0, 82.0, 84.0, 85.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 144.0, 140.0, 149.0, 140.0, 132.0, 137.0, 139.0, 181.0, 158.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 198.0, 163.0, 175.0, 228.0, 208.0, 167.0, 221.0, 219.0, 165.0], "value": 190.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 63.0, 65.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1453.7, "alertThreshold": 2.0}]} 09:54:32 INFO - Return code: 0 09:54:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:54:32 ERROR - # TBPL SUCCESS # 09:54:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:54:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:54:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:54:32 INFO - 2017-02-20 09:54:32.857 screenresolution[1651:9682] starting screenresolution argv=screenresolution get 09:54:32 INFO - 2017-02-20 09:54:32.860 screenresolution[1651:9682] Display 0: 1600x1200x32@60 09:54:32 INFO - 2017-02-20 09:54:32.866 screenresolution[1652:9685] starting screenresolution argv=screenresolution list 09:54:32 INFO - Available Modes on Display 0 09:54:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:54:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:54:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:54:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:54:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:54:33 INFO - Intel Iris: 09:54:33 INFO - Chipset Model: Intel Iris 09:54:33 INFO - Type: GPU 09:54:33 INFO - Bus: Built-In 09:54:33 INFO - VRAM (Dynamic, Max): 1536 MB 09:54:33 INFO - Vendor: Intel (0x8086) 09:54:33 INFO - Device ID: 0x0a2e 09:54:33 INFO - Revision ID: 0x0009 09:54:33 INFO - Displays: 09:54:33 INFO - Display: 09:54:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:54:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:54:33 INFO - Display Serial Number: 1600x1200 60 09:54:33 INFO - Main Display: Yes 09:54:33 INFO - Mirror: Off 09:54:33 INFO - Online: Yes 09:54:33 INFO - Rotation: Supported 09:54:33 INFO - Return code: 0 09:54:33 INFO - Running post-action listener: _resource_record_post_action 09:54:33 INFO - [mozharness: 2017-02-20 17:54:33.109699Z] Finished run-tests step (success) 09:54:33 INFO - Running post-run listener: _resource_record_post_run 09:54:33 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 39195648; Write bytes: 507300864; Read time: 373; Write time: 1567 09:54:33 INFO - TinderboxPrint: CPU usage
53.6% 09:54:33 INFO - TinderboxPrint: I/O read bytes / time
39,195,648 / 373 09:54:33 INFO - TinderboxPrint: I/O write bytes / time
507,300,864 / 1,567 09:54:33 INFO - TinderboxPrint: CPU idle
2,225.8 (46.4%) 09:54:33 INFO - TinderboxPrint: CPU system
957.5 (20.0%) 09:54:33 INFO - TinderboxPrint: CPU user
1,614.3 (33.6%) 09:54:33 INFO - TinderboxPrint: Swap in / out
247,013,376 / 0 09:54:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205726208; Write bytes: 198926336; Read time: 15824; Write time: 377 09:54:33 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37012480; Write bytes: 296261120; Read time: 349; Write time: 1126 09:54:33 INFO - Running post-run listener: _upload_blobber_files 09:54:33 INFO - Blob upload gear active. 09:54:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:54:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:54:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:35 INFO - (blobuploader) - INFO - Done attempting. 09:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:35 INFO - (blobuploader) - INFO - Done attempting. 09:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:54:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:36 INFO - (blobuploader) - INFO - Done attempting. 09:54:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:54:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:54:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:54:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:54:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:54:39 INFO - (blobuploader) - INFO - Done attempting. 09:54:39 INFO - (blobuploader) - INFO - Iteration through files over. 09:54:39 INFO - Return code: 0 09:54:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:54:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:54:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd45b36a20fb08a08e77f16041cf504f0c051fb94830eb4424de580bdbffc3734acfb73c69084c4bac29e846841f69c60aa99cc29ea733b072340cd843e8d7f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239dadeb19ae2a67e2f98cb995ad78d000bd7e0dca0af0279d431ee724946af453ba5b4214f9b7571779aef2a3f7faefa8aa159c36027b62444707e4aaf90e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4089268f403e55658ce301d58da2fe93ab8983826d1bcc5ed92cce2f9c4cd4f1c9803d0f5ef042aabac115d67109346e887c36ab408ac3c70b933bd6b91e8c6a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2aee18aad0a5c32319347a05bc09196031dc7f7781452b9bd3ff30f977586a9a9b640880abd121bf1e9e98313ba3cc80674f1b3ab68d9857db099fed49e0eb50"} 09:54:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:54:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:54:39 INFO - Contents: 09:54:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd45b36a20fb08a08e77f16041cf504f0c051fb94830eb4424de580bdbffc3734acfb73c69084c4bac29e846841f69c60aa99cc29ea733b072340cd843e8d7f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239dadeb19ae2a67e2f98cb995ad78d000bd7e0dca0af0279d431ee724946af453ba5b4214f9b7571779aef2a3f7faefa8aa159c36027b62444707e4aaf90e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4089268f403e55658ce301d58da2fe93ab8983826d1bcc5ed92cce2f9c4cd4f1c9803d0f5ef042aabac115d67109346e887c36ab408ac3c70b933bd6b91e8c6a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2aee18aad0a5c32319347a05bc09196031dc7f7781452b9bd3ff30f977586a9a9b640880abd121bf1e9e98313ba3cc80674f1b3ab68d9857db099fed49e0eb50"} 09:54:39 INFO - Running post-run listener: copy_logs_to_upload_dir 09:54:39 INFO - Copying logs to upload dir... 09:54:39 INFO - mkdir: /builds/slave/test/build/upload/logs 09:54:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.422579 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-02-20 09:54:39.189746) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 09:54:39.193219) ========= 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.cB4Psa6xuy/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.vct6OFjm9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd45b36a20fb08a08e77f16041cf504f0c051fb94830eb4424de580bdbffc3734acfb73c69084c4bac29e846841f69c60aa99cc29ea733b072340cd843e8d7f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239dadeb19ae2a67e2f98cb995ad78d000bd7e0dca0af0279d431ee724946af453ba5b4214f9b7571779aef2a3f7faefa8aa159c36027b62444707e4aaf90e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4089268f403e55658ce301d58da2fe93ab8983826d1bcc5ed92cce2f9c4cd4f1c9803d0f5ef042aabac115d67109346e887c36ab408ac3c70b933bd6b91e8c6a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2aee18aad0a5c32319347a05bc09196031dc7f7781452b9bd3ff30f977586a9a9b640880abd121bf1e9e98313ba3cc80674f1b3ab68d9857db099fed49e0eb50"} build_url:https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011017 build_url: 'https://queue.taskcluster.net/v1/task/X4oki7NNTKa3zMHDoWqG_g/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/cd45b36a20fb08a08e77f16041cf504f0c051fb94830eb4424de580bdbffc3734acfb73c69084c4bac29e846841f69c60aa99cc29ea733b072340cd843e8d7f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/239dadeb19ae2a67e2f98cb995ad78d000bd7e0dca0af0279d431ee724946af453ba5b4214f9b7571779aef2a3f7faefa8aa159c36027b62444707e4aaf90e19", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4089268f403e55658ce301d58da2fe93ab8983826d1bcc5ed92cce2f9c4cd4f1c9803d0f5ef042aabac115d67109346e887c36ab408ac3c70b933bd6b91e8c6a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2aee18aad0a5c32319347a05bc09196031dc7f7781452b9bd3ff30f977586a9a9b640880abd121bf1e9e98313ba3cc80674f1b3ab68d9857db099fed49e0eb50"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-20 09:54:39.232602) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:54:39.233502) ========= 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.cB4Psa6xuy/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.vct6OFjm9O/Listeners TMPDIR=/var/folders/z0/m8w9z33x49b2v28r7k58cfh800000w/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.004954 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-20 09:54:39.283255) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 09:54:39.283551) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-20 09:54:39.286852) ========= ========= Total master_lag: 0.18 =========