builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0202 starttime: 1488492091.75 results: success (0) buildid: 20170302120652 builduid: 0e64f50781cc414eb542b91a18f2b14e revision: 1c676fbbcdbfeec529f424d6884dce04877ec73f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.749208) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.749830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.750207) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.778140) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.778613) ========= 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.ylMDNmuJwC/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.zA3wfA370U/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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-03-02 14:01:31-- 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% 19.4M=0.001s 2017-03-02 14:01:31 (19.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094729 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.899750) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.900318) ========= 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.ylMDNmuJwC/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.zA3wfA370U/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.025688 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:31.950032) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 14:01:31.950575) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 1c676fbbcdbfeec529f424d6884dce04877ec73f --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 1c676fbbcdbfeec529f424d6884dce04877ec73f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ylMDNmuJwC/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.zA3wfA370U/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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-03-02 14:01:32,058 truncating revision to first 12 chars 2017-03-02 14:01:32,058 Setting DEBUG logging. 2017-03-02 14:01:32,058 attempt 1/10 2017-03-02 14:01:32,058 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/1c676fbbcdbf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-02 14:01:33,308 unpacking tar archive at: mozilla-aurora-1c676fbbcdbf/testing/mozharness/ program finished with exit code 0 elapsedTime=2.150763 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-02 14:01:34.127614) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:34.128265) ========= script_repo_revision: 1c676fbbcdbfeec529f424d6884dce04877ec73f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:34.129009) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:34.129508) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-02 14:01:34.151575) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-02 14:01:34.152204) ========= /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.ylMDNmuJwC/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.zA3wfA370U/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:01:34 INFO - MultiFileLogger online at 20170302 14:01:34 in /builds/slave/test 14:01:34 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 14:01:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:01:34 INFO - {'append_to_log': False, 14:01:34 INFO - 'base_work_dir': '/builds/slave/test', 14:01:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:01:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:01:34 INFO - 'branch': 'Mozilla-Aurora', 14:01:34 INFO - 'buildbot_json_path': 'buildprops.json', 14:01:34 INFO - 'config_files': ('talos/mac_config.py',), 14:01:34 INFO - 'default_actions': ('clobber', 14:01:34 INFO - 'read-buildbot-config', 14:01:34 INFO - 'download-and-extract', 14:01:34 INFO - 'populate-webroot', 14:01:34 INFO - 'create-virtualenv', 14:01:34 INFO - 'install', 14:01:34 INFO - 'run-tests'), 14:01:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:01:34 INFO - 'download_minidump_stackwalk': True, 14:01:34 INFO - 'download_symbols': 'ondemand', 14:01:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:01:34 INFO - 'tooltool.py': '/tools/tooltool.py', 14:01:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:01:34 INFO - '/tools/misc-python/virtualenv.py')}, 14:01:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:01:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:01:34 INFO - 'installer_path': 'installer.exe', 14:01:34 INFO - 'log_level': 'info', 14:01:34 INFO - 'log_name': 'talos', 14:01:34 INFO - 'log_to_console': True, 14:01:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:01:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:01:34 INFO - 'opt_config_files': (), 14:01:34 INFO - 'pip_index': False, 14:01:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:01:34 INFO - 'cmd': ('bash', 14:01:34 INFO - '-c', 14:01:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:01:34 INFO - 'enabled': True, 14:01:34 INFO - 'halt_on_failure': False, 14:01:34 INFO - 'name': 'check_screen_resolution'},), 14:01:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:01:34 INFO - 'cmd': ('bash', 14:01:34 INFO - '-c', 14:01:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:01:34 INFO - 'enabled': True, 14:01:34 INFO - 'halt_on_failure': False, 14:01:34 INFO - 'name': 'check_screen_resolution'},), 14:01:34 INFO - 'run_cmd_checks_enabled': True, 14:01:34 INFO - 'sps_profile': False, 14:01:34 INFO - 'sps_profile_interval': 0, 14:01:34 INFO - 'suite': 'dromaeojs', 14:01:34 INFO - 'system_bits': '32', 14:01:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:01:34 INFO - 'title': 't-yosemite-r7-0202', 14:01:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:01:34 INFO - 'use_talos_json': True, 14:01:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:01:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:01:34 INFO - 'work_dir': 'build'} 14:01:34 INFO - [mozharness: 2017-03-02 22:01:34.368169Z] Running clobber step. 14:01:34 INFO - Running pre-action listener: _resource_record_pre_action 14:01:34 INFO - Running main action method: clobber 14:01:34 INFO - rmtree: /builds/slave/test/build 14:01:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:01:36 INFO - Running post-action listener: _resource_record_post_action 14:01:36 INFO - [mozharness: 2017-03-02 22:01:36.736058Z] Finished clobber step (success) 14:01:36 INFO - [mozharness: 2017-03-02 22:01:36.736206Z] Running read-buildbot-config step. 14:01:36 INFO - Running pre-action listener: _resource_record_pre_action 14:01:36 INFO - Running main action method: read_buildbot_config 14:01:36 INFO - Using buildbot properties: 14:01:36 INFO - { 14:01:36 INFO - "project": "", 14:01:36 INFO - "product": "firefox", 14:01:36 INFO - "script_repo_revision": "production", 14:01:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 14:01:36 INFO - "repository": "", 14:01:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 14:01:36 INFO - "buildid": "20170302120652", 14:01:36 INFO - "pgo_build": "False", 14:01:36 INFO - "basedir": "/builds/slave/test", 14:01:36 INFO - "buildnumber": 59, 14:01:36 INFO - "slavename": "t-yosemite-r7-0202", 14:01:36 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 14:01:36 INFO - "platform": "yosemite_r7", 14:01:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 14:01:36 INFO - "branch": "mozilla-aurora", 14:01:36 INFO - "repo_path": "releases/mozilla-aurora", 14:01:36 INFO - "revision": "1c676fbbcdbfeec529f424d6884dce04877ec73f", 14:01:36 INFO - "stage_platform": "macosx64", 14:01:36 INFO - "builduid": "0e64f50781cc414eb542b91a18f2b14e", 14:01:36 INFO - "slavebuilddir": "test" 14:01:36 INFO - } 14:01:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 14:01:36 INFO - Running post-action listener: _resource_record_post_action 14:01:36 INFO - [mozharness: 2017-03-02 22:01:36.739458Z] Finished read-buildbot-config step (success) 14:01:36 INFO - [mozharness: 2017-03-02 22:01:36.739595Z] Running download-and-extract step. 14:01:36 INFO - Running pre-action listener: _resource_record_pre_action 14:01:36 INFO - Running main action method: download_and_extract 14:01:36 INFO - mkdir: /builds/slave/test/build/tests 14:01:36 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')]} 14:01:36 INFO - trying https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 14:01:36 INFO - Downloading https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/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 14:01:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/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 14:01:37 INFO - Downloaded 1199 bytes. 14:01:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 14:01:37 INFO - Using the following test package requirements: 14:01:37 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 14:01:37 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 14:01:37 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 14:01:37 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'jsshell-mac.zip'], 14:01:37 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 14:01:37 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 14:01:37 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 14:01:37 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 14:01:37 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 14:01:37 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 14:01:37 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 14:01:37 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 14:01:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 14:01:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:01:37 INFO - Fetch https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 14:01:38 INFO - Expected file size: 16357760 14:01:38 INFO - Obtained file size: 16357760 14:01:45 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 14:01:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 14:01:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 14:01:45 INFO - Fetch https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 14:01:46 INFO - Expected file size: 16357760 14:01:46 INFO - Obtained file size: 16357760 14:01:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 14:01:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 14:01:52 INFO - Fetch https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 14:01:54 INFO - Expected file size: 14403650 14:01:54 INFO - Obtained file size: 14403650 14:01: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')]} 14:01:54 INFO - trying https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:01:54 INFO - Downloading https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 14:01:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/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 14:01:56 INFO - Downloaded 73909130 bytes. 14:01:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:01:56 INFO - mkdir: /builds/slave/test/properties 14:01:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:01:56 INFO - Writing to file /builds/slave/test/properties/build_url 14:01:56 INFO - Contents: 14:01:56 INFO - build_url:https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 14:01:57 INFO - Running post-action listener: _resource_record_post_action 14:01:57 INFO - Running post-action listener: set_extra_try_arguments 14:01:57 INFO - [mozharness: 2017-03-02 22:01:57.070471Z] Finished download-and-extract step (success) 14:01:57 INFO - [mozharness: 2017-03-02 22:01:57.070541Z] Running populate-webroot step. 14:01:57 INFO - Running pre-action listener: _resource_record_pre_action 14:01:57 INFO - Running main action method: populate_webroot 14:01:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:01:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:01:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:01:57 INFO - '--tppagecycles', 14:01:57 INFO - '7'], 14:01:57 INFO - 'tests': ['tsvgm']}}, 14:01:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:01:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:01:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:01:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:01:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:01:57 INFO - 'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:01:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:01:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:01:57 INFO - 'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['damp', 'tps']}, 14:01:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:01:57 INFO - 'tests': ['damp', 'tps']}, 14:01:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['dromaeo_dom']}, 14:01:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:01:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['basic_compositor_video']}, 14:01:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:01:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['a11yr', 14:01:57 INFO - 'ts_paint', 14:01:57 INFO - 'tpaint', 14:01:57 INFO - 'sessionrestore', 14:01:57 INFO - 'sessionrestore_no_auto_restore', 14:01:57 INFO - 'tabpaint']}, 14:01:57 INFO - 'other-e10s': {'tests': ['a11yr', 14:01:57 INFO - 'ts_paint', 14:01:57 INFO - 'tpaint', 14:01:57 INFO - 'sessionrestore', 14:01:57 INFO - 'sessionrestore_no_auto_restore', 14:01:57 INFO - 'tabpaint']}, 14:01:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:01:57 INFO - 'ts_paint', 14:01:57 INFO - 'tpaint', 14:01:57 INFO - 'sessionrestore', 14:01:57 INFO - 'sessionrestore_no_auto_restore', 14:01:57 INFO - 'tabpaint']}, 14:01:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:01:57 INFO - 'ts_paint', 14:01:57 INFO - 'tpaint', 14:01:57 INFO - 'sessionrestore', 14:01:57 INFO - 'sessionrestore_no_auto_restore', 14:01:57 INFO - 'tabpaint']}, 14:01:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['a11yr', 14:01:57 INFO - 'ts_paint', 14:01:57 INFO - 'tpaint', 14:01:57 INFO - 'sessionrestore', 14:01:57 INFO - 'sessionrestore_no_auto_restore', 14:01:57 INFO - 'tabpaint']}, 14:01:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['a11yr', 14:01:57 INFO - 'ts_paint', 14:01:57 INFO - 'tpaint', 14:01:57 INFO - 'sessionrestore', 14:01:57 INFO - 'sessionrestore_no_auto_restore', 14:01:57 INFO - 'tabpaint']}, 14:01:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['tsvgx', 14:01:57 INFO - 'tsvgr_opacity', 14:01:57 INFO - 'tart', 14:01:57 INFO - 'tscrollx', 14:01:57 INFO - 'cart', 14:01:57 INFO - 'tsvg_static']}, 14:01:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:01:57 INFO - 'tsvgr_opacity', 14:01:57 INFO - 'tart', 14:01:57 INFO - 'tscrollx', 14:01:57 INFO - 'cart', 14:01:57 INFO - 'tsvg_static']}, 14:01:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:01:57 INFO - 'talos_options': ['--disable-e10s'], 14:01:57 INFO - 'tests': ['tp5o']}, 14:01:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:01:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:01:57 INFO - 'talos_options': ['--disable-e10s', 14:01:57 INFO - '--xperf_path', 14:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:57 INFO - 'tests': ['tp5n']}, 14:01:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:01:57 INFO - 'talos_options': ['--xperf_path', 14:01:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:01:57 INFO - 'tests': ['tp5n']}}, 14:01:57 INFO - 'talos.zip': {'path': '', 14:01:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:01:57 INFO - Running post-action listener: _resource_record_post_action 14:01:57 INFO - [mozharness: 2017-03-02 22:01:57.089103Z] Finished populate-webroot step (success) 14:01:57 INFO - [mozharness: 2017-03-02 22:01:57.089221Z] Running create-virtualenv step. 14:01:57 INFO - Running pre-action listener: _resource_record_pre_action 14:01:57 INFO - Running main action method: create_virtualenv 14:01:57 INFO - Creating virtualenv /builds/slave/test/build/venv 14:01:57 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:01:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:01:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:01:57 INFO - Using real prefix '/tools/python27' 14:01:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:01:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:02:00 INFO - Installing pip.................done. 14:02:00 INFO - Return code: 0 14:02:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:02:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:02:01 INFO - Reading from file tmpfile_stdout 14:02:01 INFO - Output received: 14:02:01 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) 14:02:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:02:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:01 INFO - 'HOME': '/Users/cltbld', 14:02:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:01 INFO - 'LOGNAME': 'cltbld', 14:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:01 INFO - 'MOZ_NO_REMOTE': '1', 14:02:01 INFO - 'NO_EM_RESTART': '1', 14:02:01 INFO - 'PAGER': '/bin/cat', 14:02:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:01 INFO - 'PWD': '/builds/slave/test', 14:02:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:01 INFO - 'SHELL': '/bin/bash', 14:02:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:01 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:01 INFO - 'USER': 'cltbld', 14:02:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:01 INFO - 'XPC_FLAGS': '0x0', 14:02:01 INFO - 'XPC_SERVICE_NAME': '0', 14:02:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:01 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:02:01 INFO - Cleaning up... 14:02:01 INFO - Return code: 0 14:02:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:02:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:02:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:01 INFO - 'HOME': '/Users/cltbld', 14:02:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:01 INFO - 'LOGNAME': 'cltbld', 14:02:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:01 INFO - 'MOZ_NO_REMOTE': '1', 14:02:01 INFO - 'NO_EM_RESTART': '1', 14:02:01 INFO - 'PAGER': '/bin/cat', 14:02:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:01 INFO - 'PWD': '/builds/slave/test', 14:02:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:01 INFO - 'SHELL': '/bin/bash', 14:02:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:01 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:01 INFO - 'USER': 'cltbld', 14:02:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:01 INFO - 'XPC_FLAGS': '0x0', 14:02:01 INFO - 'XPC_SERVICE_NAME': '0', 14:02:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:01 INFO - Downloading/unpacking psutil>=3.1.1 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:02:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:05 INFO - Installing collected packages: psutil 14:02:05 INFO - Running setup.py install for psutil 14:02:05 INFO - building 'psutil._psutil_osx' extension 14:02:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:02:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:02:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:02:05 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:02:05 INFO - building 'psutil._psutil_posix' extension 14:02:05 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:02:06 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:02:06 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:02:06 INFO - ^ 14:02:06 INFO - 1 warning generated. 14:02:06 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 14:02:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:02:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:02:06 INFO - Successfully installed psutil 14:02:06 INFO - Cleaning up... 14:02:06 INFO - Return code: 0 14:02:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:02:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:02:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:06 INFO - 'HOME': '/Users/cltbld', 14:02:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:06 INFO - 'LOGNAME': 'cltbld', 14:02:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:06 INFO - 'MOZ_NO_REMOTE': '1', 14:02:06 INFO - 'NO_EM_RESTART': '1', 14:02:06 INFO - 'PAGER': '/bin/cat', 14:02:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:06 INFO - 'PWD': '/builds/slave/test', 14:02:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:06 INFO - 'SHELL': '/bin/bash', 14:02:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:06 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:06 INFO - 'USER': 'cltbld', 14:02:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:06 INFO - 'XPC_FLAGS': '0x0', 14:02:06 INFO - 'XPC_SERVICE_NAME': '0', 14:02:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:02:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:02:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:02:09 INFO - Installing collected packages: mozsystemmonitor 14:02:09 INFO - Running setup.py install for mozsystemmonitor 14:02:09 INFO - Successfully installed mozsystemmonitor 14:02:09 INFO - Cleaning up... 14:02:09 INFO - Return code: 0 14:02:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:02: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')]} 14:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02: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')]} 14:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:02:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:09 INFO - 'HOME': '/Users/cltbld', 14:02:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:09 INFO - 'LOGNAME': 'cltbld', 14:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:09 INFO - 'MOZ_NO_REMOTE': '1', 14:02:09 INFO - 'NO_EM_RESTART': '1', 14:02:09 INFO - 'PAGER': '/bin/cat', 14:02:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:09 INFO - 'PWD': '/builds/slave/test', 14:02:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:09 INFO - 'SHELL': '/bin/bash', 14:02:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:09 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:09 INFO - 'USER': 'cltbld', 14:02:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:09 INFO - 'XPC_FLAGS': '0x0', 14:02:09 INFO - 'XPC_SERVICE_NAME': '0', 14:02:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:09 INFO - Downloading/unpacking jsonschema==2.5.1 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:02:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:02:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:02:12 INFO - warning: no files found matching '*.txt' 14:02:12 INFO - no previously-included directories found matching 'build' 14:02:12 INFO - no previously-included directories found matching 'dist' 14:02:12 INFO - no previously-included directories found matching '.git*' 14:02:12 INFO - Installing collected packages: jsonschema, functools32 14:02:12 INFO - Running setup.py install for functools32 14:02:13 INFO - warning: no files found matching '*.txt' 14:02:13 INFO - no previously-included directories found matching 'build' 14:02:13 INFO - no previously-included directories found matching 'dist' 14:02:13 INFO - no previously-included directories found matching '.git*' 14:02:13 INFO - Successfully installed jsonschema functools32 14:02:13 INFO - Cleaning up... 14:02:13 INFO - Return code: 0 14:02:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:02:13 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')]} 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 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')]} 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 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 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:13 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 14:02:13 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 14:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:13 INFO - 'HOME': '/Users/cltbld', 14:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:13 INFO - 'LOGNAME': 'cltbld', 14:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:13 INFO - 'MOZ_NO_REMOTE': '1', 14:02:13 INFO - 'NO_EM_RESTART': '1', 14:02:13 INFO - 'PAGER': '/bin/cat', 14:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:13 INFO - 'PWD': '/builds/slave/test', 14:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:13 INFO - 'SHELL': '/bin/bash', 14:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:13 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:13 INFO - 'USER': 'cltbld', 14:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:13 INFO - 'XPC_FLAGS': '0x0', 14:02:13 INFO - 'XPC_SERVICE_NAME': '0', 14:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:02:13 INFO - Cleaning up... 14:02:13 INFO - Return code: 0 14:02:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:02:13 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')]} 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 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')]} 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:13 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 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:13 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 14:02:13 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 14:02:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:13 INFO - 'HOME': '/Users/cltbld', 14:02:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:13 INFO - 'LOGNAME': 'cltbld', 14:02:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:13 INFO - 'MOZ_NO_REMOTE': '1', 14:02:13 INFO - 'NO_EM_RESTART': '1', 14:02:13 INFO - 'PAGER': '/bin/cat', 14:02:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:13 INFO - 'PWD': '/builds/slave/test', 14:02:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:13 INFO - 'SHELL': '/bin/bash', 14:02:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:13 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:13 INFO - 'USER': 'cltbld', 14:02:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:13 INFO - 'XPC_FLAGS': '0x0', 14:02:13 INFO - 'XPC_SERVICE_NAME': '0', 14:02:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:13 INFO - Downloading/unpacking blobuploader==1.2.4 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:16 INFO - Downloading blobuploader-1.2.4.tar.gz 14:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:02:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02: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 14:02:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:02:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:02:17 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 14:02:17 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 14:02:17 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 14:02:17 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 14:02:17 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 14:02:17 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 14:02:17 INFO - Downloading docopt-0.6.1.tar.gz 14:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:02:17 INFO - Installing collected packages: blobuploader, requests, docopt 14:02:17 INFO - Running setup.py install for blobuploader 14:02:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:02:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:02:17 INFO - Running setup.py install for requests 14:02:18 INFO - Running setup.py install for docopt 14:02:18 INFO - Successfully installed blobuploader requests docopt 14:02:18 INFO - Cleaning up... 14:02:18 INFO - Return code: 0 14:02:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:18 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')]} 14:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:18 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')]} 14:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:18 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 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:18 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 14:02:18 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 14:02:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:18 INFO - 'HOME': '/Users/cltbld', 14:02:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:18 INFO - 'LOGNAME': 'cltbld', 14:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:18 INFO - 'MOZ_NO_REMOTE': '1', 14:02:18 INFO - 'NO_EM_RESTART': '1', 14:02:18 INFO - 'PAGER': '/bin/cat', 14:02:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:18 INFO - 'PWD': '/builds/slave/test', 14:02:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:18 INFO - 'SHELL': '/bin/bash', 14:02:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:18 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:18 INFO - 'USER': 'cltbld', 14:02:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:18 INFO - 'XPC_FLAGS': '0x0', 14:02:18 INFO - 'XPC_SERVICE_NAME': '0', 14:02:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:18 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-x5NSWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-lSWTCg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-50S6_X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-mn8PcV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-p46Kgl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-mY8YmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-x6Rfdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-yXo4vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-WtBMpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:19 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-f8wQJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:20 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-qCQLjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:20 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-enCAwz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:20 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-aGLk7M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:20 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Z6KomM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:20 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-11tQ1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:20 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-gJVg3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:20 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-JWn0bM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:02:20 INFO - Running setup.py install for manifestparser 14:02:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:02:20 INFO - Running setup.py install for mozcrash 14:02:21 INFO - Running setup.py install for mozdebug 14:02:21 INFO - Running setup.py install for mozdevice 14:02:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozfile 14:02:21 INFO - Running setup.py install for mozhttpd 14:02:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozinfo 14:02:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozInstall 14:02:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:02:21 INFO - Running setup.py install for mozleak 14:02:22 INFO - Running setup.py install for mozlog 14:02:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for moznetwork 14:02:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozprocess 14:02:22 INFO - Running setup.py install for mozprofile 14:02:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozrunner 14:02:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:02:22 INFO - Running setup.py install for mozscreenshot 14:02:23 INFO - Running setup.py install for moztest 14:02:23 INFO - Running setup.py install for mozversion 14:02:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:02:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:02:23 INFO - Cleaning up... 14:02:23 INFO - Return code: 0 14:02:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:02:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:24 INFO - 'HOME': '/Users/cltbld', 14:02:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:24 INFO - 'LOGNAME': 'cltbld', 14:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:24 INFO - 'MOZ_NO_REMOTE': '1', 14:02:24 INFO - 'NO_EM_RESTART': '1', 14:02:24 INFO - 'PAGER': '/bin/cat', 14:02:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:24 INFO - 'PWD': '/builds/slave/test', 14:02:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:24 INFO - 'SHELL': '/bin/bash', 14:02:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:24 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:24 INFO - 'USER': 'cltbld', 14:02:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:24 INFO - 'XPC_FLAGS': '0x0', 14:02:24 INFO - 'XPC_SERVICE_NAME': '0', 14:02:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:02:24 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-2ZMxny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:02:24 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)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:02:24 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-pZvWzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:02:24 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)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:02:24 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-hP4vWY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:02:24 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)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:02:24 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Q8_JaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:02:24 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)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:02:24 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-shQr9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:02:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:02:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:02:24 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-5qb4aH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-u_wUCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:02:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-N7Osbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:02:25 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)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-Ox5cum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:02:25 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)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-WDK2lI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:02:25 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)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-VpVo2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:02:25 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)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-DYLVTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:02:25 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)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-C81KDn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:02:25 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)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-5fmQRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:02:25 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)) 14:02:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:25 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-KvG3IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:02:26 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-fQEkd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:02:26 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)) 14:02:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:02:26 INFO - Running setup.py (path:/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/pip-fp3IRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:02:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:02:29 INFO - Downloading blessings-1.6.tar.gz 14:02:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:02:29 INFO - Installing collected packages: blessings 14:02:29 INFO - Running setup.py install for blessings 14:02:29 INFO - Successfully installed blessings 14:02:29 INFO - Cleaning up... 14:02:29 INFO - Return code: 0 14:02:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:02:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:30 INFO - Reading from file tmpfile_stdout 14:02:30 INFO - Current package versions: 14:02:30 INFO - blessings == 1.6 14:02:30 INFO - blobuploader == 1.2.4 14:02:30 INFO - docopt == 0.6.1 14:02:30 INFO - functools32 == 3.2.3-2 14:02:30 INFO - jsonschema == 2.5.1 14:02:30 INFO - manifestparser == 1.1 14:02:30 INFO - mozInstall == 1.12 14:02:30 INFO - mozcrash == 1.0 14:02:30 INFO - mozdebug == 0.1 14:02:30 INFO - mozdevice == 0.49 14:02:30 INFO - mozfile == 1.2 14:02:30 INFO - mozhttpd == 0.7 14:02:30 INFO - mozinfo == 0.9 14:02:30 INFO - mozleak == 0.1 14:02:30 INFO - mozlog == 3.4 14:02:30 INFO - moznetwork == 0.27 14:02:30 INFO - mozprocess == 0.24 14:02:30 INFO - mozprofile == 0.28 14:02:30 INFO - mozrunner == 6.13 14:02:30 INFO - mozscreenshot == 0.1 14:02:30 INFO - mozsystemmonitor == 0.3 14:02:30 INFO - moztest == 0.8 14:02:30 INFO - mozversion == 1.4 14:02:30 INFO - psutil == 3.1.1 14:02:30 INFO - requests == 1.2.3 14:02:30 INFO - wsgiref == 0.1.2 14:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:30 INFO - 'HOME': '/Users/cltbld', 14:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PAGER': '/bin/cat', 14:02:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:30 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - 'XPC_FLAGS': '0x0', 14:02:30 INFO - 'XPC_SERVICE_NAME': '0', 14:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:02:30 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:02:30 INFO - Cleaning up... 14:02:30 INFO - Return code: 0 14:02:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b469b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b46c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe29857d3c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, '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.ylMDNmuJwC/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.zA3wfA370U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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 14:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:02:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:30 INFO - 'HOME': '/Users/cltbld', 14:02:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:30 INFO - 'LOGNAME': 'cltbld', 14:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:30 INFO - 'MOZ_NO_REMOTE': '1', 14:02:30 INFO - 'NO_EM_RESTART': '1', 14:02:30 INFO - 'PAGER': '/bin/cat', 14:02:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:30 INFO - 'PWD': '/builds/slave/test', 14:02:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:30 INFO - 'SHELL': '/bin/bash', 14:02:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:30 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:30 INFO - 'USER': 'cltbld', 14:02:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:30 INFO - 'XPC_FLAGS': '0x0', 14:02:30 INFO - 'XPC_SERVICE_NAME': '0', 14:02:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:02:31 INFO - Cleaning up... 14:02:31 INFO - Return code: 0 14:02:31 INFO - Running post-action listener: _resource_record_post_action 14:02:31 INFO - Running post-action listener: _start_resource_monitoring 14:02:31 INFO - Starting resource monitoring. 14:02:31 INFO - [mozharness: 2017-03-02 22:02:31.212680Z] Finished create-virtualenv step (success) 14:02:31 INFO - [mozharness: 2017-03-02 22:02:31.213692Z] Running install step. 14:02:31 INFO - Running pre-action listener: _resource_record_pre_action 14:02:31 INFO - Running main action method: install 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:02:31 INFO - Reading from file tmpfile_stdout 14:02:31 INFO - Detecting whether we're running mozinstall >=1.0... 14:02:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:02:31 INFO - Reading from file tmpfile_stdout 14:02:31 INFO - Output received: 14:02:31 INFO - Usage: mozinstall [options] installer 14:02:31 INFO - Options: 14:02:31 INFO - -h, --help show this help message and exit 14:02:31 INFO - -d DEST, --destination=DEST 14:02:31 INFO - Directory to install application into. [default: 14:02:31 INFO - "/builds/slave/test"] 14:02:31 INFO - --app=APP Application being installed. [default: firefox] 14:02:31 INFO - mkdir: /builds/slave/test/build/application 14:02:31 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'] 14:02:31 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 14:02:51 INFO - Reading from file tmpfile_stdout 14:02:51 INFO - Output received: 14:02:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 14:02:51 INFO - Running post-action listener: _resource_record_post_action 14:02:51 INFO - [mozharness: 2017-03-02 22:02:51.467978Z] Finished install step (success) 14:02:51 INFO - [mozharness: 2017-03-02 22:02:51.468150Z] Running run-tests step. 14:02:51 INFO - Running pre-action listener: _resource_record_pre_action 14:02:51 INFO - Running main action method: run_tests 14:02:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:02:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:02:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:02:51 INFO - 2017-03-02 14:02:51.482 screenresolution[1624:7232] starting screenresolution argv=screenresolution get 14:02:51 INFO - 2017-03-02 14:02:51.485 screenresolution[1624:7232] Display 0: 1600x1200x32@60 14:02:51 INFO - 2017-03-02 14:02:51.491 screenresolution[1625:7235] starting screenresolution argv=screenresolution list 14:02:51 INFO - Available Modes on Display 0 14:02:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:02:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:02:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:02:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:02:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:02:51 INFO - Intel Iris: 14:02:51 INFO - Chipset Model: Intel Iris 14:02:51 INFO - Type: GPU 14:02:51 INFO - Bus: Built-In 14:02:51 INFO - VRAM (Dynamic, Max): 1536 MB 14:02:51 INFO - Vendor: Intel (0x8086) 14:02:51 INFO - Device ID: 0x0a2e 14:02:51 INFO - Revision ID: 0x0009 14:02:51 INFO - Displays: 14:02:51 INFO - Display: 14:02:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:02:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:02:51 INFO - Display Serial Number: 1600x1200 60 14:02:51 INFO - Main Display: Yes 14:02:51 INFO - Mirror: Off 14:02:51 INFO - Online: Yes 14:02:51 INFO - Rotation: Supported 14:02:51 INFO - Return code: 0 14:02:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:02:51 INFO - Python 2.7.3 14:02:51 INFO - Return code: 0 14:02:51 INFO - grabbing minidump binary from tooltool 14:02:51 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')]} 14:02:51 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 0x10b247d30>, '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 0x10b16edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b23cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:02:51 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 14:02:51 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 14:02:51 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 14:02:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:02:51 INFO - Return code: 0 14:02:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:02:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:02:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:02:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:02:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:02:51 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/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--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 14:02:51 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/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0202 --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 14:02:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ylMDNmuJwC/Render', 14:02:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:02:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:02:51 INFO - 'HOME': '/Users/cltbld', 14:02:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:02:51 INFO - 'LOGNAME': 'cltbld', 14:02:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:02:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:02:51 INFO - 'MOZ_NO_REMOTE': '1', 14:02:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:02:51 INFO - 'NO_EM_RESTART': '1', 14:02:51 INFO - 'PAGER': '/bin/cat', 14:02:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:02:51 INFO - 'PWD': '/builds/slave/test', 14:02:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:02:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:02:51 INFO - 'SHELL': '/bin/bash', 14:02:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.zA3wfA370U/Listeners', 14:02:51 INFO - 'TMPDIR': '/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/', 14:02:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:02:51 INFO - 'USER': 'cltbld', 14:02:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:02:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:02:51 INFO - 'XPC_FLAGS': '0x0', 14:02:51 INFO - 'XPC_SERVICE_NAME': '0', 14:02:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:02:51 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/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0202', '--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 14:02:52 INFO - mozversion application_buildid: 20170302120652 14:02:52 INFO - mozversion application_changeset: 1c676fbbcdbfeec529f424d6884dce04877ec73f 14:02:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 14:02:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:02:52 INFO - mozversion application_name: Firefox 14:02:52 INFO - mozversion application_remotingname: firefox-dev 14:02:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:02:52 INFO - mozversion application_vendor: Mozilla 14:02:52 INFO - mozversion application_version: 53.0a2 14:02:52 INFO - mozversion platform_buildid: 20170302120652 14:02:52 INFO - mozversion platform_changeset: 1c676fbbcdbfeec529f424d6884dce04877ec73f 14:02:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:02:52 INFO - mozversion platform_version: 53.0a2 14:02:52 INFO - using testdate: 1488492172 14:02:52 INFO - actual date: 1488492172 14:02:52 INFO - starting webserver on 'localhost:49242' 14:02:52 INFO - SUITE-START | Running 2 tests 14:02:52 INFO - TEST-START | dromaeo_css 14:02:52 INFO - operating with platform_type : mac_ 14:02:52 INFO - Initialising browser for dromaeo_css test... 14:02:52 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpziwlAM/profile http://localhost:49242/getInfo.html) 14:02:54 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 14:02:54 INFO - PROCESS | 1635 | colorDepth:24 14:02:54 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 14:02:54 INFO - PROCESS | 1635 | __metrics 14:02:54 INFO - PROCESS | 1635 | 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" 14:02:54 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:02:55 INFO - TEST-INFO | 1635: exit 0 14:02:55 INFO - Browser initialized. 14:02:55 INFO - Running cycle 1/1 for dromaeo_css test... 14:02:55 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmpziwlAM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:03:07 INFO - PROCESS | 1637 | RSS: Main: 212905984 14:03:07 INFO - PROCESS | 1637 | 14:06:10 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 14:06:12 INFO - PROCESS | 1637 | RSS: Main: 346345472 14:06:12 INFO - PROCESS | 1637 | 14:07:57 INFO - PROCESS | 1637 | ************************* 14:07:57 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 14:07:57 INFO - PROCESS | 1637 | 14:07:57 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:07:57 INFO - PROCESS | 1637 | Full stack: 14:07:57 INFO - PROCESS | 1637 | ************************* 14:09:15 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 14:09:15 INFO - PROCESS | 1637 | RSS: Main: 356597760 14:09:15 INFO - PROCESS | 1637 | 14:12:18 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 14:12:18 INFO - PROCESS | 1637 | RSS: Main: 348037120 14:12:18 INFO - PROCESS | 1637 | 14:15:21 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 14:15:21 INFO - PROCESS | 1637 | RSS: Main: 332263424 14:15:21 INFO - PROCESS | 1637 | 14:18:25 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 14:18:26 INFO - PROCESS | 1637 | RSS: Main: 311476224 14:18:26 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 14:21:29 INFO - PROCESS | 1637 | RSS: Main: 361172992 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | __start_tp_report 14:21:29 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 14:21:29 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 14:21:29 INFO - PROCESS | 1637 | |i|pagename|runs| 14:21:29 INFO - PROCESS | 1637 | |0;dojo.html;3338.5326054352386;3379.476181191915;3386.966130338696;3400.9829950850244;3432.0904960185553;5531.9723401383035;5636.239107720457;5701.6864072476;5748.741306641201;5781.595288329819;5670.432956704338;5699.487046165844;5726.31284245891;5746.511546518551;5771.711414429283;5175.560077393426;5228;5229.346331708536;5250.317458730379;5257.737113144347;5139.537441630253;5146.073706732786;5161.561267292284;5167.9224811627855;5325.893482130375;5212.400573933989;5241.580673546107;5262.131748261532;5275.630705850592;5282.815101471449;5257.00116977773;5274.81538146165;5279.181726832367;5283.6037297202865;5318.893622127536;4987.251912213197;5093.083245015896;5195;5199.506046925574;5220;5583.469570390806;5584.6090773645865;5670.177824215507;5682.886342273131;5770.509506691937;6230;6247.062940558907;6275.18422605063;6275.905861412082;6292.716827742763;6180.134781130645;6239.594426362272;6295.307516173218;6297.370262973712;6314.179156709598;5726.284214473191;5750.741216645303;5841.561882858802;5854.824355269348;5868.823935281948;6272.059191121369;6314.778982735582;6329.715162817684;6337.207849018872;6339.746410143634;6022.18700475439;6130.7241174146375;6199.225096862892;6230.408111229426;6234.875302493925;5141.871453213625;6200.720967556471;6201.131841542187;6245.28179259391;6305.936940630627;6217.595856269328;6269.7178626961895;6289.213848268966;6293.590916590407;6298.244210694746;6293.905591416133;6302.180716506917;6320.336364681734;6321.494280457552;6326.557141000178;4851.95148048515;4875.439324477659;4896.2410826321975;4939.234418665113;4948.331975183376;3773.1699026214187;4403.405540252089;4449.310356894686;4485.730856148642;4498.50516443191;5568.7215639217875;5830.7084645767545;5834.3290521589715;5837.824865254049;5840.29916410025;6140.04415716754;6217;6217.533684973645;6221.440070393596;6241.625502469867;5872.559558033165;5889.587728858939;5904.7342869570975;5918.763249469973;5925;5495.505404513533;5501.339839219239;5507.5593952483705;5523.558115350762;5526.281583394133;6220.160278362363;6238.033104868752;6258.186435763413;6262.937370626418;6277.121203031488;6252.406021427957;6252.437280644582;6253.093301471352;6270.561060725706;6298.811035668938;6315.115883776183;6343.207099112611;6367.917454032733;6370.8088757337355;6440.710168042356;5180.507851754077;6050.969745151246;6156.445919867234;6173.166622505904;6177.96911015442;6259.6870156492905;6281.12064311006;6293.748250069946;6304.338044505261;6307.148534947907;5500;5654.462826031685;6174.166487524127;6195.628262304276;6197.318294987638;5956.970215148896;6031.547633927561;6086.300075491198;6103.298120716175;6152;5080.441151473409;5968.104784282393;5988.461038506555;6072.392760723892;6092.512598992159;6201.0388389799655;6211.472024877755;6217.875642487034;6219.689015549295;6227.719752611234;5757.453041961007;5879.059350503899;6051.576389652682;6065.878682426239;6068.969655151696 14:21:29 INFO - PROCESS | 1637 | |1;ext.html;459.7264627546609;495.43767823520295;507.5660310434578;511.08005589938114;514.9562287205588;30954.2261443464;39679.20641587167;41778.74663760092;41915.37126943098;43930.34104488427;43517;43688;43884;43911.78044109783;43964;8368.58157092146;9269.119433653792;9463.716088517322;9464.66873659422;9471.526423678823;8372.455790373637;11022.834657480144;11236.269642473255;11286.209965302432;11472.655820325404;11384.373859437728;11433.771324573503;11440.14198935079;11441.885581144206;11455.770884582304;11308.660740177807;11395.259308144985;11411.657650270423;11424.485898134604;11443.313401195956;8389.62246698894;8610.698625548075;11152.776944461146;11425.143114266462;11471.13966452511;41097.58902410998;41495.755127345925;41504;41529.1694166115;41564.376534352006;3921.313770090251;3949.1904159647493;3953.5058117735284;3979.3235150024566;4052.081101416614;29187;30378.392432151453;30748.8462557688;31226.68773312283;31572.684273157203;3059.3269480714207;3144.371125774854;3148.244421338885;3172.9846449136285;3192.0583427888596;496841;497694;498478;499339;499891;65567.67216163984;65968.01047984284;66004;66069.66965165143;66224.33775662181;69158.65420672865;69180;69227.96158057633;69232.61534769276;69384;16470.258838352303;16508.587285317964;17132.314707411813;17169.7424538632;17188.968661880328;11741.647750567497;13027.08810383264;13055.955523558092;13060.673483162807;13060.934695326652;14726.116433014053;15639.68720625581;15884.76172857408;18182.45452636423;18339.54151146232;7167.462440316997;7542.434317426105;7649.732259370895;7652.846943061108;7743.574103424366;775.8448310337955;852.2202185000779;860.776198188463;874.0385575866623;902.9232515236147;30009.24976875552;30056.098317050524;30091.849540752155;30500.694993049787;30728.53907191394;891.2290868398918;915.0940568836803;1042.2704107125044;1062.6811956413046;1161.9128565357462;14904.62738431548;15404.845951540341;15868.920655396649;15950.122743249001;16122.193890305438;646798;668247;668259;669398;669595;62190.37809621936;62848.68575657184;62901.68549157225;63064.684676576326;63196;1433.7705967045222;1460.2041887171729;1470.4779803169934;1513.356823350094;1517.446132161753;28991.275218118873;30242.697573023986;30519.847400762854;30713.629706853684;31144.377112457172;53878.73060634672;54493.72753136209;54676.726616366665;54733.452665474426;54822;617175.8282417118;621826;623367;624136;625048;42440.787796060824;43227.56772432361;43467.34798977955;43787.78106109449;43835;47224.7638761804;47331.763341183076;47924;48609;48621.756891215315;38466.80766596261;38702.032449189;38915.61084389233;39272.80363598164;40020.79989600033;37099.814500928405;37761.62238377581;38183.809080954416;38418.42372364473;38883.805580971915;36930;37357.252854942206;37949.81025094857;38099.42850857295;38113.618863811;31720.524192136676;33270.667293326755;34154.80458183952;34283.828580856934;34319.485207722406;24303.14938977127;24949.376265593506;24983.000679972596;25146.74853251444;25600.871995639904 14:21:29 INFO - PROCESS | 1637 | |2;jquery.html;369.34625712488895;374.27390861728264;390.14168828577135;398.81853756540767;423.07557985801026;14505.347259373328;14754.114753114807;17106.401275955344;19884.50288742782;20383.796162038376;14886.925565372185;21740.673889891663;22243.44391390216;22323.883805809684;22542.21102261421;5523.6685798851995;5613.933352663002;5701.828945131652;5885.764569417218;5892.027815410452;5829.679367634779;5918;5928.436798504135;5934.376890426508;5964.910526342087;5750.597458177929;5893.64638121712;5902.232709747726;5912.231409916705;5997.6701281429505;5991.610545314541;6082.939170608303;6126.264848218198;6128.019516877278;6139.478144357735;5723.799667011676;5935.139404786325;6028.457438830483;6038.124471951586;6038.879222415571;13558.11872228302;13785.241811700353;14533.854661453355;21116.683249751266;26258.737412625822;2585.5346037713202;2588.7022992355933;2595.666958703938;2603.856787876666;2606.5177942080586;9863.112319891245;9997.400155990665;10166.390016598954;10443.373397596168;10569.207309451745;1648.917554122301;1767.0369648541575;1776.671315806567;1857.823506766855;1860.8046155153784;86997;117535;121370.39314803458;121547;122202;9540.759701238794;10142.543585538668;11403.828942565868;11843.763124737628;12033.759324813454;12669.239845609292;15413.075215487106;15457;15459.227038648247;15471.845281547265;8423.368247381348;8682.565871706389;8736.039035706068;8848.823023539493;8870.895186684738;8253.711120110767;8498.66005359791;8510.957445212734;8715.651373944971;8735.082816304324;4633.837815676435;4723;4739.502352253033;4814.301926220678;4815.3017812417;1963.33246696124;1999.1803360622075;2012.45663670811;2013.0639252747542;2019.7374341335826;962.7496850818837;976.7899901521207;1011.4437059617328;1012.9898701013043;1022.2895087913977;22116.889415552818;22399.552008960054;22468.98889549974;22501.662475062887;22517.099316027503;1018.8064267789097;1027.845823126522;1042.2652030318607;1052.2003277508995;1055.2244100586063;8196.180381961756;10255.641052563124;11481.655550333504;11553.191276610556;11554.94222528882;689977;724062;726817;732087;754488;124037;155264;161750.191249043;165687;167655;890.701614958983;985.669800616787;997.5162046407487;1020.0309705779539;1026.4508487959056;16166;18600.813991859908;19255.748376355492;19470.61058778788;19624.313149039714;36992;57731.4226857726;58153.70923145357;59535.70232148985;60560.394396055475;68924.65537672279;86375.13624863922;88425.67361489453;88670.55664721635;92992;8197.46716463428;8278.461899976483;8341.541215232977;8574.614142363484;8580.570971451278;10451.634192803216;13230.536931207362;13456.529021484592;13574.728505430034;14115.929420352833;5745.1382292656435;9222.985471597985;11062.563354821714;11770.882291176978;11949.581764638197;11420.600278990196;11563.826542601699;11743.17797754149;11966.940165299118;12013.339266340436;9248.89013318406;11486.195966282614;11848.052155827685;11982.221155624857;12114.878851211728;8259.42184047111;8331.12523185081;8443.324534037385;8579.571021449028;8588.184122508352;8146.877796832934;11075.72310692239;11402.657920262405;11422.82865757031;11518.596849110241 14:21:29 INFO - PROCESS | 1637 | |3;mootools.html;1314.3099872566906;1314.4479318686151;1442.4158215922548;1470.5882352941173;1473.609493484227;7303.598302093383;7906;8062.274395304421;8124.431289809716;8281.171882811715;8098.109207987131;8163.510189388626;8175.959120204406;8185.42702010858;8185.427020108595;2295.1966811615885;2341.7775311345395;2342.121704360865;2342.4846533762543;2343.238447504559;2058.4030631117034;2141.5930973115137;2244.820414366855;2325.848819826706;2341.4497593065616;2300.9309720708407;2312.0636142362287;2312.2947501012186;2318.397216723647;2318.733345665253;2248.696425982496;2270.977290227093;2272.45461089339;2274.0676322707777;2283.1095872609694;2269.341890851651;2284.4403121235237;2312.2138472919287;2316.66408370787;2337.9649305260436;8135.95932020342;8202.630881610341;8204.138565450601;8204.958975205085;8231.17688231178;4966.726830024347;5142.04872098663;5143.974280128613;5146.382434107931;5146.996335714537;3209.9197520061953;3375.1562109472634;3450.258194488197;3453.671901169385;3467.063892748969;1108.728361551417;1146.547113890017;1189.7382575833303;1190.422645017166;1204.265398107154;9590.76023099421;10050.296479246455;10543.525541350658;10608.992145746142;10626.096781773636;4452.777361131931;4612.907741845212;4688.343631891538;4695.671303008757;4696.131215725101;8467.49195048299;8622.137786221454;8622.655093796304;8632;8644.092370301154;5082.69503829764;5083.008813281449;5088.72012039334;5092.592592592584;5104.770285337168;4509.143262780127;4675.742834144155;4737.028909073631;4746.406699162605;4756.9762151189025;3417.1457135716073;3468.0289518934737;3534.9469757953652;3577.481265216581;3627.6190999944624;1127.0814286356592;1132.8753837077916;1144.7767685301287;1145.4673576786668;1154.1130252037979;755.1202848681224;850.6980022092192;891.2246345679171;897.7576054465258;912.780932576177;5347.946520534745;5464.1257398816;5496.6701997880255;5790.623609465371;5980.162777211194;874.6894852327332;933.7618907178626;940.4310392212612;968.6584081047799;971.9939862242686;3575.6245594212755;3607.0801945503727;3717.8698745544316;3821.8471261149243;3885.417187421909;9483.620655173716;9816.754581135528;9823.410595364157;9843.507824608741;9845.261605379625;9142.497162655985;9587.041295870496;9660.37207581505;9708.417494950325;9756.658516951873;6621.238557565845;7464.066991626047;7560.9621951889885;7588.772336830014;7597.012388389474;5286.682799032071;5303.36359636846;5303.867403314948;5438.972805135949;5457.61796674229;8681.08848570891;8703.825923481369;8800.339974502065;8872.334574907038;8985.056569060154;8783.868241976248;9064.546772661472;9193.540322983958;9274.350795444525;9297.256219502287;6886.552374095868;7199.208087110309;7204.4956853019785;7216.314450127229;7231.2768723129375;6184.381561843779;6786.93213067863;7400.481966262525;7518.436117291116;7693.769186924401;6988.580685158907;6996;7049.647517624201;7059.011738356531;7086.610236437045;6859.5541289816;6930.13373328334;6939.063226464363;6972.9302706972285;6978.895316570357;6305.873882522232;6422.165118534747;6440.9033864493;6441.806745797634;6449.064885591469;4766.809327626995;4783.162946484282;4918.491569299611;4945.67853089548;5094.821681241138;4861.1979023460735;4896.926546101882;4974;5041.117804384291;5056.544910957884 14:21:29 INFO - PROCESS | 1637 | |4;prototype.html;355.110448326941;358.7506682855415;365.4481732583798;376.3714596623638;377.4319648928362;4571.88570285743;4637.814487420504;5052.772625231864;5382.784688612455;5426.186072089188;5128.230765385194;5140.563052140573;5163.922541161885;5263.894722105556;5281.656692314997;4164.2515939479945;4182.832686692529;4206.810693518799;4207.936880946788;4220.915581688364;4112.362583799516;4163;4207.684423668222;4227.534971153171;4239.7668128252935;3461.732565169805;3811.2087318960043;4012.358022716366;4107;4163.895902602444;4129.834806607747;4161.438205842233;4170.666346692273;4174.895627609334;4178.979105104455;3510.192655689206;3691.3171063353366;3717.7769333839788;3719.8523646134636;3726.9440958385644;4451.577100175478;4888.975555122237;5072.51811077947;5194.818181363672;5236.7905283788605;4348.977990172307;4583.3125031245245;4627.514111018329;4854.2718592211095;4865.464798872156;5662.462066103713;5681.23303354046;5681.545476361881;5684.857878553069;5705.5435565154685;3222.146131275214;3505.1587618971516;3549.6627820357285;3778.905527361838;3935.60643935607;4842.506109353686;5218.739063046871;5235.790568377299;5454.945450545483;5977.790777322816;3421.298633780069;3648.21563363878;4153.293940030202;4233.491980962242;4239.7244179128875;3812.4853144825647;3993.84024639017;4240.257954857888;4253.723882835137;4274.978625106854;4240.681948853849;4353.737416149282;4717.669763116549;4823.879403014953;4832.163777764427;5037.874053148701;5597.633845600438;5646.548276137899;5651.689157096317;5700.37295897451;1101.7906597746403;1238.8079847623633;1307.2613973105165;1380.6272306477397;1394.4840409048718;852.9125365159472;988.8714467119229;994.3735446668552;998.7952469743685;1002.7593377589471;4387.762241256982;4427.1887351532005;4784.354112194809;4887.193613053806;5084.872878178076;4435.733855968652;5582.302212223472;5602.663840169603;5622.32532096151;5628.945434916226;4463.754493502824;4969.155243608595;4972.8508144755715;5022.824201152942;5074.82238121664;2397.1701698482616;2747.4367754610257;2764.525749454227;2870.5934092294624;2948.5871977923107;5327.866803329948;5491.505764481136;5743.731226165724;5784.1779839350465;5795.377294357587;4883.536064073907;5226.320578324793;5690.6870122142855;5710.65736055838;5816.796412125555;4734;4759.74003267074;4942.071053512466;5783.797567085132;5786.826395208066;5235.476452354734;5511.834644960658;5611.466910643646;5612.663240205601;5621.233773371932;4368.366586844953;4971.254311853251;5257.4742525747115;5334.866628334323;5393.516782884738;4854.8786280341865;5556.638818476786;5706.600537962303;5737.827865164052;5766.625169363978;3505.3339865425487;3587.677109060197;3920.29434701745;3972.8609498667406;3978.681705463614;4696.7416792076765;5162.561182299396;5163.974180129076;5367.289518792984;5536.861578460571;5207;5272.7100009499845;5394.433584473573;5395.487428694268;5460.7542660579575;4973.47778483254;4976.452590215146;5125;5325.600579956441;5587.525060369914;5168.8449346519665;5200.843974680765;5212.374515058065;5448.746788238648;5449.5640348772795;5261.736913154404;5329.626926115135;5445.373782014961;5586.804461843816;5602.467765562265;4784.6889952153;4886.462489126122;5414.945850541601;5530.806421775219;5546.972265138648 14:21:29 INFO - PROCESS | 1637 | |5;yui.html;702.6943279673345;720.3984672798214;742.8365759532903;769.0387016229713;828.6768160417438;14181.361838717257;14670.926645366771;15710;15723.921380393082;15731.92134039331;14110;14164.645883852909;14303;14327.570172894804;14343.713125737506;850.6724910909282;868.6481974800184;870.4733636150102;870.6865528409768;873.6942070275385;845.3026253340987;855.2174760094506;856.1908995998783;870.2950610005915;877.1535468273115;915.8214148241095;919.4942781470198;919.843626583479;922.1930810540777;925.2181906289209;915.7115508614799;916.8762217100673;917.3074328881685;917.9586918588612;918.4581097152645;683.9008343790123;684.7603338831419;685.3044160177424;686.2965460403127;686.7459040155125;14714.411423543046;15093.773593396108;15140.167290799001;15545.689086218325;15637.374505019785;13821.723565528633;13952.441902323895;14010.579682609537;14118.152910825384;14215.431382744679;11376.715582110432;11406.258593191416;11422.942885285604;11550.942245288803;12109.455074521667;3565.607783143852;3622.3479773640734;3659.743817932746;3691.9630803692157;3787.6401741834484;100357;108079;108094.45952770185;109114;109864.90135098627;8964.976995081613;9889.802203956024;10210.693679189637;10551.419671918118;11078.723031924104;21573.56852862934;21911.78088219129;22024.559508810056;22037.449063773533;22078.22726204575;7425.1832298447125;7555.320021198118;7556.697732090654;7567.394608431312;7719.614019299125;3717.981410092932;4110.588941105865;4174.415581818548;4210.431591735077;4297.72064815786;3423.298223864102;3532.434810430319;3535.080878971486;3541.451075083366;3543.7519373644113;630.8990561510136;638.8626445314187;646.2793984707018;654.473149114967;654.584338944764;518.0054295752165;592.9673867937305;669.7321071571411;677.4241894389729;689.7275576147393;9715;9848.458334791656;10056.64801731936;10149.949250253701;10181.847272290921;554.5028423257222;558.2352177516827;589.6874656432097;636.9968150159219;680.6721014131682;4716.5990890774665;4963.255511673278;4968;4974.925376119361;4984.501549844987;60802.087968680506;73650;89238.21523569492;92092.53953730188;107944;50049.74975125101;60395;81196.59401702954;85108.57445712732;87478;60296;76179;78987.99999999885;79245.60377198076;80755.7886631701;10384;10823.891761082288;10842.728931776768;10854.511546980562;11186.720331991766;45410;49779;50462.74768626133;53551.66120846854;53678.73160634172;63367;65489.67255163693;66470.66764666146;70152.6492367535;70461.29538704548;12933.224006559636;13137;13219.66950826237;13679.384427700976;13742.519011834538;14378.784318235445;14418.639534011314;14731.116133032052;14936.775948360566;15061.77407338869;10673.89326106729;12507.249565026128;13025.08824382322;13424.530141445002;13425.328733563478;12581.559645412366;13540.46739731767;13900.165990040225;13902.37439315213;14235.652438325118;10946.890531094587;13610.155700101195;13632.755358293125;13789.310534473438;14068.859311406755;10707.304025238334;11218.607348742755;11385.373804440504;11385.601503947322;11808.822867657163;10760.461976900968;11076.446177691245;11204;11258.718532036437;11477.82783258235 14:21:29 INFO - PROCESS | 1637 | __end_tp_report 14:21:29 INFO - PROCESS | 1637 | __start_cc_report 14:21:29 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1425 14:21:29 INFO - PROCESS | 1637 | __end_cc_report 14:21:29 INFO - PROCESS | 1637 | __startTimestamp1488493289830__endTimestamp 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | ------- Summary: start ------- 14:21:29 INFO - PROCESS | 1637 | Number of tests: 6 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5749.90 Median:5956.97 stddev:656.49 (11.0%) stddev-sans-first:630.66 14:21:29 INFO - PROCESS | 1637 | Values: 3338.5 3379.5 3387.0 3401.0 3432.1 5532.0 5636.2 5701.7 5748.7 5781.6 5670.4 5699.5 5726.3 5746.5 5771.7 5175.6 5228.0 5229.3 5250.3 5257.7 5139.5 5146.1 5161.6 5167.9 5325.9 5212.4 5241.6 5262.1 5275.6 5282.8 5257.0 5274.8 5279.2 5283.6 5318.9 4987.3 5093.1 5195.0 5199.5 5220.0 5583.5 5584.6 5670.2 5682.9 5770.5 6230.0 6247.1 6275.2 6275.9 6292.7 6180.1 6239.6 6295.3 6297.4 6314.2 5726.3 5750.7 5841.6 5854.8 5868.8 6272.1 6314.8 6329.7 6337.2 6339.7 6022.2 6130.7 6199.2 6230.4 6234.9 5141.9 6200.7 6201.1 6245.3 6305.9 6217.6 6269.7 6289.2 6293.6 6298.2 6293.9 6302.2 6320.3 6321.5 6326.6 4852.0 4875.4 4896.2 4939.2 4948.3 3773.2 4403.4 4449.3 4485.7 4498.5 5568.7 5830.7 5834.3 5837.8 5840.3 6140.0 6217.0 6217.5 6221.4 6241.6 5872.6 5889.6 5904.7 5918.8 5925.0 5495.5 5501.3 5507.6 5523.6 5526.3 6220.2 6238.0 6258.2 6262.9 6277.1 6252.4 6252.4 6253.1 6270.6 6298.8 6315.1 6343.2 6367.9 6370.8 6440.7 5180.5 6051.0 6156.4 6173.2 6178.0 6259.7 6281.1 6293.7 6304.3 6307.1 5500.0 5654.5 6174.2 6195.6 6197.3 5957.0 6031.5 6086.3 6103.3 6152.0 5080.4 5968.1 5988.5 6072.4 6092.5 6201.0 6211.5 6217.9 6219.7 6227.7 5757.5 5879.1 6051.6 6065.9 6069.0 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:73663.48 Median:21611.00 stddev:160131.78 (741.0%) stddev-sans-first:160486.67 14:21:29 INFO - PROCESS | 1637 | Values: 459.7 495.4 507.6 511.1 515.0 30954.2 39679.2 41778.7 41915.4 43930.3 43517.0 43688.0 43884.0 43911.8 43964.0 8368.6 9269.1 9463.7 9464.7 9471.5 8372.5 11022.8 11236.3 11286.2 11472.7 11384.4 11433.8 11440.1 11441.9 11455.8 11308.7 11395.3 11411.7 11424.5 11443.3 8389.6 8610.7 11152.8 11425.1 11471.1 41097.6 41495.8 41504.0 41529.2 41564.4 3921.3 3949.2 3953.5 3979.3 4052.1 29187.0 30378.4 30748.8 31226.7 31572.7 3059.3 3144.4 3148.2 3173.0 3192.1 496841.0 497694.0 498478.0 499339.0 499891.0 65567.7 65968.0 66004.0 66069.7 66224.3 69158.7 69180.0 69228.0 69232.6 69384.0 16470.3 16508.6 17132.3 17169.7 17189.0 11741.6 13027.1 13056.0 13060.7 13060.9 14726.1 15639.7 15884.8 18182.5 18339.5 7167.5 7542.4 7649.7 7652.8 7743.6 775.8 852.2 860.8 874.0 902.9 30009.2 30056.1 30091.8 30500.7 30728.5 891.2 915.1 1042.3 1062.7 1161.9 14904.6 15404.8 15868.9 15950.1 16122.2 646798.0 668247.0 668259.0 669398.0 669595.0 62190.4 62848.7 62901.7 63064.7 63196.0 1433.8 1460.2 1470.5 1513.4 1517.4 28991.3 30242.7 30519.8 30713.6 31144.4 53878.7 54493.7 54676.7 54733.5 54822.0 617175.8 621826.0 623367.0 624136.0 625048.0 42440.8 43227.6 43467.3 43787.8 43835.0 47224.8 47331.8 47924.0 48609.0 48621.8 38466.8 38702.0 38915.6 39272.8 40020.8 37099.8 37761.6 38183.8 38418.4 38883.8 36930.0 37357.3 37949.8 38099.4 38113.6 31720.5 33270.7 34154.8 34283.8 34319.5 24303.1 24949.4 24983.0 25146.7 25600.9 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:39236.94 Median:2587.12 stddev:120841.77 (4670.9%) stddev-sans-first:121145.52 14:21:29 INFO - PROCESS | 1637 | Values: 369.3 374.3 390.1 398.8 423.1 14505.3 14754.1 17106.4 19884.5 20383.8 14886.9 21740.7 22243.4 22323.9 22542.2 5523.7 5613.9 5701.8 5885.8 5892.0 5829.7 5918.0 5928.4 5934.4 5964.9 5750.6 5893.6 5902.2 5912.2 5997.7 5991.6 6082.9 6126.3 6128.0 6139.5 5723.8 5935.1 6028.5 6038.1 6038.9 13558.1 13785.2 14533.9 21116.7 26258.7 2585.5 2588.7 2595.7 2603.9 2606.5 9863.1 9997.4 10166.4 10443.4 10569.2 1648.9 1767.0 1776.7 1857.8 1860.8 86997.0 117535.0 121370.4 121547.0 122202.0 9540.8 10142.5 11403.8 11843.8 12033.8 12669.2 15413.1 15457.0 15459.2 15471.8 8423.4 8682.6 8736.0 8848.8 8870.9 8253.7 8498.7 8511.0 8715.7 8735.1 4633.8 4723.0 4739.5 4814.3 4815.3 1963.3 1999.2 2012.5 2013.1 2019.7 962.7 976.8 1011.4 1013.0 1022.3 22116.9 22399.6 22469.0 22501.7 22517.1 1018.8 1027.8 1042.3 1052.2 1055.2 8196.2 10255.6 11481.7 11553.2 11554.9 689977.0 724062.0 726817.0 732087.0 754488.0 124037.0 155264.0 161750.2 165687.0 167655.0 890.7 985.7 997.5 1020.0 1026.5 16166.0 18600.8 19255.7 19470.6 19624.3 36992.0 57731.4 58153.7 59535.7 60560.4 68924.7 86375.1 88425.7 88670.6 92992.0 8197.5 8278.5 8341.5 8574.6 8580.6 10451.6 13230.5 13456.5 13574.7 14115.9 5745.1 9223.0 11062.6 11770.9 11949.6 11420.6 11563.8 11743.2 11966.9 12013.3 9248.9 11486.2 11848.1 11982.2 12114.9 8259.4 8331.1 8443.3 8579.6 8588.2 8146.9 11075.7 11402.7 11422.8 11518.6 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5288.91 Median:5303.62 stddev:2833.67 (53.4%) stddev-sans-first:2825.88 14:21:29 INFO - PROCESS | 1637 | Values: 1314.3 1314.4 1442.4 1470.6 1473.6 7303.6 7906.0 8062.3 8124.4 8281.2 8098.1 8163.5 8176.0 8185.4 8185.4 2295.2 2341.8 2342.1 2342.5 2343.2 2058.4 2141.6 2244.8 2325.8 2341.4 2300.9 2312.1 2312.3 2318.4 2318.7 2248.7 2271.0 2272.5 2274.1 2283.1 2269.3 2284.4 2312.2 2316.7 2338.0 8136.0 8202.6 8204.1 8205.0 8231.2 4966.7 5142.0 5144.0 5146.4 5147.0 3209.9 3375.2 3450.3 3453.7 3467.1 1108.7 1146.5 1189.7 1190.4 1204.3 9590.8 10050.3 10543.5 10609.0 10626.1 4452.8 4612.9 4688.3 4695.7 4696.1 8467.5 8622.1 8622.7 8632.0 8644.1 5082.7 5083.0 5088.7 5092.6 5104.8 4509.1 4675.7 4737.0 4746.4 4757.0 3417.1 3468.0 3534.9 3577.5 3627.6 1127.1 1132.9 1144.8 1145.5 1154.1 755.1 850.7 891.2 897.8 912.8 5347.9 5464.1 5496.7 5790.6 5980.2 874.7 933.8 940.4 968.7 972.0 3575.6 3607.1 3717.9 3821.8 3885.4 9483.6 9816.8 9823.4 9843.5 9845.3 9142.5 9587.0 9660.4 9708.4 9756.7 6621.2 7464.1 7561.0 7588.8 7597.0 5286.7 5303.4 5303.9 5439.0 5457.6 8681.1 8703.8 8800.3 8872.3 8985.1 8783.9 9064.5 9193.5 9274.4 9297.3 6886.6 7199.2 7204.5 7216.3 7231.3 6184.4 6786.9 7400.5 7518.4 7693.8 6988.6 6996.0 7049.6 7059.0 7086.6 6859.6 6930.1 6939.1 6972.9 6978.9 6305.9 6422.2 6440.9 6441.8 6449.1 4766.8 4783.2 4918.5 4945.7 5094.8 4861.2 4896.9 4974.0 5041.1 5056.5 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4472.91 Median:4955.61 stddev:1318.46 (26.6%) stddev-sans-first:1285.42 14:21:29 INFO - PROCESS | 1637 | Values: 355.1 358.8 365.4 376.4 377.4 4571.9 4637.8 5052.8 5382.8 5426.2 5128.2 5140.6 5163.9 5263.9 5281.7 4164.3 4182.8 4206.8 4207.9 4220.9 4112.4 4163.0 4207.7 4227.5 4239.8 3461.7 3811.2 4012.4 4107.0 4163.9 4129.8 4161.4 4170.7 4174.9 4179.0 3510.2 3691.3 3717.8 3719.9 3726.9 4451.6 4889.0 5072.5 5194.8 5236.8 4349.0 4583.3 4627.5 4854.3 4865.5 5662.5 5681.2 5681.5 5684.9 5705.5 3222.1 3505.2 3549.7 3778.9 3935.6 4842.5 5218.7 5235.8 5454.9 5977.8 3421.3 3648.2 4153.3 4233.5 4239.7 3812.5 3993.8 4240.3 4253.7 4275.0 4240.7 4353.7 4717.7 4823.9 4832.2 5037.9 5597.6 5646.5 5651.7 5700.4 1101.8 1238.8 1307.3 1380.6 1394.5 852.9 988.9 994.4 998.8 1002.8 4387.8 4427.2 4784.4 4887.2 5084.9 4435.7 5582.3 5602.7 5622.3 5628.9 4463.8 4969.2 4972.9 5022.8 5074.8 2397.2 2747.4 2764.5 2870.6 2948.6 5327.9 5491.5 5743.7 5784.2 5795.4 4883.5 5226.3 5690.7 5710.7 5816.8 4734.0 4759.7 4942.1 5783.8 5786.8 5235.5 5511.8 5611.5 5612.7 5621.2 4368.4 4971.3 5257.5 5334.9 5393.5 4854.9 5556.6 5706.6 5737.8 5766.6 3505.3 3587.7 3920.3 3972.9 3978.7 4696.7 5162.6 5164.0 5367.3 5536.9 5207.0 5272.7 5394.4 5395.5 5460.8 4973.5 4976.5 5125.0 5325.6 5587.5 5168.8 5200.8 5212.4 5448.7 5449.6 5261.7 5329.6 5445.4 5586.8 5602.5 4784.7 4886.5 5414.9 5530.8 5547.0 14:21:29 INFO - PROCESS | 1637 | 14:21:29 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19480.80 Median:3704.97 stddev:27296.11 (736.7%) stddev-sans-first:27336.27 14:21:29 INFO - PROCESS | 1637 | Values: 702.7 720.4 742.8 769.0 828.7 14181.4 14670.9 15710.0 15723.9 15731.9 14110.0 14164.6 14303.0 14327.6 14343.7 850.7 868.6 870.5 870.7 873.7 845.3 855.2 856.2 870.3 877.2 915.8 919.5 919.8 922.2 925.2 915.7 916.9 917.3 918.0 918.5 683.9 684.8 685.3 686.3 686.7 14714.4 15093.8 15140.2 15545.7 15637.4 13821.7 13952.4 14010.6 14118.2 14215.4 11376.7 11406.3 11422.9 11550.9 12109.5 3565.6 3622.3 3659.7 3692.0 3787.6 100357.0 108079.0 108094.5 109114.0 109864.9 8965.0 9889.8 10210.7 10551.4 11078.7 21573.6 21911.8 22024.6 22037.4 22078.2 7425.2 7555.3 7556.7 7567.4 7719.6 3718.0 4110.6 4174.4 4210.4 4297.7 3423.3 3532.4 3535.1 3541.5 3543.8 630.9 638.9 646.3 654.5 654.6 518.0 593.0 669.7 677.4 689.7 9715.0 9848.5 10056.6 10149.9 10181.8 554.5 558.2 589.7 637.0 680.7 4716.6 4963.3 4968.0 4974.9 4984.5 60802.1 73650.0 89238.2 92092.5 107944.0 50049.7 60395.0 81196.6 85108.6 87478.0 60296.0 76179.0 78988.0 79245.6 80755.8 10384.0 10823.9 10842.7 10854.5 11186.7 45410.0 49779.0 50462.7 53551.7 53678.7 63367.0 65489.7 66470.7 70152.6 70461.3 12933.2 13137.0 13219.7 13679.4 13742.5 14378.8 14418.6 14731.1 14936.8 15061.8 10673.9 12507.2 13025.1 13424.5 13425.3 12581.6 13540.5 13900.2 13902.4 14235.7 10946.9 13610.2 13632.8 13789.3 14068.9 10707.3 11218.6 11385.4 11385.6 11808.8 10760.5 11076.4 11204.0 11258.7 11477.8 14:21:29 INFO - PROCESS | 1637 | -------- Summary: end -------- 14:21:29 INFO - PROCESS | 1637 | 14:21:30 INFO - TEST-INFO | 1637: exit 0 14:21:30 INFO - TEST-OK | dromaeo_css | took 1118398ms 14:21:30 INFO - TEST-START | kraken 14:21:30 INFO - operating with platform_type : mac_ 14:21:30 INFO - Initialising browser for kraken test... 14:21:30 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmp6H3cny/profile http://localhost:49242/getInfo.html) 14:21:32 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 14:21:32 INFO - PROCESS | 1647 | colorDepth:24 14:21:32 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 14:21:32 INFO - PROCESS | 1647 | __metrics 14:21:32 INFO - PROCESS | 1647 | 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" 14:21:32 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:21:33 INFO - TEST-INFO | 1647: exit 0 14:21:33 INFO - Browser initialized. 14:21:33 INFO - Running cycle 1/1 for kraken test... 14:21:33 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/T/tmp6H3cny/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:21:45 INFO - PROCESS | 1648 | RSS: Main: 212533248 14:21:45 INFO - PROCESS | 1648 | 14:21:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 14:21:49 INFO - PROCESS | 1648 | RSS: Main: 265502720 14:21:49 INFO - PROCESS | 1648 | 14:21:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 14:21:52 INFO - PROCESS | 1648 | RSS: Main: 274591744 14:21:52 INFO - PROCESS | 1648 | 14:21:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 14:21:56 INFO - PROCESS | 1648 | RSS: Main: 371154944 14:21:56 INFO - PROCESS | 1648 | 14:21:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 14:21:58 INFO - PROCESS | 1648 | RSS: Main: 276619264 14:21:58 INFO - PROCESS | 1648 | 14:22:00 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:22:01 INFO - PROCESS | 1648 | RSS: Main: 278364160 14:22:01 INFO - PROCESS | 1648 | 14:22:04 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 14:22:04 INFO - PROCESS | 1648 | RSS: Main: 318820352 14:22:04 INFO - PROCESS | 1648 | 14:22:07 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 14:22:08 INFO - PROCESS | 1648 | RSS: Main: 320212992 14:22:08 INFO - PROCESS | 1648 | 14:22:11 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 14:22:11 INFO - PROCESS | 1648 | RSS: Main: 316678144 14:22:11 INFO - PROCESS | 1648 | 14:22:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:22:14 INFO - PROCESS | 1648 | RSS: Main: 293658624 14:22:14 INFO - PROCESS | 1648 | 14:22:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:22:16 INFO - PROCESS | 1648 | RSS: Main: 298299392 14:22:16 INFO - PROCESS | 1648 | 14:22:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:22:19 INFO - PROCESS | 1648 | RSS: Main: 302583808 14:22:19 INFO - PROCESS | 1648 | 14:22:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:22:23 INFO - PROCESS | 1648 | RSS: Main: 318529536 14:22:23 INFO - PROCESS | 1648 | 14:22:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:22:26 INFO - PROCESS | 1648 | RSS: Main: 312446976 14:22:26 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 14:22:28 INFO - PROCESS | 1648 | RSS: Main: 356282368 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | __start_tp_report 14:22:28 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 14:22:28 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 14:22:28 INFO - PROCESS | 1648 | |i|pagename|runs| 14:22:28 INFO - PROCESS | 1648 | |0;ai-astar;115;114;112;113;113;114;112;112;113;114 14:22:28 INFO - PROCESS | 1648 | |1;audio-beat-detection;173;137;115;144;109;111;108;108;130;110 14:22:28 INFO - PROCESS | 1648 | |2;audio-dft;186;179;183;185;184;182;184;182;183;185 14:22:28 INFO - PROCESS | 1648 | |3;audio-fft;81;57;58;90;58;58;57;58;92;81 14:22:28 INFO - PROCESS | 1648 | |4;audio-oscillator;87;71;86;71;68;69;81;69;70;83 14:22:28 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;83;87;83;86;83;87;83;86;83 14:22:28 INFO - PROCESS | 1648 | |6;imaging-darkroom;93;93;92;95;93;93;93;96;93;93 14:22:28 INFO - PROCESS | 1648 | |7;imaging-desaturate;86;84;85;96;133;137;85;86;85;86 14:22:28 INFO - PROCESS | 1648 | |8;json-parse-financial;56;53;55;53;56;56;56;56;55;55 14:22:28 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;64;72;69;74;71;70;72;69;69;71 14:22:28 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;86;90;103;101;101;83;84;85;81;89 14:22:28 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;136;153;146;131;136;154;149;145;173;141 14:22:28 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;167;168;169;167;166;163;167;167;167;165 14:22:28 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;62;83;83;83;84;65;65;63;64;65 14:22:28 INFO - PROCESS | 1648 | __end_tp_report 14:22:28 INFO - PROCESS | 1648 | __start_cc_report 14:22:28 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2091 14:22:28 INFO - PROCESS | 1648 | __end_cc_report 14:22:28 INFO - PROCESS | 1648 | __startTimestamp1488493348773__endTimestamp 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | ------- Summary: start ------- 14:22:28 INFO - PROCESS | 1648 | Number of tests: 14 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.50 stddev:1.03 (0.9%) stddev-sans-first:0.87 14:22:28 INFO - PROCESS | 1648 | Values: 115.0 114.0 112.0 113.0 113.0 114.0 112.0 112.0 113.0 114.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:124.50 Median:122.50 stddev:21.57 (17.6%) stddev-sans-first:14.02 14:22:28 INFO - PROCESS | 1648 | Values: 173.0 137.0 115.0 144.0 109.0 111.0 108.0 108.0 130.0 110.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:2.00 (1.1%) stddev-sans-first:1.87 14:22:28 INFO - PROCESS | 1648 | Values: 186.0 179.0 183.0 185.0 184.0 182.0 184.0 182.0 183.0 185.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:69.00 Median:69.50 stddev:15.02 (21.6%) stddev-sans-first:15.29 14:22:28 INFO - PROCESS | 1648 | Values: 81.0 57.0 58.0 90.0 58.0 58.0 57.0 58.0 92.0 81.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:75.50 Median:76.00 stddev:7.75 (10.2%) stddev-sans-first:7.01 14:22:28 INFO - PROCESS | 1648 | Values: 87.0 71.0 86.0 71.0 68.0 69.0 81.0 69.0 70.0 83.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:84.80 Median:86.00 stddev:1.93 (2.2%) stddev-sans-first:1.88 14:22:28 INFO - PROCESS | 1648 | Values: 87.0 83.0 87.0 83.0 86.0 83.0 87.0 83.0 86.0 83.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.00 stddev:1.17 (1.3%) stddev-sans-first:1.24 14:22:28 INFO - PROCESS | 1648 | Values: 93.0 93.0 92.0 95.0 93.0 93.0 93.0 96.0 93.0 93.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:85.50 stddev:20.70 (24.2%) stddev-sans-first:21.62 14:22:28 INFO - PROCESS | 1648 | Values: 86.0 84.0 85.0 96.0 133.0 137.0 85.0 86.0 85.0 86.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:56.00 stddev:1.20 (2.1%) stddev-sans-first:1.22 14:22:28 INFO - PROCESS | 1648 | Values: 56.0 53.0 55.0 53.0 56.0 56.0 56.0 56.0 55.0 55.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:71.00 stddev:2.69 (3.8%) stddev-sans-first:1.72 14:22:28 INFO - PROCESS | 1648 | Values: 64.0 72.0 69.0 74.0 71.0 70.0 72.0 69.0 69.0 71.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:84.50 stddev:8.29 (9.8%) stddev-sans-first:8.64 14:22:28 INFO - PROCESS | 1648 | Values: 86.0 90.0 103.0 101.0 101.0 83.0 84.0 85.0 81.0 89.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:147.50 stddev:12.02 (8.1%) stddev-sans-first:12.15 14:22:28 INFO - PROCESS | 1648 | Values: 136.0 153.0 146.0 131.0 136.0 154.0 149.0 145.0 173.0 141.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.60 Median:167.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 14:22:28 INFO - PROCESS | 1648 | Values: 167.0 168.0 169.0 167.0 166.0 163.0 167.0 167.0 167.0 165.0 14:22:28 INFO - PROCESS | 1648 | 14:22:28 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:74.00 stddev:9.99 (13.5%) stddev-sans-first:9.96 14:22:28 INFO - PROCESS | 1648 | Values: 62.0 83.0 83.0 83.0 84.0 65.0 65.0 63.0 64.0 65.0 14:22:28 INFO - PROCESS | 1648 | -------- Summary: end -------- 14:22:28 INFO - PROCESS | 1648 | 14:22:29 INFO - TEST-INFO | 1648: exit 0 14:22:29 INFO - TEST-OK | kraken | took 59226ms 14:22:29 INFO - SUITE-END | took 1177s 14:22:29 INFO - Completed test suite (00:19:37) 14:22:29 INFO - javascript benchmark 14:22:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.5326054352386, 3379.476181191915, 3386.966130338696, 3400.9829950850244, 3432.0904960185553, 5531.9723401383035, 5636.239107720457, 5701.6864072476, 5748.741306641201, 5781.595288329819, 5670.432956704338, 5699.487046165844, 5726.31284245891, 5746.511546518551, 5771.711414429283, 5175.560077393426, 5228.0, 5229.346331708536, 5250.317458730379, 5257.737113144347, 5139.537441630253, 5146.073706732786, 5161.561267292284, 5167.9224811627855, 5325.893482130375, 5212.400573933989, 5241.580673546107, 5262.131748261532, 5275.630705850592, 5282.815101471449, 5257.00116977773, 5274.81538146165, 5279.181726832367, 5283.6037297202865, 5318.893622127536, 4987.251912213197, 5093.083245015896, 5195.0, 5199.506046925574, 5220.0, 5583.469570390806, 5584.6090773645865, 5670.177824215507, 5682.886342273131, 5770.509506691937, 6230.0, 6247.062940558907, 6275.18422605063, 6275.905861412082, 6292.716827742763, 6180.134781130645, 6239.594426362272, 6295.307516173218, 6297.370262973712, 6314.179156709598, 5726.284214473191, 5750.741216645303, 5841.561882858802, 5854.824355269348, 5868.823935281948, 6272.059191121369, 6314.778982735582, 6329.715162817684, 6337.207849018872, 6339.746410143634, 6022.18700475439, 6130.7241174146375, 6199.225096862892, 6230.408111229426, 6234.875302493925, 5141.871453213625, 6200.720967556471, 6201.131841542187, 6245.28179259391, 6305.936940630627, 6217.595856269328, 6269.7178626961895, 6289.213848268966, 6293.590916590407, 6298.244210694746, 6293.905591416133, 6302.180716506917, 6320.336364681734, 6321.494280457552, 6326.557141000178, 4851.95148048515, 4875.439324477659, 4896.2410826321975, 4939.234418665113, 4948.331975183376, 3773.1699026214187, 4403.405540252089, 4449.310356894686, 4485.730856148642, 4498.50516443191, 5568.7215639217875, 5830.7084645767545, 5834.3290521589715, 5837.824865254049, 5840.29916410025, 6140.04415716754, 6217.0, 6217.533684973645, 6221.440070393596, 6241.625502469867, 5872.559558033165, 5889.587728858939, 5904.7342869570975, 5918.763249469973, 5925.0, 5495.505404513533, 5501.339839219239, 5507.5593952483705, 5523.558115350762, 5526.281583394133, 6220.160278362363, 6238.033104868752, 6258.186435763413, 6262.937370626418, 6277.121203031488, 6252.406021427957, 6252.437280644582, 6253.093301471352, 6270.561060725706, 6298.811035668938, 6315.115883776183, 6343.207099112611, 6367.917454032733, 6370.8088757337355, 6440.710168042356, 5180.507851754077, 6050.969745151246, 6156.445919867234, 6173.166622505904, 6177.96911015442, 6259.6870156492905, 6281.12064311006, 6293.748250069946, 6304.338044505261, 6307.148534947907, 5500.0, 5654.462826031685, 6174.166487524127, 6195.628262304276, 6197.318294987638, 5956.970215148896, 6031.547633927561, 6086.300075491198, 6103.298120716175, 6152.0, 5080.441151473409, 5968.104784282393, 5988.461038506555, 6072.392760723892, 6092.512598992159, 6201.0388389799655, 6211.472024877755, 6217.875642487034, 6219.689015549295, 6227.719752611234, 5757.453041961007, 5879.059350503899, 6051.576389652682, 6065.878682426239, 6068.969655151696], "value": 5707.821272777129, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.7264627546609, 495.43767823520295, 507.5660310434578, 511.08005589938114, 514.9562287205588, 30954.2261443464, 39679.20641587167, 41778.74663760092, 41915.37126943098, 43930.34104488427, 43517.0, 43688.0, 43884.0, 43911.78044109783, 43964.0, 8368.58157092146, 9269.119433653792, 9463.716088517322, 9464.66873659422, 9471.526423678823, 8372.455790373637, 11022.834657480144, 11236.269642473255, 11286.209965302432, 11472.655820325404, 11384.373859437728, 11433.771324573503, 11440.14198935079, 11441.885581144206, 11455.770884582304, 11308.660740177807, 11395.259308144985, 11411.657650270423, 11424.485898134604, 11443.313401195956, 8389.62246698894, 8610.698625548075, 11152.776944461146, 11425.143114266462, 11471.13966452511, 41097.58902410998, 41495.755127345925, 41504.0, 41529.1694166115, 41564.376534352006, 3921.313770090251, 3949.1904159647493, 3953.5058117735284, 3979.3235150024566, 4052.081101416614, 29187.0, 30378.392432151453, 30748.8462557688, 31226.68773312283, 31572.684273157203, 3059.3269480714207, 3144.371125774854, 3148.244421338885, 3172.9846449136285, 3192.0583427888596, 496841.0, 497694.0, 498478.0, 499339.0, 499891.0, 65567.67216163984, 65968.01047984284, 66004.0, 66069.66965165143, 66224.33775662181, 69158.65420672865, 69180.0, 69227.96158057633, 69232.61534769276, 69384.0, 16470.258838352303, 16508.587285317964, 17132.314707411813, 17169.7424538632, 17188.968661880328, 11741.647750567497, 13027.08810383264, 13055.955523558092, 13060.673483162807, 13060.934695326652, 14726.116433014053, 15639.68720625581, 15884.76172857408, 18182.45452636423, 18339.54151146232, 7167.462440316997, 7542.434317426105, 7649.732259370895, 7652.846943061108, 7743.574103424366, 775.8448310337955, 852.2202185000779, 860.776198188463, 874.0385575866623, 902.9232515236147, 30009.24976875552, 30056.098317050524, 30091.849540752155, 30500.694993049787, 30728.53907191394, 891.2290868398918, 915.0940568836803, 1042.2704107125044, 1062.6811956413046, 1161.9128565357462, 14904.62738431548, 15404.845951540341, 15868.920655396649, 15950.122743249001, 16122.193890305438, 646798.0, 668247.0, 668259.0, 669398.0, 669595.0, 62190.37809621936, 62848.68575657184, 62901.68549157225, 63064.684676576326, 63196.0, 1433.7705967045222, 1460.2041887171729, 1470.4779803169934, 1513.356823350094, 1517.446132161753, 28991.275218118873, 30242.697573023986, 30519.847400762854, 30713.629706853684, 31144.377112457172, 53878.73060634672, 54493.72753136209, 54676.726616366665, 54733.452665474426, 54822.0, 617175.8282417118, 621826.0, 623367.0, 624136.0, 625048.0, 42440.787796060824, 43227.56772432361, 43467.34798977955, 43787.78106109449, 43835.0, 47224.7638761804, 47331.763341183076, 47924.0, 48609.0, 48621.756891215315, 38466.80766596261, 38702.032449189, 38915.61084389233, 39272.80363598164, 40020.79989600033, 37099.814500928405, 37761.62238377581, 38183.809080954416, 38418.42372364473, 38883.805580971915, 36930.0, 37357.252854942206, 37949.81025094857, 38099.42850857295, 38113.618863811, 31720.524192136676, 33270.667293326755, 34154.80458183952, 34283.828580856934, 34319.485207722406, 24303.14938977127, 24949.376265593506, 24983.000679972596, 25146.74853251444, 25600.871995639904], "value": 20799.518853457266, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.34625712488895, 374.27390861728264, 390.14168828577135, 398.81853756540767, 423.07557985801026, 14505.347259373328, 14754.114753114807, 17106.401275955344, 19884.50288742782, 20383.796162038376, 14886.925565372185, 21740.673889891663, 22243.44391390216, 22323.883805809684, 22542.21102261421, 5523.6685798851995, 5613.933352663002, 5701.828945131652, 5885.764569417218, 5892.027815410452, 5829.679367634779, 5918.0, 5928.436798504135, 5934.376890426508, 5964.910526342087, 5750.597458177929, 5893.64638121712, 5902.232709747726, 5912.231409916705, 5997.6701281429505, 5991.610545314541, 6082.939170608303, 6126.264848218198, 6128.019516877278, 6139.478144357735, 5723.799667011676, 5935.139404786325, 6028.457438830483, 6038.124471951586, 6038.879222415571, 13558.11872228302, 13785.241811700353, 14533.854661453355, 21116.683249751266, 26258.737412625822, 2585.5346037713202, 2588.7022992355933, 2595.666958703938, 2603.856787876666, 2606.5177942080586, 9863.112319891245, 9997.400155990665, 10166.390016598954, 10443.373397596168, 10569.207309451745, 1648.917554122301, 1767.0369648541575, 1776.671315806567, 1857.823506766855, 1860.8046155153784, 86997.0, 117535.0, 121370.39314803458, 121547.0, 122202.0, 9540.759701238794, 10142.543585538668, 11403.828942565868, 11843.763124737628, 12033.759324813454, 12669.239845609292, 15413.075215487106, 15457.0, 15459.227038648247, 15471.845281547265, 8423.368247381348, 8682.565871706389, 8736.039035706068, 8848.823023539493, 8870.895186684738, 8253.711120110767, 8498.66005359791, 8510.957445212734, 8715.651373944971, 8735.082816304324, 4633.837815676435, 4723.0, 4739.502352253033, 4814.301926220678, 4815.3017812417, 1963.33246696124, 1999.1803360622075, 2012.45663670811, 2013.0639252747542, 2019.7374341335826, 962.7496850818837, 976.7899901521207, 1011.4437059617328, 1012.9898701013043, 1022.2895087913977, 22116.889415552818, 22399.552008960054, 22468.98889549974, 22501.662475062887, 22517.099316027503, 1018.8064267789097, 1027.845823126522, 1042.2652030318607, 1052.2003277508995, 1055.2244100586063, 8196.180381961756, 10255.641052563124, 11481.655550333504, 11553.191276610556, 11554.94222528882, 689977.0, 724062.0, 726817.0, 732087.0, 754488.0, 124037.0, 155264.0, 161750.191249043, 165687.0, 167655.0, 890.701614958983, 985.669800616787, 997.5162046407487, 1020.0309705779539, 1026.4508487959056, 16166.0, 18600.813991859908, 19255.748376355492, 19470.61058778788, 19624.313149039714, 36992.0, 57731.4226857726, 58153.70923145357, 59535.70232148985, 60560.394396055475, 68924.65537672279, 86375.13624863922, 88425.67361489453, 88670.55664721635, 92992.0, 8197.46716463428, 8278.461899976483, 8341.541215232977, 8574.614142363484, 8580.570971451278, 10451.634192803216, 13230.536931207362, 13456.529021484592, 13574.728505430034, 14115.929420352833, 5745.1382292656435, 9222.985471597985, 11062.563354821714, 11770.882291176978, 11949.581764638197, 11420.600278990196, 11563.826542601699, 11743.17797754149, 11966.940165299118, 12013.339266340436, 9248.89013318406, 11486.195966282614, 11848.052155827685, 11982.221155624857, 12114.878851211728, 8259.42184047111, 8331.12523185081, 8443.324534037385, 8579.571021449028, 8588.184122508352, 8146.877796832934, 11075.72310692239, 11402.657920262405, 11422.82865757031, 11518.596849110241], "value": 9712.06441180814, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.3099872566906, 1314.4479318686151, 1442.4158215922548, 1470.5882352941173, 1473.609493484227, 7303.598302093383, 7906.0, 8062.274395304421, 8124.431289809716, 8281.171882811715, 8098.109207987131, 8163.510189388626, 8175.959120204406, 8185.42702010858, 8185.427020108595, 2295.1966811615885, 2341.7775311345395, 2342.121704360865, 2342.4846533762543, 2343.238447504559, 2058.4030631117034, 2141.5930973115137, 2244.820414366855, 2325.848819826706, 2341.4497593065616, 2300.9309720708407, 2312.0636142362287, 2312.2947501012186, 2318.397216723647, 2318.733345665253, 2248.696425982496, 2270.977290227093, 2272.45461089339, 2274.0676322707777, 2283.1095872609694, 2269.341890851651, 2284.4403121235237, 2312.2138472919287, 2316.66408370787, 2337.9649305260436, 8135.95932020342, 8202.630881610341, 8204.138565450601, 8204.958975205085, 8231.17688231178, 4966.726830024347, 5142.04872098663, 5143.974280128613, 5146.382434107931, 5146.996335714537, 3209.9197520061953, 3375.1562109472634, 3450.258194488197, 3453.671901169385, 3467.063892748969, 1108.728361551417, 1146.547113890017, 1189.7382575833303, 1190.422645017166, 1204.265398107154, 9590.76023099421, 10050.296479246455, 10543.525541350658, 10608.992145746142, 10626.096781773636, 4452.777361131931, 4612.907741845212, 4688.343631891538, 4695.671303008757, 4696.131215725101, 8467.49195048299, 8622.137786221454, 8622.655093796304, 8632.0, 8644.092370301154, 5082.69503829764, 5083.008813281449, 5088.72012039334, 5092.592592592584, 5104.770285337168, 4509.143262780127, 4675.742834144155, 4737.028909073631, 4746.406699162605, 4756.9762151189025, 3417.1457135716073, 3468.0289518934737, 3534.9469757953652, 3577.481265216581, 3627.6190999944624, 1127.0814286356592, 1132.8753837077916, 1144.7767685301287, 1145.4673576786668, 1154.1130252037979, 755.1202848681224, 850.6980022092192, 891.2246345679171, 897.7576054465258, 912.780932576177, 5347.946520534745, 5464.1257398816, 5496.6701997880255, 5790.623609465371, 5980.162777211194, 874.6894852327332, 933.7618907178626, 940.4310392212612, 968.6584081047799, 971.9939862242686, 3575.6245594212755, 3607.0801945503727, 3717.8698745544316, 3821.8471261149243, 3885.417187421909, 9483.620655173716, 9816.754581135528, 9823.410595364157, 9843.507824608741, 9845.261605379625, 9142.497162655985, 9587.041295870496, 9660.37207581505, 9708.417494950325, 9756.658516951873, 6621.238557565845, 7464.066991626047, 7560.9621951889885, 7588.772336830014, 7597.012388389474, 5286.682799032071, 5303.36359636846, 5303.867403314948, 5438.972805135949, 5457.61796674229, 8681.08848570891, 8703.825923481369, 8800.339974502065, 8872.334574907038, 8985.056569060154, 8783.868241976248, 9064.546772661472, 9193.540322983958, 9274.350795444525, 9297.256219502287, 6886.552374095868, 7199.208087110309, 7204.4956853019785, 7216.314450127229, 7231.2768723129375, 6184.381561843779, 6786.93213067863, 7400.481966262525, 7518.436117291116, 7693.769186924401, 6988.580685158907, 6996.0, 7049.647517624201, 7059.011738356531, 7086.610236437045, 6859.5541289816, 6930.13373328334, 6939.063226464363, 6972.9302706972285, 6978.895316570357, 6305.873882522232, 6422.165118534747, 6440.9033864493, 6441.806745797634, 6449.064885591469, 4766.809327626995, 4783.162946484282, 4918.491569299611, 4945.67853089548, 5094.821681241138, 4861.1979023460735, 4896.926546101882, 4974.0, 5041.117804384291, 5056.544910957884], "value": 4314.699363406851, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.110448326941, 358.7506682855415, 365.4481732583798, 376.3714596623638, 377.4319648928362, 4571.88570285743, 4637.814487420504, 5052.772625231864, 5382.784688612455, 5426.186072089188, 5128.230765385194, 5140.563052140573, 5163.922541161885, 5263.894722105556, 5281.656692314997, 4164.2515939479945, 4182.832686692529, 4206.810693518799, 4207.936880946788, 4220.915581688364, 4112.362583799516, 4163.0, 4207.684423668222, 4227.534971153171, 4239.7668128252935, 3461.732565169805, 3811.2087318960043, 4012.358022716366, 4107.0, 4163.895902602444, 4129.834806607747, 4161.438205842233, 4170.666346692273, 4174.895627609334, 4178.979105104455, 3510.192655689206, 3691.3171063353366, 3717.7769333839788, 3719.8523646134636, 3726.9440958385644, 4451.577100175478, 4888.975555122237, 5072.51811077947, 5194.818181363672, 5236.7905283788605, 4348.977990172307, 4583.3125031245245, 4627.514111018329, 4854.2718592211095, 4865.464798872156, 5662.462066103713, 5681.23303354046, 5681.545476361881, 5684.857878553069, 5705.5435565154685, 3222.146131275214, 3505.1587618971516, 3549.6627820357285, 3778.905527361838, 3935.60643935607, 4842.506109353686, 5218.739063046871, 5235.790568377299, 5454.945450545483, 5977.790777322816, 3421.298633780069, 3648.21563363878, 4153.293940030202, 4233.491980962242, 4239.7244179128875, 3812.4853144825647, 3993.84024639017, 4240.257954857888, 4253.723882835137, 4274.978625106854, 4240.681948853849, 4353.737416149282, 4717.669763116549, 4823.879403014953, 4832.163777764427, 5037.874053148701, 5597.633845600438, 5646.548276137899, 5651.689157096317, 5700.37295897451, 1101.7906597746403, 1238.8079847623633, 1307.2613973105165, 1380.6272306477397, 1394.4840409048718, 852.9125365159472, 988.8714467119229, 994.3735446668552, 998.7952469743685, 1002.7593377589471, 4387.762241256982, 4427.1887351532005, 4784.354112194809, 4887.193613053806, 5084.872878178076, 4435.733855968652, 5582.302212223472, 5602.663840169603, 5622.32532096151, 5628.945434916226, 4463.754493502824, 4969.155243608595, 4972.8508144755715, 5022.824201152942, 5074.82238121664, 2397.1701698482616, 2747.4367754610257, 2764.525749454227, 2870.5934092294624, 2948.5871977923107, 5327.866803329948, 5491.505764481136, 5743.731226165724, 5784.1779839350465, 5795.377294357587, 4883.536064073907, 5226.320578324793, 5690.6870122142855, 5710.65736055838, 5816.796412125555, 4734.0, 4759.74003267074, 4942.071053512466, 5783.797567085132, 5786.826395208066, 5235.476452354734, 5511.834644960658, 5611.466910643646, 5612.663240205601, 5621.233773371932, 4368.366586844953, 4971.254311853251, 5257.4742525747115, 5334.866628334323, 5393.516782884738, 4854.8786280341865, 5556.638818476786, 5706.600537962303, 5737.827865164052, 5766.625169363978, 3505.3339865425487, 3587.677109060197, 3920.29434701745, 3972.8609498667406, 3978.681705463614, 4696.7416792076765, 5162.561182299396, 5163.974180129076, 5367.289518792984, 5536.861578460571, 5207.0, 5272.7100009499845, 5394.433584473573, 5395.487428694268, 5460.7542660579575, 4973.47778483254, 4976.452590215146, 5125.0, 5325.600579956441, 5587.525060369914, 5168.8449346519665, 5200.843974680765, 5212.374515058065, 5448.746788238648, 5449.5640348772795, 5261.736913154404, 5329.626926115135, 5445.373782014961, 5586.804461843816, 5602.467765562265, 4784.6889952153, 4886.462489126122, 5414.945850541601, 5530.806421775219, 5546.972265138648], "value": 4072.9694866146338, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.6943279673345, 720.3984672798214, 742.8365759532903, 769.0387016229713, 828.6768160417438, 14181.361838717257, 14670.926645366771, 15710.0, 15723.921380393082, 15731.92134039331, 14110.0, 14164.645883852909, 14303.0, 14327.570172894804, 14343.713125737506, 850.6724910909282, 868.6481974800184, 870.4733636150102, 870.6865528409768, 873.6942070275385, 845.3026253340987, 855.2174760094506, 856.1908995998783, 870.2950610005915, 877.1535468273115, 915.8214148241095, 919.4942781470198, 919.843626583479, 922.1930810540777, 925.2181906289209, 915.7115508614799, 916.8762217100673, 917.3074328881685, 917.9586918588612, 918.4581097152645, 683.9008343790123, 684.7603338831419, 685.3044160177424, 686.2965460403127, 686.7459040155125, 14714.411423543046, 15093.773593396108, 15140.167290799001, 15545.689086218325, 15637.374505019785, 13821.723565528633, 13952.441902323895, 14010.579682609537, 14118.152910825384, 14215.431382744679, 11376.715582110432, 11406.258593191416, 11422.942885285604, 11550.942245288803, 12109.455074521667, 3565.607783143852, 3622.3479773640734, 3659.743817932746, 3691.9630803692157, 3787.6401741834484, 100357.0, 108079.0, 108094.45952770185, 109114.0, 109864.90135098627, 8964.976995081613, 9889.802203956024, 10210.693679189637, 10551.419671918118, 11078.723031924104, 21573.56852862934, 21911.78088219129, 22024.559508810056, 22037.449063773533, 22078.22726204575, 7425.1832298447125, 7555.320021198118, 7556.697732090654, 7567.394608431312, 7719.614019299125, 3717.981410092932, 4110.588941105865, 4174.415581818548, 4210.431591735077, 4297.72064815786, 3423.298223864102, 3532.434810430319, 3535.080878971486, 3541.451075083366, 3543.7519373644113, 630.8990561510136, 638.8626445314187, 646.2793984707018, 654.473149114967, 654.584338944764, 518.0054295752165, 592.9673867937305, 669.7321071571411, 677.4241894389729, 689.7275576147393, 9715.0, 9848.458334791656, 10056.64801731936, 10149.949250253701, 10181.847272290921, 554.5028423257222, 558.2352177516827, 589.6874656432097, 636.9968150159219, 680.6721014131682, 4716.5990890774665, 4963.255511673278, 4968.0, 4974.925376119361, 4984.501549844987, 60802.087968680506, 73650.0, 89238.21523569492, 92092.53953730188, 107944.0, 50049.74975125101, 60395.0, 81196.59401702954, 85108.57445712732, 87478.0, 60296.0, 76179.0, 78987.99999999885, 79245.60377198076, 80755.7886631701, 10384.0, 10823.891761082288, 10842.728931776768, 10854.511546980562, 11186.720331991766, 45410.0, 49779.0, 50462.74768626133, 53551.66120846854, 53678.73160634172, 63367.0, 65489.67255163693, 66470.66764666146, 70152.6492367535, 70461.29538704548, 12933.224006559636, 13137.0, 13219.66950826237, 13679.384427700976, 13742.519011834538, 14378.784318235445, 14418.639534011314, 14731.116133032052, 14936.775948360566, 15061.77407338869, 10673.89326106729, 12507.249565026128, 13025.08824382322, 13424.530141445002, 13425.328733563478, 12581.559645412366, 13540.46739731767, 13900.165990040225, 13902.37439315213, 14235.652438325118, 10946.890531094587, 13610.155700101195, 13632.755358293125, 13789.310534473438, 14068.859311406755, 10707.304025238334, 11218.607348742755, 11385.373804440504, 11385.601503947322, 11808.822867657163, 10760.461976900968, 11076.446177691245, 11204.0, 11258.718532036437, 11477.82783258235], "value": 7396.931800980179, "unit": "score"}], "name": "dromaeo_css", "value": 7288.415295923215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 112.0, 113.0, 113.0, 114.0, 112.0, 112.0, 113.0, 114.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 137.0, 115.0, 144.0, 109.0, 111.0, 108.0, 108.0, 130.0, 110.0], "value": 124.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 179.0, 183.0, 185.0, 184.0, 182.0, 184.0, 182.0, 183.0, 185.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 90.0, 58.0, 58.0, 57.0, 58.0, 92.0, 81.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 86.0, 71.0, 68.0, 69.0, 81.0, 69.0, 70.0, 83.0], "value": 75.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 83.0, 86.0, 83.0, 87.0, 83.0, 86.0, 83.0], "value": 84.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 92.0, 95.0, 93.0, 93.0, 93.0, 96.0, 93.0, 93.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 96.0, 133.0, 137.0, 85.0, 86.0, 85.0, 86.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 55.0, 53.0, 56.0, 56.0, 56.0, 56.0, 55.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 69.0, 74.0, 71.0, 70.0, 72.0, 69.0, 69.0, 71.0], "value": 70.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 103.0, 101.0, 101.0, 83.0, 84.0, 85.0, 81.0, 89.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 153.0, 146.0, 131.0, 136.0, 154.0, 149.0, 145.0, 173.0, 141.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 169.0, 167.0, 166.0, 163.0, 167.0, 167.0, 167.0, 165.0], "value": 166.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 83.0, 83.0, 83.0, 84.0, 65.0, 65.0, 63.0, 64.0, 65.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1440.2, "alertThreshold": 2.0}]} 14:22:29 INFO - Return code: 0 14:22:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:22:30 ERROR - # TBPL SUCCESS # 14:22:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:22:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:22:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:22:30 INFO - 2017-03-02 14:22:30.074 screenresolution[1652:9679] starting screenresolution argv=screenresolution get 14:22:30 INFO - 2017-03-02 14:22:30.077 screenresolution[1652:9679] Display 0: 1600x1200x32@60 14:22:30 INFO - 2017-03-02 14:22:30.083 screenresolution[1653:9682] starting screenresolution argv=screenresolution list 14:22:30 INFO - Available Modes on Display 0 14:22:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:22:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:22:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:22:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:22:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:22:30 INFO - Intel Iris: 14:22:30 INFO - Chipset Model: Intel Iris 14:22:30 INFO - Type: GPU 14:22:30 INFO - Bus: Built-In 14:22:30 INFO - VRAM (Dynamic, Max): 1536 MB 14:22:30 INFO - Vendor: Intel (0x8086) 14:22:30 INFO - Device ID: 0x0a2e 14:22:30 INFO - Revision ID: 0x0009 14:22:30 INFO - Displays: 14:22:30 INFO - Display: 14:22:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:22:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:22:30 INFO - Display Serial Number: 1600x1200 60 14:22:30 INFO - Main Display: Yes 14:22:30 INFO - Mirror: Off 14:22:30 INFO - Online: Yes 14:22:30 INFO - Rotation: Supported 14:22:30 INFO - Return code: 0 14:22:30 INFO - Running post-action listener: _resource_record_post_action 14:22:30 INFO - [mozharness: 2017-03-02 22:22:30.325651Z] Finished run-tests step (success) 14:22:30 INFO - Running post-run listener: _resource_record_post_run 14:22:30 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 37979136; Write bytes: 509175296; Read time: 242; Write time: 1578 14:22:30 INFO - TinderboxPrint: CPU usage
53.8% 14:22:30 INFO - TinderboxPrint: I/O read bytes / time
37,979,136 / 242 14:22:30 INFO - TinderboxPrint: I/O write bytes / time
509,175,296 / 1,578 14:22:30 INFO - TinderboxPrint: CPU idle
2,214.9 (46.2%) 14:22:30 INFO - TinderboxPrint: CPU system
959.5 (20.0%) 14:22:30 INFO - TinderboxPrint: CPU user
1,619.2 (33.8%) 14:22:30 INFO - TinderboxPrint: Swap in / out
246,083,584 / 0 14:22:30 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205591040; Write bytes: 198955008; Read time: 15706; Write time: 415 14:22:30 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34354176; Write bytes: 296656896; Read time: 219; Write time: 1115 14:22:30 INFO - Running post-run listener: _upload_blobber_files 14:22:30 INFO - Blob upload gear active. 14:22:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:22:30 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 14:22:30 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'] 14:22:30 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 14:22:31 INFO - (blobuploader) - INFO - Open directory for files ... 14:22:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:22:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:31 INFO - (blobuploader) - INFO - Done attempting. 14:22:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:22:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:32 INFO - (blobuploader) - INFO - Done attempting. 14:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:33 INFO - (blobuploader) - INFO - Done attempting. 14:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:22:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:22:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:22:36 INFO - (blobuploader) - INFO - Done attempting. 14:22:36 INFO - (blobuploader) - INFO - Iteration through files over. 14:22:36 INFO - Return code: 0 14:22:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:22:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:22:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8bd07fe61e1a06bfa08dec9ffc5e7e465dd442968a87e2f5225d844017bc95e0698f1f360bb89f30687a7a4e5c62bdc36d7923affca9d18baf9d56f02fa938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e5ba4a967b2a08145513f137450bbee7cc4858dec6a3e0c83ffa2d5d03d602671483c063b93678d9913e72aa9351aeecdc4c894575408e9ab05a394b051fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32996716235844c7f3f6698c393dc14f194150c4ee5af2a5bfd5e19e403966c596b7471e8f0adfbf5d0161f016d14b0439676e4dba716fa4e3c1b80412bab098", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb2b6776fe517f92484931abe975813fed497cccfd9a567e850622d6ffe71b0643ff502aadf524ebae768670c193f93451e22b2efe8aba95d893647f98f6a1ca"} 14:22:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:22:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:22:36 INFO - Contents: 14:22:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3e8bd07fe61e1a06bfa08dec9ffc5e7e465dd442968a87e2f5225d844017bc95e0698f1f360bb89f30687a7a4e5c62bdc36d7923affca9d18baf9d56f02fa938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e5ba4a967b2a08145513f137450bbee7cc4858dec6a3e0c83ffa2d5d03d602671483c063b93678d9913e72aa9351aeecdc4c894575408e9ab05a394b051fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32996716235844c7f3f6698c393dc14f194150c4ee5af2a5bfd5e19e403966c596b7471e8f0adfbf5d0161f016d14b0439676e4dba716fa4e3c1b80412bab098", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb2b6776fe517f92484931abe975813fed497cccfd9a567e850622d6ffe71b0643ff502aadf524ebae768670c193f93451e22b2efe8aba95d893647f98f6a1ca"} 14:22:36 INFO - Running post-run listener: copy_logs_to_upload_dir 14:22:36 INFO - Copying logs to upload dir... 14:22:36 INFO - mkdir: /builds/slave/test/build/upload/logs 14:22:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.003067 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-02 14:22:36.196313) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 14:22:36.199420) ========= 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.ylMDNmuJwC/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.zA3wfA370U/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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/3e8bd07fe61e1a06bfa08dec9ffc5e7e465dd442968a87e2f5225d844017bc95e0698f1f360bb89f30687a7a4e5c62bdc36d7923affca9d18baf9d56f02fa938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e5ba4a967b2a08145513f137450bbee7cc4858dec6a3e0c83ffa2d5d03d602671483c063b93678d9913e72aa9351aeecdc4c894575408e9ab05a394b051fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32996716235844c7f3f6698c393dc14f194150c4ee5af2a5bfd5e19e403966c596b7471e8f0adfbf5d0161f016d14b0439676e4dba716fa4e3c1b80412bab098", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb2b6776fe517f92484931abe975813fed497cccfd9a567e850622d6ffe71b0643ff502aadf524ebae768670c193f93451e22b2efe8aba95d893647f98f6a1ca"} build_url:https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011290 build_url: 'https://queue.taskcluster.net/v1/task/d8r6Clj7S46llovbAyxwpw/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/3e8bd07fe61e1a06bfa08dec9ffc5e7e465dd442968a87e2f5225d844017bc95e0698f1f360bb89f30687a7a4e5c62bdc36d7923affca9d18baf9d56f02fa938", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/00e5ba4a967b2a08145513f137450bbee7cc4858dec6a3e0c83ffa2d5d03d602671483c063b93678d9913e72aa9351aeecdc4c894575408e9ab05a394b051fb6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/32996716235844c7f3f6698c393dc14f194150c4ee5af2a5bfd5e19e403966c596b7471e8f0adfbf5d0161f016d14b0439676e4dba716fa4e3c1b80412bab098", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/bb2b6776fe517f92484931abe975813fed497cccfd9a567e850622d6ffe71b0643ff502aadf524ebae768670c193f93451e22b2efe8aba95d893647f98f6a1ca"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-02 14:22:36.234206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:22:36.234530) ========= 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.ylMDNmuJwC/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.zA3wfA370U/Listeners TMPDIR=/var/folders/m8/xm1_j30s6pvgt5d6k446cwxc00000w/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.005148 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-02 14:22:36.283366) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 14:22:36.283701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-02 14:22:36.284071) ========= ========= Total master_lag: 0.18 =========