builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1479485010.35 results: success (0) buildid: 20161118040828 builduid: 1aa1d4ab7c794f94a737edcf8e37d62f revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.348789) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.349315) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.349749) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.382591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.382981) ========= 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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-18 08:03:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 57.8M=0s 2016-11-18 08:03:30 (57.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105449 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.514473) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.514822) ========= 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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.026895 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:30.563232) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 08:03:30.563609) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2bKzzOr9Eh/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.KSwPLFxer6/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-18 08:03:30,673 truncating revision to first 12 chars 2016-11-18 08:03:30,674 Setting DEBUG logging. 2016-11-18 08:03:30,674 attempt 1/10 2016-11-18 08:03:30,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/11b5acda902f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 08:03:31,928 unpacking tar archive at: mozilla-beta-11b5acda902f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.545183 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-18 08:03:32.139711) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:32.140082) ========= script_repo_revision: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:32.140522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:32.140810) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 08:03:32.162673) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-18 08:03:32.163057) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2bKzzOr9Eh/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.KSwPLFxer6/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:03:32 INFO - MultiFileLogger online at 20161118 08:03:32 in /builds/slave/test 08:03:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:03:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:03:32 INFO - {'append_to_log': False, 08:03:32 INFO - 'base_work_dir': '/builds/slave/test', 08:03:32 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:03:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:03:32 INFO - 'branch': 'Mozilla-Beta', 08:03:32 INFO - 'buildbot_json_path': 'buildprops.json', 08:03:32 INFO - 'config_files': ('talos/mac_config.py',), 08:03:32 INFO - 'default_actions': ('clobber', 08:03:32 INFO - 'read-buildbot-config', 08:03:32 INFO - 'download-and-extract', 08:03:32 INFO - 'populate-webroot', 08:03:32 INFO - 'create-virtualenv', 08:03:32 INFO - 'install', 08:03:32 INFO - 'run-tests'), 08:03:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:03:32 INFO - 'download_minidump_stackwalk': True, 08:03:32 INFO - 'download_symbols': 'ondemand', 08:03:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:03:32 INFO - 'tooltool.py': '/tools/tooltool.py', 08:03:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:03:32 INFO - '/tools/misc-python/virtualenv.py')}, 08:03:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:03:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:03:32 INFO - 'installer_path': 'installer.exe', 08:03:32 INFO - 'log_level': 'info', 08:03:32 INFO - 'log_name': 'talos', 08:03:32 INFO - 'log_to_console': True, 08:03:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:03:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:03:32 INFO - 'opt_config_files': (), 08:03:32 INFO - 'pip_index': False, 08:03:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:32 INFO - 'cmd': ('bash', 08:03:32 INFO - '-c', 08:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:32 INFO - 'enabled': True, 08:03:32 INFO - 'halt_on_failure': False, 08:03:32 INFO - 'name': 'check_screen_resolution'},), 08:03:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:03:32 INFO - 'cmd': ('bash', 08:03:32 INFO - '-c', 08:03:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:03:32 INFO - 'enabled': True, 08:03:32 INFO - 'halt_on_failure': False, 08:03:32 INFO - 'name': 'check_screen_resolution'},), 08:03:32 INFO - 'run_cmd_checks_enabled': True, 08:03:32 INFO - 'sps_profile': False, 08:03:32 INFO - 'sps_profile_interval': 0, 08:03:32 INFO - 'suite': 'dromaeojs', 08:03:32 INFO - 'system_bits': '32', 08:03:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:03:32 INFO - 'title': 't-yosemite-r7-0022', 08:03:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:03:32 INFO - 'use_talos_json': True, 08:03:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:03:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:03:32 INFO - 'work_dir': 'build'} 08:03:32 INFO - [mozharness: 2016-11-18 16:03:32.392813Z] Running clobber step. 08:03:32 INFO - Running pre-action listener: _resource_record_pre_action 08:03:32 INFO - Running main action method: clobber 08:03:32 INFO - rmtree: /builds/slave/test/build 08:03:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:03:34 INFO - Running post-action listener: _resource_record_post_action 08:03:34 INFO - [mozharness: 2016-11-18 16:03:34.600981Z] Finished clobber step (success) 08:03:34 INFO - [mozharness: 2016-11-18 16:03:34.601175Z] Running read-buildbot-config step. 08:03:34 INFO - Running pre-action listener: _resource_record_pre_action 08:03:34 INFO - Running main action method: read_buildbot_config 08:03:34 INFO - Using buildbot properties: 08:03:34 INFO - { 08:03:34 INFO - "project": "", 08:03:34 INFO - "product": "firefox", 08:03:34 INFO - "script_repo_revision": "production", 08:03:34 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:03:34 INFO - "repository": "", 08:03:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:03:34 INFO - "buildid": "20161118040828", 08:03:34 INFO - "pgo_build": "False", 08:03:34 INFO - "basedir": "/builds/slave/test", 08:03:34 INFO - "buildnumber": 12, 08:03:34 INFO - "slavename": "t-yosemite-r7-0022", 08:03:34 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 08:03:34 INFO - "platform": "yosemite_r7", 08:03:34 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:03:34 INFO - "branch": "mozilla-beta", 08:03:34 INFO - "repo_path": "releases/mozilla-beta", 08:03:34 INFO - "revision": "11b5acda902f5ecb13ab2d451d36c7a9063f2b26", 08:03:34 INFO - "stage_platform": "macosx64", 08:03:34 INFO - "builduid": "1aa1d4ab7c794f94a737edcf8e37d62f", 08:03:34 INFO - "slavebuilddir": "test" 08:03:34 INFO - } 08:03:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 08:03:34 INFO - Running post-action listener: _resource_record_post_action 08:03:34 INFO - [mozharness: 2016-11-18 16:03:34.606691Z] Finished read-buildbot-config step (success) 08:03:34 INFO - [mozharness: 2016-11-18 16:03:34.606913Z] Running download-and-extract step. 08:03:34 INFO - Running pre-action listener: _resource_record_pre_action 08:03:34 INFO - Running main action method: download_and_extract 08:03:34 INFO - mkdir: /builds/slave/test/build/tests 08:03:34 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')]} 08:03:34 INFO - trying https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 08:03:34 INFO - Downloading https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:03:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 08:03:35 INFO - Downloaded 1165 bytes. 08:03:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 08:03:35 INFO - Using the following test package requirements: 08:03:35 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:03:35 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:35 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 08:03:35 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:35 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 08:03:35 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:03:35 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:35 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 08:03:35 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 08:03:35 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:35 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 08:03:35 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:35 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 08:03:35 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:35 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 08:03:35 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 08:03:35 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 08:03:35 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 08:03:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:03:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:03:35 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:03:36 INFO - Expected file size: 16231139 08:03:43 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:03:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 08:03:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 08:03:43 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 08:03:43 INFO - Expected file size: 16231139 08:03:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 08:03:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 08:03:50 INFO - Fetch https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 08:03:51 INFO - Expected file size: 14414089 08:03: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')]} 08:03:51 INFO - trying https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:51 INFO - Downloading https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 08:03:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 08:03:54 INFO - Downloaded 86009518 bytes. 08:03:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:54 INFO - mkdir: /builds/slave/test/properties 08:03:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:03:54 INFO - Writing to file /builds/slave/test/properties/build_url 08:03:54 INFO - Contents: 08:03:54 INFO - build_url:https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg 08:03:54 INFO - Running post-action listener: _resource_record_post_action 08:03:54 INFO - Running post-action listener: set_extra_try_arguments 08:03:54 INFO - [mozharness: 2016-11-18 16:03:54.779111Z] Finished download-and-extract step (success) 08:03:54 INFO - [mozharness: 2016-11-18 16:03:54.779238Z] Running populate-webroot step. 08:03:54 INFO - Running pre-action listener: _resource_record_pre_action 08:03:54 INFO - Running main action method: populate_webroot 08:03:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:03:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:03:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:03:54 INFO - '--tppagecycles', 08:03:54 INFO - '7'], 08:03:54 INFO - 'tests': ['tsvgm']}}, 08:03:54 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:03:54 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:03:54 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:03:54 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:03:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:03:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['damp', 'tps']}, 08:03:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'tests': ['damp', 'tps']}, 08:03:54 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['dromaeo_dom']}, 08:03:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:03:54 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['basic_compositor_video']}, 08:03:54 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:03:54 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['a11yr', 08:03:54 INFO - 'ts_paint', 08:03:54 INFO - 'tpaint', 08:03:54 INFO - 'sessionrestore', 08:03:54 INFO - 'sessionrestore_no_auto_restore', 08:03:54 INFO - 'tabpaint']}, 08:03:54 INFO - 'other-e10s': {'tests': ['a11yr', 08:03:54 INFO - 'ts_paint', 08:03:54 INFO - 'tpaint', 08:03:54 INFO - 'sessionrestore', 08:03:54 INFO - 'sessionrestore_no_auto_restore', 08:03:54 INFO - 'tabpaint']}, 08:03:54 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:03:54 INFO - 'ts_paint', 08:03:54 INFO - 'tpaint', 08:03:54 INFO - 'sessionrestore', 08:03:54 INFO - 'sessionrestore_no_auto_restore', 08:03:54 INFO - 'tabpaint']}, 08:03:54 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:03:54 INFO - 'ts_paint', 08:03:54 INFO - 'tpaint', 08:03:54 INFO - 'sessionrestore', 08:03:54 INFO - 'sessionrestore_no_auto_restore', 08:03:54 INFO - 'tabpaint']}, 08:03:54 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['a11yr', 08:03:54 INFO - 'ts_paint', 08:03:54 INFO - 'tpaint', 08:03:54 INFO - 'sessionrestore', 08:03:54 INFO - 'sessionrestore_no_auto_restore', 08:03:54 INFO - 'tabpaint']}, 08:03:54 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['a11yr', 08:03:54 INFO - 'ts_paint', 08:03:54 INFO - 'tpaint', 08:03:54 INFO - 'sessionrestore', 08:03:54 INFO - 'sessionrestore_no_auto_restore', 08:03:54 INFO - 'tabpaint']}, 08:03:54 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['tsvgx', 08:03:54 INFO - 'tsvgr_opacity', 08:03:54 INFO - 'tart', 08:03:54 INFO - 'tscrollx', 08:03:54 INFO - 'cart']}, 08:03:54 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:03:54 INFO - 'tsvgr_opacity', 08:03:54 INFO - 'tart', 08:03:54 INFO - 'tscrollx', 08:03:54 INFO - 'cart']}, 08:03:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'talos_options': ['--disable-e10s'], 08:03:54 INFO - 'tests': ['tp5o']}, 08:03:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'tests': ['tp5o']}, 08:03:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'talos_options': ['--disable-e10s', 08:03:54 INFO - '--xperf_path', 08:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:54 INFO - 'tests': ['tp5n']}, 08:03:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:03:54 INFO - 'talos_options': ['--xperf_path', 08:03:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:03:54 INFO - 'tests': ['tp5n']}}, 08:03:54 INFO - 'talos.zip': {'path': '', 08:03:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:03:54 INFO - Running post-action listener: _resource_record_post_action 08:03:54 INFO - [mozharness: 2016-11-18 16:03:54.798330Z] Finished populate-webroot step (success) 08:03:54 INFO - [mozharness: 2016-11-18 16:03:54.798462Z] Running create-virtualenv step. 08:03:54 INFO - Running pre-action listener: _resource_record_pre_action 08:03:54 INFO - Running main action method: create_virtualenv 08:03:54 INFO - Creating virtualenv /builds/slave/test/build/venv 08:03:54 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 08:03:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:03:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:03:54 INFO - Using real prefix '/tools/python27' 08:03:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:03:55 INFO - Installing distribute.............................................................................................................................................................................................done. 08:03:58 INFO - Installing pip.................done. 08:03:58 INFO - Return code: 0 08:03:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:03:58 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')]} 08:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:58 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')]} 08:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:58 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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:03:58 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 08:03:58 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 08:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:58 INFO - 'HOME': '/Users/cltbld', 08:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:58 INFO - 'LOGNAME': 'cltbld', 08:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:58 INFO - 'MOZ_NO_REMOTE': '1', 08:03:58 INFO - 'NO_EM_RESTART': '1', 08:03:58 INFO - 'PAGER': '/bin/cat', 08:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:58 INFO - 'PWD': '/builds/slave/test', 08:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:58 INFO - 'SHELL': '/bin/bash', 08:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:03:58 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:58 INFO - 'USER': 'cltbld', 08:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:58 INFO - 'XPC_FLAGS': '0x0', 08:03:58 INFO - 'XPC_SERVICE_NAME': '0', 08:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:58 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 08:03:58 INFO - Cleaning up... 08:03:58 INFO - Return code: 0 08:03:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:03:58 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')]} 08:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:58 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')]} 08:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:03:58 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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:03:58 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 08:03:58 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 08:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:03:58 INFO - 'HOME': '/Users/cltbld', 08:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:03:58 INFO - 'LOGNAME': 'cltbld', 08:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:03:58 INFO - 'MOZ_NO_REMOTE': '1', 08:03:58 INFO - 'NO_EM_RESTART': '1', 08:03:58 INFO - 'PAGER': '/bin/cat', 08:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:03:58 INFO - 'PWD': '/builds/slave/test', 08:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:03:58 INFO - 'SHELL': '/bin/bash', 08:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:03:58 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:03:58 INFO - 'USER': 'cltbld', 08:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:03:58 INFO - 'XPC_FLAGS': '0x0', 08:03:58 INFO - 'XPC_SERVICE_NAME': '0', 08:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:03:59 INFO - Downloading/unpacking psutil>=3.1.1 08:03:59 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 08:03:59 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 08:03:59 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 08:03:59 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 08:03:59 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 08:03:59 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 08:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:04:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:02 INFO - Installing collected packages: psutil 08:04:02 INFO - Running setup.py install for psutil 08:04:02 INFO - building 'psutil._psutil_osx' extension 08:04:02 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 08:04:02 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 08:04:02 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 08:04:02 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 08:04:03 INFO - building 'psutil._psutil_posix' extension 08:04:03 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 08:04:03 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:04:03 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:04:03 INFO - ^ 08:04:03 INFO - 1 warning generated. 08:04:03 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 08:04:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:04:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:04:03 INFO - Successfully installed psutil 08:04:03 INFO - Cleaning up... 08:04:03 INFO - Return code: 0 08:04:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:04:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:04:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:03 INFO - 'HOME': '/Users/cltbld', 08:04:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:03 INFO - 'LOGNAME': 'cltbld', 08:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:03 INFO - 'MOZ_NO_REMOTE': '1', 08:04:03 INFO - 'NO_EM_RESTART': '1', 08:04:03 INFO - 'PAGER': '/bin/cat', 08:04:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:03 INFO - 'PWD': '/builds/slave/test', 08:04:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:03 INFO - 'SHELL': '/bin/bash', 08:04:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:03 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:03 INFO - 'USER': 'cltbld', 08:04:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:03 INFO - 'XPC_FLAGS': '0x0', 08:04:03 INFO - 'XPC_SERVICE_NAME': '0', 08:04:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:04:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:04:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:04:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:04:06 INFO - Installing collected packages: mozsystemmonitor 08:04:06 INFO - Running setup.py install for mozsystemmonitor 08:04:06 INFO - Successfully installed mozsystemmonitor 08:04:06 INFO - Cleaning up... 08:04:06 INFO - Return code: 0 08:04:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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', '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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:04: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 jsonschema==2.5.1 08:04:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:06 INFO - 'HOME': '/Users/cltbld', 08:04:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:06 INFO - 'LOGNAME': 'cltbld', 08:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:06 INFO - 'MOZ_NO_REMOTE': '1', 08:04:06 INFO - 'NO_EM_RESTART': '1', 08:04:06 INFO - 'PAGER': '/bin/cat', 08:04:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:06 INFO - 'PWD': '/builds/slave/test', 08:04:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:06 INFO - 'SHELL': '/bin/bash', 08:04:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:06 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:06 INFO - 'USER': 'cltbld', 08:04:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:06 INFO - 'XPC_FLAGS': '0x0', 08:04:06 INFO - 'XPC_SERVICE_NAME': '0', 08:04:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:06 INFO - Downloading/unpacking jsonschema==2.5.1 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:04:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:09 INFO - Downloading functools32-3.2.3-2.tar.gz 08:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:04:09 INFO - warning: no files found matching '*.txt' 08:04:09 INFO - no previously-included directories found matching 'build' 08:04:09 INFO - no previously-included directories found matching 'dist' 08:04:09 INFO - no previously-included directories found matching '.git*' 08:04:09 INFO - Installing collected packages: jsonschema, functools32 08:04:09 INFO - Running setup.py install for functools32 08:04:09 INFO - warning: no files found matching '*.txt' 08:04:09 INFO - no previously-included directories found matching 'build' 08:04:09 INFO - no previously-included directories found matching 'dist' 08:04:09 INFO - no previously-included directories found matching '.git*' 08:04:09 INFO - Successfully installed jsonschema functools32 08:04:09 INFO - Cleaning up... 08:04:09 INFO - Return code: 0 08:04:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:04: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')]} 08:04:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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')]} 08:04:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04: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', '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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:04: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 functools32==3.2.3-2 08:04:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:09 INFO - 'HOME': '/Users/cltbld', 08:04:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:09 INFO - 'LOGNAME': 'cltbld', 08:04:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:09 INFO - 'MOZ_NO_REMOTE': '1', 08:04:09 INFO - 'NO_EM_RESTART': '1', 08:04:09 INFO - 'PAGER': '/bin/cat', 08:04:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:09 INFO - 'PWD': '/builds/slave/test', 08:04:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:09 INFO - 'SHELL': '/bin/bash', 08:04:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:09 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:09 INFO - 'USER': 'cltbld', 08:04:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:09 INFO - 'XPC_FLAGS': '0x0', 08:04:09 INFO - 'XPC_SERVICE_NAME': '0', 08:04:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:04:10 INFO - Cleaning up... 08:04:10 INFO - Return code: 0 08:04:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:04:10 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')]} 08:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:10 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')]} 08:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:10 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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04:10 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 08:04:10 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 08:04:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:10 INFO - 'HOME': '/Users/cltbld', 08:04:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:10 INFO - 'LOGNAME': 'cltbld', 08:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:10 INFO - 'MOZ_NO_REMOTE': '1', 08:04:10 INFO - 'NO_EM_RESTART': '1', 08:04:10 INFO - 'PAGER': '/bin/cat', 08:04:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:10 INFO - 'PWD': '/builds/slave/test', 08:04:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:10 INFO - 'SHELL': '/bin/bash', 08:04:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:10 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:10 INFO - 'USER': 'cltbld', 08:04:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:10 INFO - 'XPC_FLAGS': '0x0', 08:04:10 INFO - 'XPC_SERVICE_NAME': '0', 08:04:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:10 INFO - Downloading/unpacking blobuploader==1.2.4 08:04:10 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 08:04:10 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 08:04:10 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 08:04:10 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 08:04:10 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 08:04:10 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 08:04:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:04:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:04:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:04:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04: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 08:04:14 INFO - Downloading docopt-0.6.1.tar.gz 08:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:04:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:04:14 INFO - Running setup.py install for blobuploader 08:04:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:04:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:04:14 INFO - Running setup.py install for requests 08:04:14 INFO - Running setup.py install for docopt 08:04:15 INFO - Successfully installed blobuploader requests docopt 08:04:15 INFO - Cleaning up... 08:04:15 INFO - Return code: 0 08:04:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:15 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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04:15 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 08:04:15 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 08:04:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:15 INFO - 'HOME': '/Users/cltbld', 08:04:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:15 INFO - 'LOGNAME': 'cltbld', 08:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:15 INFO - 'MOZ_NO_REMOTE': '1', 08:04:15 INFO - 'NO_EM_RESTART': '1', 08:04:15 INFO - 'PAGER': '/bin/cat', 08:04:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:15 INFO - 'PWD': '/builds/slave/test', 08:04:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:15 INFO - 'SHELL': '/bin/bash', 08:04:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:15 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:15 INFO - 'USER': 'cltbld', 08:04:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:15 INFO - 'XPC_FLAGS': '0x0', 08:04:15 INFO - 'XPC_SERVICE_NAME': '0', 08:04:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:15 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-cXsXRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:15 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-0ocQbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:15 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-T37TeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:15 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-OKTo_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:15 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-J8lM1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-DejUse-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-y41Ceg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-sM52q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-lMNtvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-xl69f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-MsK5zt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-YwukIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-kJ2lHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-kU27Vq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:16 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-JbLps9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:17 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-eQj35_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:17 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-QnKeeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:04:17 INFO - Running setup.py install for manifestparser 08:04:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:04:17 INFO - Running setup.py install for mozcrash 08:04:17 INFO - Running setup.py install for mozdebug 08:04:17 INFO - Running setup.py install for mozdevice 08:04:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:04:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:04:17 INFO - Running setup.py install for mozfile 08:04:18 INFO - Running setup.py install for mozhttpd 08:04:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Running setup.py install for mozinfo 08:04:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Running setup.py install for mozInstall 08:04:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Running setup.py install for mozleak 08:04:18 INFO - Running setup.py install for mozlog 08:04:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Running setup.py install for moznetwork 08:04:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:04:18 INFO - Running setup.py install for mozprocess 08:04:19 INFO - Running setup.py install for mozprofile 08:04:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:04:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:04:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:04:19 INFO - Running setup.py install for mozrunner 08:04:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:04:19 INFO - Running setup.py install for mozscreenshot 08:04:19 INFO - Running setup.py install for moztest 08:04:19 INFO - Running setup.py install for mozversion 08:04:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:04:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:04:19 INFO - Cleaning up... 08:04:19 INFO - Return code: 0 08:04:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:20 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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04:20 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 08:04:20 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 08:04:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:20 INFO - 'HOME': '/Users/cltbld', 08:04:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:20 INFO - 'LOGNAME': 'cltbld', 08:04:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:20 INFO - 'MOZ_NO_REMOTE': '1', 08:04:20 INFO - 'NO_EM_RESTART': '1', 08:04:20 INFO - 'PAGER': '/bin/cat', 08:04:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:20 INFO - 'PWD': '/builds/slave/test', 08:04:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:20 INFO - 'SHELL': '/bin/bash', 08:04:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:20 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:20 INFO - 'USER': 'cltbld', 08:04:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:20 INFO - 'XPC_FLAGS': '0x0', 08:04:20 INFO - 'XPC_SERVICE_NAME': '0', 08:04:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:04:20 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-CLYTKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:04:20 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)) 08:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:04:20 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-UbF8Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:04:20 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-G0B4DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:04:20 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)) 08:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:04:20 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-TLfbWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:04:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:04:20 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-0P0ltF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-NyVzvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-lX8Hcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-o5QJjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-w8AsD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-OfVv5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-_siYXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-gjYYkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:04:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-vS37DK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:04:21 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)) 08:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:04:21 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-3BWsUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-QEWH84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:04:22 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)) 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:04:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-oUyTbj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:04:22 INFO - Running setup.py (path:/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/pip-pG81Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:04:22 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)) 08:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:04:22 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)) 08:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:04:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:22 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 08:04:25 INFO - Downloading blessings-1.6.tar.gz 08:04:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:04:25 INFO - Installing collected packages: blessings 08:04:25 INFO - Running setup.py install for blessings 08:04:25 INFO - Successfully installed blessings 08:04:25 INFO - Cleaning up... 08:04:25 INFO - Return code: 0 08:04:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:04:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:25 INFO - Reading from file tmpfile_stdout 08:04:25 INFO - Current package versions: 08:04:25 INFO - blessings == 1.6 08:04:25 INFO - blobuploader == 1.2.4 08:04:25 INFO - docopt == 0.6.1 08:04:25 INFO - functools32 == 3.2.3-2 08:04:25 INFO - jsonschema == 2.5.1 08:04:25 INFO - manifestparser == 1.1 08:04:25 INFO - mozInstall == 1.12 08:04:25 INFO - mozcrash == 0.17 08:04:25 INFO - mozdebug == 0.1 08:04:25 INFO - mozdevice == 0.48 08:04:25 INFO - mozfile == 1.2 08:04:25 INFO - mozhttpd == 0.7 08:04:25 INFO - mozinfo == 0.9 08:04:25 INFO - mozleak == 0.1 08:04:25 INFO - mozlog == 3.4 08:04:25 INFO - moznetwork == 0.27 08:04:25 INFO - mozprocess == 0.23 08:04:25 INFO - mozprofile == 0.28 08:04:25 INFO - mozrunner == 6.12 08:04:25 INFO - mozscreenshot == 0.1 08:04:25 INFO - mozsystemmonitor == 0.3 08:04:25 INFO - moztest == 0.7 08:04:25 INFO - mozversion == 1.4 08:04:25 INFO - psutil == 3.1.1 08:04:25 INFO - requests == 1.2.3 08:04:25 INFO - wsgiref == 0.1.2 08:04:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:25 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 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04:25 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 08:04:25 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 08:04:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:25 INFO - 'HOME': '/Users/cltbld', 08:04:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:25 INFO - 'LOGNAME': 'cltbld', 08:04:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:25 INFO - 'MOZ_NO_REMOTE': '1', 08:04:25 INFO - 'NO_EM_RESTART': '1', 08:04:25 INFO - 'PAGER': '/bin/cat', 08:04:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:25 INFO - 'PWD': '/builds/slave/test', 08:04:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:25 INFO - 'SHELL': '/bin/bash', 08:04:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:25 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:25 INFO - 'USER': 'cltbld', 08:04:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:25 INFO - 'XPC_FLAGS': '0x0', 08:04:25 INFO - 'XPC_SERVICE_NAME': '0', 08:04:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 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)) 08:04:26 INFO - Cleaning up... 08:04:26 INFO - Return code: 0 08:04:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:04:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:04:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:04:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:04:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103053490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102fc9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd02b4a2bb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, '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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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 08:04:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:04:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:26 INFO - 'HOME': '/Users/cltbld', 08:04:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:26 INFO - 'LOGNAME': 'cltbld', 08:04:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:26 INFO - 'MOZ_NO_REMOTE': '1', 08:04:26 INFO - 'NO_EM_RESTART': '1', 08:04:26 INFO - 'PAGER': '/bin/cat', 08:04:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:26 INFO - 'PWD': '/builds/slave/test', 08:04:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:26 INFO - 'SHELL': '/bin/bash', 08:04:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:26 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:26 INFO - 'USER': 'cltbld', 08:04:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:26 INFO - 'XPC_FLAGS': '0x0', 08:04:26 INFO - 'XPC_SERVICE_NAME': '0', 08:04:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:04:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:04:26 INFO - Cleaning up... 08:04:26 INFO - Return code: 0 08:04:26 INFO - Running post-action listener: _resource_record_post_action 08:04:26 INFO - Running post-action listener: _start_resource_monitoring 08:04:26 INFO - Starting resource monitoring. 08:04:26 INFO - [mozharness: 2016-11-18 16:04:26.388553Z] Finished create-virtualenv step (success) 08:04:26 INFO - [mozharness: 2016-11-18 16:04:26.389372Z] Running install step. 08:04:26 INFO - Running pre-action listener: _resource_record_pre_action 08:04:26 INFO - Running main action method: install 08:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:04:26 INFO - Reading from file tmpfile_stdout 08:04:26 INFO - Detecting whether we're running mozinstall >=1.0... 08:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:04:26 INFO - Reading from file tmpfile_stdout 08:04:26 INFO - Output received: 08:04:26 INFO - Usage: mozinstall [options] installer 08:04:26 INFO - Options: 08:04:26 INFO - -h, --help show this help message and exit 08:04:26 INFO - -d DEST, --destination=DEST 08:04:26 INFO - Directory to install application into. [default: 08:04:26 INFO - "/builds/slave/test"] 08:04:26 INFO - --app=APP Application being installed. [default: firefox] 08:04:26 INFO - mkdir: /builds/slave/test/build/application 08:04:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:04:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:04:48 INFO - Reading from file tmpfile_stdout 08:04:48 INFO - Output received: 08:04:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:04:48 INFO - Running post-action listener: _resource_record_post_action 08:04:48 INFO - [mozharness: 2016-11-18 16:04:48.744865Z] Finished install step (success) 08:04:48 INFO - [mozharness: 2016-11-18 16:04:48.745005Z] Running run-tests step. 08:04:48 INFO - Running pre-action listener: _resource_record_pre_action 08:04:48 INFO - Running main action method: run_tests 08:04:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:04:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:04:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:04:48 INFO - 2016-11-18 08:04:48.759 screenresolution[1630:7742] starting screenresolution argv=screenresolution get 08:04:48 INFO - 2016-11-18 08:04:48.762 screenresolution[1630:7742] Display 0: 1600x1200x32@60 08:04:48 INFO - 2016-11-18 08:04:48.767 screenresolution[1631:7744] starting screenresolution argv=screenresolution list 08:04:48 INFO - Available Modes on Display 0 08:04:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:04:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:04:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:04:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:04:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:04:48 INFO - Intel Iris: 08:04:48 INFO - Chipset Model: Intel Iris 08:04:48 INFO - Type: GPU 08:04:48 INFO - Bus: Built-In 08:04:48 INFO - VRAM (Dynamic, Max): 1536 MB 08:04:48 INFO - Vendor: Intel (0x8086) 08:04:48 INFO - Device ID: 0x0a2e 08:04:48 INFO - Revision ID: 0x0009 08:04:48 INFO - Displays: 08:04:48 INFO - Display: 08:04:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:04:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:04:48 INFO - Display Serial Number: 1600x1200 60 08:04:48 INFO - Main Display: Yes 08:04:48 INFO - Mirror: Off 08:04:48 INFO - Online: Yes 08:04:48 INFO - Rotation: Supported 08:04:49 INFO - Return code: 0 08:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:04:49 INFO - Python 2.7.3 08:04:49 INFO - Return code: 0 08:04:49 INFO - grabbing minidump binary from tooltool 08:04:49 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')]} 08:04:49 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 0x102e67d30>, '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 0x102ccddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102e5fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:04:49 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 08:04:49 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 08:04:49 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 08:04:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:04:49 INFO - Return code: 0 08:04:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:04:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:04:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:04:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:04:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 08:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --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 08:04:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2bKzzOr9Eh/Render', 08:04:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:04:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:04:49 INFO - 'HOME': '/Users/cltbld', 08:04:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:04:49 INFO - 'LOGNAME': 'cltbld', 08:04:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:04:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:04:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:04:49 INFO - 'MOZ_NO_REMOTE': '1', 08:04:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:04:49 INFO - 'NO_EM_RESTART': '1', 08:04:49 INFO - 'PAGER': '/bin/cat', 08:04:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:04:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:04:49 INFO - 'PWD': '/builds/slave/test', 08:04:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:04:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:04:49 INFO - 'SHELL': '/bin/bash', 08:04:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.KSwPLFxer6/Listeners', 08:04:49 INFO - 'TMPDIR': '/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/', 08:04:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:04:49 INFO - 'USER': 'cltbld', 08:04:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:04:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:04:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:04:49 INFO - 'XPC_FLAGS': '0x0', 08:04:49 INFO - 'XPC_SERVICE_NAME': '0', 08:04:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:04:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--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 08:04:49 INFO - mozversion application_buildid: 20161118040828 08:04:49 INFO - mozversion application_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 08:04:49 INFO - mozversion application_display_name: Firefox 08:04:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:04:49 INFO - mozversion application_name: Firefox 08:04:49 INFO - mozversion application_remotingname: firefox 08:04:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:49 INFO - mozversion application_vendor: Mozilla 08:04:49 INFO - mozversion application_version: 51.0 08:04:49 INFO - mozversion platform_buildid: 20161118040828 08:04:49 INFO - mozversion platform_changeset: 11b5acda902f5ecb13ab2d451d36c7a9063f2b26 08:04:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:04:49 INFO - mozversion platform_version: 51.0 08:04:49 INFO - using testdate: 1479485089 08:04:49 INFO - actual date: 1479485089 08:04:49 INFO - starting webserver on 'localhost:49244' 08:04:49 INFO - SUITE-START | Running 2 tests 08:04:49 INFO - TEST-START | dromaeo_css 08:04:49 INFO - operating with platform_type : mac_ 08:04:49 INFO - Initialising browser for dromaeo_css test... 08:04:49 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmp32swxo/profile http://localhost:49244/getInfo.html) 08:04:51 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 08:04:51 INFO - PROCESS | 1641 | colorDepth:24 08:04:51 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 08:04:51 INFO - PROCESS | 1641 | __metrics 08:04:51 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:04:51 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:04:52 INFO - TEST-INFO | 1641: exit 0 08:04:52 INFO - Browser initialized. 08:04:52 INFO - Running cycle 1/1 for dromaeo_css test... 08:04:52 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmp32swxo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:05:04 INFO - PROCESS | 1644 | RSS: Main: 168054784 08:05:04 INFO - PROCESS | 1644 | 08:05:56 INFO - PROCESS | 1644 | 1479485156028 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:08:06 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 08:08:07 INFO - PROCESS | 1644 | RSS: Main: 281935872 08:08:07 INFO - PROCESS | 1644 | 08:11:10 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 08:11:11 INFO - PROCESS | 1644 | RSS: Main: 300834816 08:11:11 INFO - PROCESS | 1644 | 08:14:13 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 08:14:13 INFO - PROCESS | 1644 | RSS: Main: 271220736 08:14:13 INFO - PROCESS | 1644 | 08:17:16 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 08:17:16 INFO - PROCESS | 1644 | RSS: Main: 272228352 08:17:16 INFO - PROCESS | 1644 | 08:20:19 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 08:20:20 INFO - PROCESS | 1644 | RSS: Main: 263151616 08:20:20 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 08:23:23 INFO - PROCESS | 1644 | RSS: Main: 389361664 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | __start_tp_report 08:23:23 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 08:23:23 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 08:23:23 INFO - PROCESS | 1644 | |i|pagename|runs| 08:23:23 INFO - PROCESS | 1644 | |0;dojo.html;3491.0923159978406;3491.4064609016464;3514.191735900743;3534;3562.7506074574776;5602.747876345564;5817.854553636156;5885.4997325227405;5905.143754155651;5919.467247947684;4969.428515720684;5944.405559444053;5962.04607262838;5965.2245208122995;5967.313758917726;5273.525382715565;5297.258383826248;5355.169948657965;5374.167004114349;5375.951689420564;5237.764300606463;5242.030224408478;5249.1338929076655;5406.378266499344;5418.2685337479525;5296.1261391870485;5318.441563635821;5331.813386531472;5336.893262134755;5338.492843179892;5333.333333333353;5340.225667278223;5397.7571009304675;5398.91901621476;5402.945970540283;5186.636935414523;5258.737063146866;5294.444083371268;5332.626716129873;5349.037173308803;5095.847124586231;5784.248047753807;5799.652020878761;5831.446012628836;5842.094475356326;6228.937710622927;6259.843503912393;6271.937280627181;6287.622742635456;6301.905471417932;5965.910511342333;6292.150559674431;6304.621722696653;6309.905351419732;6325.9051114233325;5774.2782152230975;5828.475437210672;5922.526197904157;5945.40545945402;5999.730012149464;6354.332795056545;6366.936330636727;6375.330590287953;6383.489320854414;6397.872042559123;6297.118403423525;6312;6319;6319.9368006320265;6332.620042797447;5261.394939581921;5438.374586922476;6193.969030154911;6197.1324014637985;6278;6224.502039836802;6290.150829637941;6291.370862913764;6299.6850157491945;6309.148264984168;6258.937410625836;6284.4344009039405;6299.496040316763;6311.652859092794;6314.9684251579365;5002.974985125051;5061.645684802103;5095.337606111182;5105.591552675777;5141.331626888481;3618.457231415309;4628.236341003764;4630.027694184192;4670.626349892001;4676.906461870812;5899.380565040609;5957.672328021914;5987;5987.161797348374;5991.340952495222;6136.7948077883175;6174.660393678301;6178.289496707936;6269.937300626935;6286.308506064329;5009.499050094962;5945.554083443759;5988.580799344091;5988.6706231157705;6027.60820546663;5559.527440167551;5581.49766521015;5594.272744543184;5596.076647353222;5609.775608975595;6316.084167795736;6340.904886426615;6447.967760161263;6530.608163510205;6544.018397240452;6206.410391012847;6241.251049874044;6263.279722831932;6308.463780578702;6311.368863113652;6492.902606460812;6509.837254068497;6510.544261901621;6510.902336464862;6539.182602174728;6159.260888693386;6280.937190628218;6323.747050117944;6337.366263373626;6369.490440764635;6184.072389141485;6209.503239740719;6246.094316324198;6294.0558916162945;6302.747890084345;6291.748330066746;6297.992321228581;6305.274893387135;6313.494920406265;6315.494760419064;6260.718267677874;6304.243490780952;6315.652639104894;6316.589421687576;6323.588966717149;5899.085641725539;6030.39696030411;6065;6096.177016102947;6111.174991376285;6167.784127555694;6194.318624951162;6222.968885155546;6245.437910588069;6252.9370007098;5365.65123267002;5796.333421656564;5939.198208241832;6040;6094.177286066324 08:23:23 INFO - PROCESS | 1644 | |1;ext.html;490.21076067531266;504.8687341291263;509.98767446618456;546.3334731627414;566.9143590025102;32483.67516324836;43023.56976430239;44191.67424977256;44422.111557768825;46631.53368466314;45676.77161614187;45803.54196458034;45844.77077614616;45878;45908.77045614767;8942.329325300596;9898.802023959517;10125.544350504208;10268.845967310497;10277.33197342174;9436.575354109082;9674.032596740304;12299.754004919896;12546.81179782304;12571.811422828665;12482.563110291141;12592.622221333375;12597.307148106851;12606.747865042693;12612.68468288291;12504.249745015282;12566.623001309885;12612.495500180028;12617.684557886034;12618.495260189673;12404.19372740769;12475.563355282522;12484;12496.187747796364;12501.437435315433;43118.353224701656;43390.783046084565;43469.34795978063;43495.34756978648;43599.78200109011;3418.8119653419053;3565.8751943681846;3734.2158146789207;3834.983729311735;4115.135821477494;30745.077647670605;31468;31532.211694707585;31786.523202151988;34194.65805341965;3246.8376581170846;3280.6391296957318;3466.94799578004;3474.4788281757687;3496.17839807645;514389;521245;523157;524820;525136;65821;66101;66128.33871661319;66216;66260.33739662541;60746;69458.30541694518;69526.30473695198;69702.30297696959;69981.65009174921;17750;18014.2794288227;18027.2789088435;18048.819511804977;18085.00532470727;12721.936390318175;12999.285039322738;13913.026088173932;13999.16005039701;14011.299435028208;16077.839221607868;17935.641287174443;17953.551161220814;18141.183646735928;18669.253229870654;7362.668679909417;7402.962985185148;7446.7021319146625;7495.625218739041;7496.437767167485;896.4621227263721;997.9151772099308;1003.5433877585826;1033.235405799703;1118.0775859915439;31639.84180079131;31846;31848.681513185034;31859.68140318567;32681.346373072407;1084.6095405653957;1104;1110.4614262083044;1122.354646078508;1183;13491.460341586422;15411.92116551853;16162.676746465006;16172.110533920511;16216;700816;706183;707044;708121;708912;61521.692391537756;61651.458713531625;61690;61857.38142618516;61932.69033654893;1236.505397840871;1293.9158954667917;1310.8033794930645;1352.1076089780697;1473.256005717106;30820.458977051505;32645.836770815993;32726.34547308993;32731.509027364133;33347.166320842174;44675.77662111669;52736.68158296073;53226.73386633042;53513.732431337594;53516.73241633767;581427;585458;586084;588565;882299;24321.39196520101;27135;27180.456390872467;27573.75918083731;28263;48886.75556622194;48983.26525102055;49181.75409122931;49565.50434495609;49610.50389496059;39457;40654.79672601618;41818.37272440855;41923.501857212184;42223;39998.80000599979;40323;40560.59439405568;41285.1742965145;41598.37602436027;39781;40271.39592906168;40845.59154408418;40950.77147685574;41001.179976400905;33432.33135337231;35880.10299742423;35981;36044;36436.27127457489;20432.69350959707;26654.333641659112;26769.33076673099;26939.191824245303;27071.72928270692 08:23:23 INFO - PROCESS | 1644 | |2;jquery.html;375.40310905659993;379.87654012445955;386.94582758413827;391.6572998626202;406.1937054945932;19796.208151673934;21849.126034958583;22503.762293073873;22764.43088922776;22795.886020569873;18346.174422151;21617.56764864702;21677.024533895972;21757.564848703056;21760.891195544;5855.268091488575;6305.0542418637115;6357.332480089593;6362.713677884506;6373.203349581302;4492.640588752892;4570.200214962385;4577.198990176722;6282.591631543958;6285.245770507546;4638.141943740402;7039.929600704004;7047.506674532785;7055.294470552929;7058.082449281586;5869.501092407172;6140.048292514667;6197.5351848611535;7043.190033146177;7048.929510704878;6090.23872015998;6095.664738439384;6096.237970253718;6104.96947515264;6108.083787431877;13018.674533136747;13772.311384430739;13986.720265594631;14118.71762564743;14131.78802317966;2265.399669087693;2309.3187509684685;2373.133806160756;2415.3961509622595;2503.236512863576;10285.794284114276;10407.06336429725;10408.011238932366;10462.738431539196;10642.893571064345;1628.5765700917727;1918.8368988635982;2007.1770574064562;2031.8882461464614;2067.297118979539;95650;115020;116427.417862911;128031.71968280291;129442.99999999905;11299.830502542469;11574.942125289488;11711.941440292743;11747.706307342385;11754.588589399329;15129.697406051817;15131.621709457351;15134.848651513345;15150.469733559272;15176.089434633957;8907.331950103768;9025.548722563846;9054.320925930582;9084.8637270441;9157.221636160868;7725.806854828562;9152.31357648179;9198.126178013077;9257.768555786159;9437.009114043063;4608.216603177468;4637.420322459692;4664.230401983703;4668.696534725232;4725.5983241424865;1895.2040143139914;1937.9709304360447;1939.1952339779116;1943.9902800485906;1944.387517931847;361.74294327212726;394.25682588321223;703.9753608623673;722.6206241723032;912.9041450647719;10296.40405737097;11156.832647510293;11288.0969522438;11362.48868800906;11387;424.73241857630114;428.38954489851835;435.45133132252954;435.6775985770507;440.58364845220956;5611.6071874969175;5719.370869204384;5747.3103227612955;5833.941660583425;5843.18195452637;545272;650666;652893;657946;672893;145675;146228;147607.60170503845;149853.25073374782;151026;414.92738770715005;416.18635567466134;427.09455953379035;432.21768598836206;441.21684010880944;11519.732829388928;11535.76928461443;11588.594399195988;11629.76740465203;12013.939930300643;49290;57202;57236.71381643065;57527.7123614396;58692.532686683175;77802.61098694471;81727.18272817196;82567.5871620638;83814;85073.72389414288;7274.781756547312;7624.351930086005;8319.168083191633;8397.832043358976;8534.359923005675;12875.227486350848;13620.795688064489;13715.913919368462;13734.244616546186;14060.578182654537;10469.790604188025;11638.76722465529;11892.086438822544;11987.700307492383;12037.879621203676;10361.911999240272;11152.776944461228;11412;11691.356975366436;11726.530938762355;11852.348120853436;11854.288742675468;12000.219985700902;12015.459304331502;12039.03687704964;7713.537187768752;7727.652255648397;7815.92184078152;7848.546639478611;7853.764387068397;11205.943970280096;11705.180637355303;11719.238249513754;12072.75854482923;12089 08:23:23 INFO - PROCESS | 1644 | |3;mootools.html;1599.1604407685963;1601.0313760175093;1819;1946.2604210400045;1953.9413817585478;8934.55327233639;9492.477913714743;9494.335396522229;9494.620215191384;9500.049995000505;8337.791555211123;8581.098984606604;8918.108189181079;9169.083091690827;9194.632214711404;2410.5781488239577;2441.7192022917325;2442.1452491627965;2443.3402981195068;2444.7433019532873;2414.95170096598;2433.1848830641757;2450.926472205828;2451.534208500379;2458.21337172105;2428.2836563213896;2434.2453839309783;2442.792362649168;2454.5827209374447;2455.312512496495;2398.6761787158857;2404.0504000919627;2409.7590240975937;2411.7588241175918;2426.7573242675767;2405.819563532742;2406.3984003999;2425.611902095656;2425.854448733082;2434.7686969737847;9262.212711919496;9301.162895339385;9374.484403357812;9374.90625093747;9438.575264113131;4542.432195975503;5685.943140568583;5698.116791897262;5699.857503562403;5704.2299289595785;3572.1782086390276;3686.5207523021836;3750.9624903750887;3750.981245093757;3761.699064074895;1006.0693858181153;1027.1628622672572;1034.7413146713322;1037.6368271105127;1046.3251202974116;10628.787424251472;12536.185147965352;12561.246325220516;12568.434420451102;12590.433430495557;4804.663673542818;4845.442774080955;4881.8771682513225;4990.8752281193265;5016.272640467112;10636.095931845724;10640.840387394195;10641.73395665099;10657.946710266398;10681.519331630096;5612.410696876769;5619.831405057855;5625.156226566048;5630.352509461464;5632.070708333079;4611.031683346468;4611.193041217841;4929.309896614477;5105;5116;3683.557973043198;3904.882853514399;4078.592140785957;4085.1829634073306;4179.477565304337;1122.629532254354;1315.9736805264033;1322.623052430072;1329.6409969308427;1339.1028011232497;916.5142474488532;933.9486328252011;949.857521371786;952.5856252530172;994.9005099489993;5976.312724036791;5982.46157845796;6018.428249316308;6237.875242495215;6242.937570624326;443.1579998003754;445.7793392270847;451.7063908459462;456.5548590124602;461.7160446325553;3727.254549090193;3867.9226415471535;4050.86575758788;4087.5708050654252;4099.8975025624;11054.392008439612;11583.884161158448;11618.128640352008;11619.6514104577;11623.53505859773;9853.359531630422;11530.423478826026;11536.480858361394;11546.884531154581;11554.942225288987;8661.350398720122;8680.522571258514;8686.087960764155;8712.346574006975;8714.172153645393;5818.214541036906;6014.849628759316;6035.245594300713;6194.9778286582205;6217.906731398942;10378.948105259426;10487.423191724529;10489.580416783549;10489.947550262199;10622;10844.728881777703;10923;10934.726631834268;10946.397948112612;10988.670339889815;7764.378849691898;7825.726099586487;7888.053433588007;7907.644156012878;7943.126256111707;8904.73285801427;8995.775105622412;8999.415038022507;9006.63973441055;9008.234300084567;7874.960625196837;7929.801754955942;8081.676732930617;8085.919140808516;8101.675932962851;7754.185810490043;7792.805179870548;7798.844023119619;7830.725924592612;7906.683732650629;7251.456140789356;7268.927310726825;7339.1926888043345;7352.558846469229;7352.852942941218;4897.240927656219;4911.459739428588;5035.29505869186;5066.113430149635;5165.793368265227;5065.758874231777;5072.087024335655;5110.3356563646485;5266.710330931835;5286.682799032071 08:23:23 INFO - PROCESS | 1644 | |4;prototype.html;304.27734131437836;310.0898861840498;311.69765327632194;315.93681263747254;320.89410494536804;5410.486003829635;5570.86072848179;5583.05088135017;5590.357108932474;5590.888182236358;4913.894373765901;5385.623006389555;5437.945620543794;5467.343918729748;5511.366192887819;3929.3713005919058;4082.611672171783;4092.6930480213955;4098.52866920305;4124.237016152021;3794.392897136459;4110.671146308288;4125.443065186191;4172.749635021908;4179.373094035888;3508.982455087734;4053.6149065838845;4082.5100987881347;4100.958990410102;4121.402396652484;3998.7000974926996;4109.116539943911;4140.323169116483;4148.43996060534;4148.854790082363;3596.29872174926;3599.604043555233;3605.1888325126897;3609.512715783388;3616.4575313703153;5315.229291752674;5333.213373519876;5339.919901201485;5372.328458942632;5373.677579345252;4672.509386514401;4776.379070720784;4808.374911261549;4854.393200849894;4867.853964381075;5088.872778180576;5724.8282551523525;5776.855578610526;5796.62321949072;5798.681072541009;3353.6478669739813;3832.0419895026243;4028.4964379452567;4047.797610119482;4050.6961977851483;5347.25138480613;5916.7337469813965;6007.759689612454;6145.324014358417;6162.691865406757;4056.9857535616097;4065.2682517147196;4079.571644977294;4082.3876418537457;4087.8773636790943;4139.544650088488;4149.33610622299;4152.0485371875175;4156.251874662529;4172.4784401949755;4048.7975601219823;4125.958740412618;4788.808447662054;4789.904201915942;4799.568038876448;5836.795712150054;5838.102616649606;5843.444872737083;5878.8836019033115;5879.235699359056;1180.7992641251008;1197.4252358867793;1337.2110454831695;1356.7150898311465;1375.5460697969645;786.7443080998584;823.6993497373415;837.5812093953024;846.4159729786428;847.4745657692271;4663.463701674283;5286.735663216824;5408.8377348679605;5532.5297349724915;5569.27599412082;5162.6902385856965;5374.731263436813;5695.515881150066;5723.427657234243;5995.760169593167;4587.816487340469;4695.366125573004;4936.506349365035;5183.611229157828;5309.41596424393;2385.2605692235115;2774.916752497428;2984.9552256716165;3130.4052230076213;3132.7023932726356;5212.296339994053;5552.861178470571;5872.823815285548;5924.837434336522;6215.34738852423;5144.971005798855;5531.059719847635;5706.857328566736;5759.8560035999435;6031.758729650853;4936.925946110883;5199;5581.609287349927;6170.413810687977;6197.721102550396;5256.658317209369;5570.749316280696;5921.970390148194;5929.258842644669;5932.851678708067;4947.455779864284;5048.242763585492;5343.679379237258;5742.741576629145;5782.624129431573;5465.398806131402;6180.598261113013;6193.38066193377;6198.566100372931;6241.4084408477365;3355.3624811285777;3724.646158614927;3755.779371704262;3795.0132965428634;3966.305896468049;5991.502124468882;6009.399060093956;6012.076135636729;6014.879702406015;6033.87932241344;4939.9259011114145;5095.694258344512;5826.70866456684;5842;5870.442307980735;5029.497050294941;5069.986002799381;5823.7379317929945;5847.590668653153;5884.9705751470965;4799.856004319876;5722.914156287742;5728.705994053353;5737.426257374396;5737.79095048401;4831.492693267297;5095.082885080721;5741.425857414225;5769.221155144001;5776.220210271727;5775.595708300379;5776.140810298929;5786.528083150244;5802.564807639359;5820.447057529528 08:23:23 INFO - PROCESS | 1644 | |5;yui.html;610.8167549735078;728.0462594001855;792.1484404265416;819.614781052905;856.4347530629785;16427.671446571076;17043.914780426112;17072.317107315692;17073.658526829473;17097.57256068599;15170;15267.541973740805;15276.770848437282;15283;15293.158876261801;715.8926161075841;732.5604637217654;735.8197241675797;737.5464089584921;737.7307282841778;745.0686641697878;891.7859713668738;906.5693795447175;913.3743385780729;913.5569248914271;961.0197598449578;977.4575110813496;980.7204946590223;980.9313348065639;982.29274922056;972.2950860626025;974.181687382595;974.1914211204684;976.0727309056354;976.2190247801731;722.3354513847273;722.8734971379987;723.0419693905544;723.8009547374462;723.9022731931227;15436.228188590638;15485.612859678486;15488.922555387151;15489.225538723018;15546.300416481285;13608.319584020759;13656.453741850313;13791.138196343565;13911.513097041656;13931.164130152223;13408.664783380396;13587.796183057262;13842.861571384257;13864.237466939314;13963.162210267315;4639.814407423699;4733.905321893543;4755.310479980418;4769.475357710684;4906.632002599819;122599;123706;124502;124861.37569312187;129809;11147.665570032912;11611.767764644828;11723.648290551297;11758.294502329887;11995.760084798256;21813.709560495918;21975.560488790456;21983.560328793334;22073.779262207492;22153.66769498459;8259.669613215525;8312.709055183039;8338.207870252316;8345.833083338299;8550.828983420297;4514.977425112854;4546.386237857913;4678.836240731558;4719.985203181263;4828.420589529279;3554.662307080823;3663.2124093320062;3667.853285868589;3671.5594128704724;3678.889633311005;640.6412409050853;649.2112083818183;687.9965600171967;688.4629988608893;688.7245101959256;565.4995329133664;575.5481946671842;578.2338401617873;603.4448307557058;694.6630884021246;8835.293176545862;9285.767855803659;9453.810923781486;9721.854172187423;9911.950440247752;562.9915551266735;576.3688760806909;587.8589138606703;634.0995785983914;655.452696998012;3723.9813800931365;4865.172920603506;4926.310316555685;4975.427825800007;4980.327655766498;131543;143573;145214;145245;150835.24582377236;103308;120165.39917300358;123792;126328;126730;78116.21883781203;98464.01535984692;103043;103119.48440257901;106605;9305.86041209396;9449.43303401798;9481.810363792823;9488.430694158373;9497.905020949702;55677.88644227174;56756.43243567512;57301.140482891955;58342;60253.39746602478;83520;85146.57426712826;86661;89975;90587.54706226691;12244.816327755269;13207.405666745211;13393.66515837112;13478.73042539124;13691.726165476834;12838.68486637374;15530.922345388653;15982.760258595898;16673.5831604206;16892.493225203263;14322.212278324792;14850.40598376053;14923.104613723212;15567.688646227238;15665;12313.507459701512;14019.859801401855;14048.157110573398;14860.479883204036;14913.478028268959;13762.93118534441;14371.784423233868;14540.054896431699;14688.41246350134;14755.409783608964;11520.88479115198;11666.650000499998;11767.764644706887;11846.052315814542;12796.744065118459;12013.399330033288;12076.879231207575;12162.087843411957;12182.867748679211;12243.142979991315 08:23:23 INFO - PROCESS | 1644 | __end_tp_report 08:23:23 INFO - PROCESS | 1644 | __start_cc_report 08:23:23 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,1193 08:23:23 INFO - PROCESS | 1644 | __end_cc_report 08:23:23 INFO - PROCESS | 1644 | __startTimestamp1479486203485__endTimestamp 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | ------- Summary: start ------- 08:23:23 INFO - PROCESS | 1644 | Number of tests: 6 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:5833.39 Median:6030.40 stddev:644.76 (10.7%) stddev-sans-first:620.00 08:23:23 INFO - PROCESS | 1644 | Values: 3491.1 3491.4 3514.2 3534.0 3562.8 5602.7 5817.9 5885.5 5905.1 5919.5 4969.4 5944.4 5962.0 5965.2 5967.3 5273.5 5297.3 5355.2 5374.2 5376.0 5237.8 5242.0 5249.1 5406.4 5418.3 5296.1 5318.4 5331.8 5336.9 5338.5 5333.3 5340.2 5397.8 5398.9 5402.9 5186.6 5258.7 5294.4 5332.6 5349.0 5095.8 5784.2 5799.7 5831.4 5842.1 6228.9 6259.8 6271.9 6287.6 6301.9 5965.9 6292.2 6304.6 6309.9 6325.9 5774.3 5828.5 5922.5 5945.4 5999.7 6354.3 6366.9 6375.3 6383.5 6397.9 6297.1 6312.0 6319.0 6319.9 6332.6 5261.4 5438.4 6194.0 6197.1 6278.0 6224.5 6290.2 6291.4 6299.7 6309.1 6258.9 6284.4 6299.5 6311.7 6315.0 5003.0 5061.6 5095.3 5105.6 5141.3 3618.5 4628.2 4630.0 4670.6 4676.9 5899.4 5957.7 5987.0 5987.2 5991.3 6136.8 6174.7 6178.3 6269.9 6286.3 5009.5 5945.6 5988.6 5988.7 6027.6 5559.5 5581.5 5594.3 5596.1 5609.8 6316.1 6340.9 6448.0 6530.6 6544.0 6206.4 6241.3 6263.3 6308.5 6311.4 6492.9 6509.8 6510.5 6510.9 6539.2 6159.3 6280.9 6323.7 6337.4 6369.5 6184.1 6209.5 6246.1 6294.1 6302.7 6291.7 6298.0 6305.3 6313.5 6315.5 6260.7 6304.2 6315.7 6316.6 6323.6 5899.1 6030.4 6065.0 6096.2 6111.2 6167.8 6194.3 6223.0 6245.4 6252.9 5365.7 5796.3 5939.2 6040.0 6094.2 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:76380.89 Median:36240.14 stddev:169379.53 (467.4%) stddev-sans-first:169758.84 08:23:23 INFO - PROCESS | 1644 | Values: 490.2 504.9 510.0 546.3 566.9 32483.7 43023.6 44191.7 44422.1 46631.5 45676.8 45803.5 45844.8 45878.0 45908.8 8942.3 9898.8 10125.5 10268.8 10277.3 9436.6 9674.0 12299.8 12546.8 12571.8 12482.6 12592.6 12597.3 12606.7 12612.7 12504.2 12566.6 12612.5 12617.7 12618.5 12404.2 12475.6 12484.0 12496.2 12501.4 43118.4 43390.8 43469.3 43495.3 43599.8 3418.8 3565.9 3734.2 3835.0 4115.1 30745.1 31468.0 31532.2 31786.5 34194.7 3246.8 3280.6 3466.9 3474.5 3496.2 514389.0 521245.0 523157.0 524820.0 525136.0 65821.0 66101.0 66128.3 66216.0 66260.3 60746.0 69458.3 69526.3 69702.3 69981.7 17750.0 18014.3 18027.3 18048.8 18085.0 12721.9 12999.3 13913.0 13999.2 14011.3 16077.8 17935.6 17953.6 18141.2 18669.3 7362.7 7403.0 7446.7 7495.6 7496.4 896.5 997.9 1003.5 1033.2 1118.1 31639.8 31846.0 31848.7 31859.7 32681.3 1084.6 1104.0 1110.5 1122.4 1183.0 13491.5 15411.9 16162.7 16172.1 16216.0 700816.0 706183.0 707044.0 708121.0 708912.0 61521.7 61651.5 61690.0 61857.4 61932.7 1236.5 1293.9 1310.8 1352.1 1473.3 30820.5 32645.8 32726.3 32731.5 33347.2 44675.8 52736.7 53226.7 53513.7 53516.7 581427.0 585458.0 586084.0 588565.0 882299.0 24321.4 27135.0 27180.5 27573.8 28263.0 48886.8 48983.3 49181.8 49565.5 49610.5 39457.0 40654.8 41818.4 41923.5 42223.0 39998.8 40323.0 40560.6 41285.2 41598.4 39781.0 40271.4 40845.6 40950.8 41001.2 33432.3 35880.1 35981.0 36044.0 36436.3 20432.7 26654.3 26769.3 26939.2 27071.7 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:36083.16 Median:377.64 stddev:106812.35 (28284.2%) stddev-sans-first:107078.34 08:23:23 INFO - PROCESS | 1644 | Values: 375.4 379.9 386.9 391.7 406.2 19796.2 21849.1 22503.8 22764.4 22795.9 18346.2 21617.6 21677.0 21757.6 21760.9 5855.3 6305.1 6357.3 6362.7 6373.2 4492.6 4570.2 4577.2 6282.6 6285.2 4638.1 7039.9 7047.5 7055.3 7058.1 5869.5 6140.0 6197.5 7043.2 7048.9 6090.2 6095.7 6096.2 6105.0 6108.1 13018.7 13772.3 13986.7 14118.7 14131.8 2265.4 2309.3 2373.1 2415.4 2503.2 10285.8 10407.1 10408.0 10462.7 10642.9 1628.6 1918.8 2007.2 2031.9 2067.3 95650.0 115020.0 116427.4 128031.7 129443.0 11299.8 11574.9 11711.9 11747.7 11754.6 15129.7 15131.6 15134.8 15150.5 15176.1 8907.3 9025.5 9054.3 9084.9 9157.2 7725.8 9152.3 9198.1 9257.8 9437.0 4608.2 4637.4 4664.2 4668.7 4725.6 1895.2 1938.0 1939.2 1944.0 1944.4 361.7 394.3 704.0 722.6 912.9 10296.4 11156.8 11288.1 11362.5 11387.0 424.7 428.4 435.5 435.7 440.6 5611.6 5719.4 5747.3 5833.9 5843.2 545272.0 650666.0 652893.0 657946.0 672893.0 145675.0 146228.0 147607.6 149853.3 151026.0 414.9 416.2 427.1 432.2 441.2 11519.7 11535.8 11588.6 11629.8 12013.9 49290.0 57202.0 57236.7 57527.7 58692.5 77802.6 81727.2 82567.6 83814.0 85073.7 7274.8 7624.4 8319.2 8397.8 8534.4 12875.2 13620.8 13715.9 13734.2 14060.6 10469.8 11638.8 11892.1 11987.7 12037.9 10361.9 11152.8 11412.0 11691.4 11726.5 11852.3 11854.3 12000.2 12015.5 12039.0 7713.5 7727.7 7815.9 7848.5 7853.8 11205.9 11705.2 11719.2 12072.8 12089.0 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:5992.16 Median:4611.11 stddev:3447.48 (74.8%) stddev-sans-first:3441.35 08:23:23 INFO - PROCESS | 1644 | Values: 1599.2 1601.0 1819.0 1946.3 1953.9 8934.6 9492.5 9494.3 9494.6 9500.0 8337.8 8581.1 8918.1 9169.1 9194.6 2410.6 2441.7 2442.1 2443.3 2444.7 2415.0 2433.2 2450.9 2451.5 2458.2 2428.3 2434.2 2442.8 2454.6 2455.3 2398.7 2404.1 2409.8 2411.8 2426.8 2405.8 2406.4 2425.6 2425.9 2434.8 9262.2 9301.2 9374.5 9374.9 9438.6 4542.4 5685.9 5698.1 5699.9 5704.2 3572.2 3686.5 3751.0 3751.0 3761.7 1006.1 1027.2 1034.7 1037.6 1046.3 10628.8 12536.2 12561.2 12568.4 12590.4 4804.7 4845.4 4881.9 4990.9 5016.3 10636.1 10640.8 10641.7 10657.9 10681.5 5612.4 5619.8 5625.2 5630.4 5632.1 4611.0 4611.2 4929.3 5105.0 5116.0 3683.6 3904.9 4078.6 4085.2 4179.5 1122.6 1316.0 1322.6 1329.6 1339.1 916.5 933.9 949.9 952.6 994.9 5976.3 5982.5 6018.4 6237.9 6242.9 443.2 445.8 451.7 456.6 461.7 3727.3 3867.9 4050.9 4087.6 4099.9 11054.4 11583.9 11618.1 11619.7 11623.5 9853.4 11530.4 11536.5 11546.9 11554.9 8661.4 8680.5 8686.1 8712.3 8714.2 5818.2 6014.8 6035.2 6195.0 6217.9 10378.9 10487.4 10489.6 10489.9 10622.0 10844.7 10923.0 10934.7 10946.4 10988.7 7764.4 7825.7 7888.1 7907.6 7943.1 8904.7 8995.8 8999.4 9006.6 9008.2 7875.0 7929.8 8081.7 8085.9 8101.7 7754.2 7792.8 7798.8 7830.7 7906.7 7251.5 7268.9 7339.2 7352.6 7352.9 4897.2 4911.5 5035.3 5066.1 5165.8 5065.8 5072.1 5110.3 5266.7 5286.7 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4659.15 Median:5234.48 stddev:1445.33 (27.6%) stddev-sans-first:1411.94 08:23:23 INFO - PROCESS | 1644 | Values: 304.3 310.1 311.7 315.9 320.9 5410.5 5570.9 5583.1 5590.4 5590.9 4913.9 5385.6 5437.9 5467.3 5511.4 3929.4 4082.6 4092.7 4098.5 4124.2 3794.4 4110.7 4125.4 4172.7 4179.4 3509.0 4053.6 4082.5 4101.0 4121.4 3998.7 4109.1 4140.3 4148.4 4148.9 3596.3 3599.6 3605.2 3609.5 3616.5 5315.2 5333.2 5339.9 5372.3 5373.7 4672.5 4776.4 4808.4 4854.4 4867.9 5088.9 5724.8 5776.9 5796.6 5798.7 3353.6 3832.0 4028.5 4047.8 4050.7 5347.3 5916.7 6007.8 6145.3 6162.7 4057.0 4065.3 4079.6 4082.4 4087.9 4139.5 4149.3 4152.0 4156.3 4172.5 4048.8 4126.0 4788.8 4789.9 4799.6 5836.8 5838.1 5843.4 5878.9 5879.2 1180.8 1197.4 1337.2 1356.7 1375.5 786.7 823.7 837.6 846.4 847.5 4663.5 5286.7 5408.8 5532.5 5569.3 5162.7 5374.7 5695.5 5723.4 5995.8 4587.8 4695.4 4936.5 5183.6 5309.4 2385.3 2774.9 2985.0 3130.4 3132.7 5212.3 5552.9 5872.8 5924.8 6215.3 5145.0 5531.1 5706.9 5759.9 6031.8 4936.9 5199.0 5581.6 6170.4 6197.7 5256.7 5570.7 5922.0 5929.3 5932.9 4947.5 5048.2 5343.7 5742.7 5782.6 5465.4 6180.6 6193.4 6198.6 6241.4 3355.4 3724.6 3755.8 3795.0 3966.3 5991.5 6009.4 6012.1 6014.9 6033.9 4939.9 5095.7 5826.7 5842.0 5870.4 5029.5 5070.0 5823.7 5847.6 5885.0 4799.9 5722.9 5728.7 5737.4 5737.8 4831.5 5095.1 5741.4 5769.2 5776.2 5775.6 5776.1 5786.5 5802.6 5820.4 08:23:23 INFO - PROCESS | 1644 | 08:23:23 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:24674.92 Median:3669.71 stddev:38422.11 (1047.0%) stddev-sans-first:38487.41 08:23:23 INFO - PROCESS | 1644 | Values: 610.8 728.0 792.1 819.6 856.4 16427.7 17043.9 17072.3 17073.7 17097.6 15170.0 15267.5 15276.8 15283.0 15293.2 715.9 732.6 735.8 737.5 737.7 745.1 891.8 906.6 913.4 913.6 961.0 977.5 980.7 980.9 982.3 972.3 974.2 974.2 976.1 976.2 722.3 722.9 723.0 723.8 723.9 15436.2 15485.6 15488.9 15489.2 15546.3 13608.3 13656.5 13791.1 13911.5 13931.2 13408.7 13587.8 13842.9 13864.2 13963.2 4639.8 4733.9 4755.3 4769.5 4906.6 122599.0 123706.0 124502.0 124861.4 129809.0 11147.7 11611.8 11723.6 11758.3 11995.8 21813.7 21975.6 21983.6 22073.8 22153.7 8259.7 8312.7 8338.2 8345.8 8550.8 4515.0 4546.4 4678.8 4720.0 4828.4 3554.7 3663.2 3667.9 3671.6 3678.9 640.6 649.2 688.0 688.5 688.7 565.5 575.5 578.2 603.4 694.7 8835.3 9285.8 9453.8 9721.9 9912.0 563.0 576.4 587.9 634.1 655.5 3724.0 4865.2 4926.3 4975.4 4980.3 131543.0 143573.0 145214.0 145245.0 150835.2 103308.0 120165.4 123792.0 126328.0 126730.0 78116.2 98464.0 103043.0 103119.5 106605.0 9305.9 9449.4 9481.8 9488.4 9497.9 55677.9 56756.4 57301.1 58342.0 60253.4 83520.0 85146.6 86661.0 89975.0 90587.5 12244.8 13207.4 13393.7 13478.7 13691.7 12838.7 15530.9 15982.8 16673.6 16892.5 14322.2 14850.4 14923.1 15567.7 15665.0 12313.5 14019.9 14048.2 14860.5 14913.5 13762.9 14371.8 14540.1 14688.4 14755.4 11520.9 11666.7 11767.8 11846.1 12796.7 12013.4 12076.9 12162.1 12182.9 12243.1 08:23:23 INFO - PROCESS | 1644 | -------- Summary: end -------- 08:23:23 INFO - PROCESS | 1644 | 08:23:24 INFO - TEST-INFO | 1644: exit 0 08:23:24 INFO - TEST-OK | dromaeo_css | took 1114693ms 08:23:24 INFO - TEST-START | kraken 08:23:24 INFO - operating with platform_type : mac_ 08:23:24 INFO - Initialising browser for kraken test... 08:23:24 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmp6amRvR/profile http://localhost:49244/getInfo.html) 08:23:26 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 08:23:26 INFO - PROCESS | 1654 | colorDepth:24 08:23:26 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 08:23:26 INFO - PROCESS | 1654 | __metrics 08:23:26 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:23:26 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:23:27 INFO - TEST-INFO | 1654: exit 0 08:23:27 INFO - Browser initialized. 08:23:27 INFO - Running cycle 1/1 for kraken test... 08:23:27 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/tmp6amRvR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:23:39 INFO - PROCESS | 1656 | RSS: Main: 168607744 08:23:39 INFO - PROCESS | 1656 | 08:23:41 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 08:23:42 INFO - PROCESS | 1656 | RSS: Main: 218480640 08:23:42 INFO - PROCESS | 1656 | 08:23:45 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 08:23:45 INFO - PROCESS | 1656 | RSS: Main: 228220928 08:23:45 INFO - PROCESS | 1656 | 08:23:48 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 08:23:49 INFO - PROCESS | 1656 | RSS: Main: 326705152 08:23:49 INFO - PROCESS | 1656 | 08:23:51 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 08:23:51 INFO - PROCESS | 1656 | RSS: Main: 227438592 08:23:51 INFO - PROCESS | 1656 | 08:23:53 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:23:54 INFO - PROCESS | 1656 | RSS: Main: 228204544 08:23:54 INFO - PROCESS | 1656 | 08:23:57 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 08:23:57 INFO - PROCESS | 1656 | RSS: Main: 266010624 08:23:57 INFO - PROCESS | 1656 | 08:24:00 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 08:24:01 INFO - PROCESS | 1656 | RSS: Main: 268480512 08:24:01 INFO - PROCESS | 1656 | 08:24:03 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 08:24:04 INFO - PROCESS | 1656 | RSS: Main: 265990144 08:24:04 INFO - PROCESS | 1656 | 08:24:05 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:24:06 INFO - PROCESS | 1656 | RSS: Main: 239575040 08:24:06 INFO - PROCESS | 1656 | 08:24:08 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:24:09 INFO - PROCESS | 1656 | RSS: Main: 244330496 08:24:09 INFO - PROCESS | 1656 | 08:24:11 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:24:11 INFO - PROCESS | 1656 | RSS: Main: 250548224 08:24:11 INFO - PROCESS | 1656 | 08:24:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:24:15 INFO - PROCESS | 1656 | RSS: Main: 276295680 08:24:15 INFO - PROCESS | 1656 | 08:24:17 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:24:18 INFO - PROCESS | 1656 | RSS: Main: 264966144 08:24:18 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 08:24:20 INFO - PROCESS | 1656 | RSS: Main: 308883456 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | __start_tp_report 08:24:20 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 08:24:20 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 08:24:20 INFO - PROCESS | 1656 | |i|pagename|runs| 08:24:20 INFO - PROCESS | 1656 | |0;ai-astar;114;114;113;111;112;114;113;113;112;112 08:24:20 INFO - PROCESS | 1656 | |1;audio-beat-detection;137;109;103;131;115;102;107;105;134;106 08:24:20 INFO - PROCESS | 1656 | |2;audio-dft;183;183;182;183;181;181;182;182;183;183 08:24:20 INFO - PROCESS | 1656 | |3;audio-fft;81;59;59;85;63;58;57;57;82;57 08:24:20 INFO - PROCESS | 1656 | |4;audio-oscillator;84;69;93;70;68;68;91;67;67;90 08:24:20 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;86;84;87;86;86;85;89;85;88;85 08:24:20 INFO - PROCESS | 1656 | |6;imaging-darkroom;94;93;92;94;92;93;93;94;92;94 08:24:20 INFO - PROCESS | 1656 | |7;imaging-desaturate;87;85;87;87;84;84;85;83;84;85 08:24:20 INFO - PROCESS | 1656 | |8;json-parse-financial;55;53;51;50;55;56;56;55;56;55 08:24:20 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;66;70;78;71;69;67;69;68;68;71 08:24:20 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;84;81;82;91;92;82;85;87;87;110 08:24:20 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;134;133;135;134;134;132;130;151;136;135 08:24:20 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;159;159;159;159;157;175;161;158;157;157 08:24:20 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;65;65;69;79;81;80;81;62;63;66 08:24:20 INFO - PROCESS | 1656 | __end_tp_report 08:24:20 INFO - PROCESS | 1656 | __start_cc_report 08:24:20 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1853 08:24:20 INFO - PROCESS | 1656 | __end_cc_report 08:24:20 INFO - PROCESS | 1656 | __startTimestamp1479486260615__endTimestamp 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | ------- Summary: start ------- 08:24:20 INFO - PROCESS | 1656 | Number of tests: 14 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:1.03 (0.9%) stddev-sans-first:1.00 08:24:20 INFO - PROCESS | 1656 | Values: 114.0 114.0 113.0 111.0 112.0 114.0 113.0 113.0 112.0 112.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:114.90 Median:112.00 stddev:13.72 (12.3%) stddev-sans-first:12.00 08:24:20 INFO - PROCESS | 1656 | Values: 137.0 109.0 103.0 131.0 115.0 102.0 107.0 105.0 134.0 106.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:182.30 Median:183.00 stddev:0.82 (0.4%) stddev-sans-first:0.83 08:24:20 INFO - PROCESS | 1656 | Values: 183.0 183.0 182.0 183.0 181.0 181.0 182.0 182.0 183.0 183.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:65.80 Median:61.00 stddev:11.81 (19.4%) stddev-sans-first:11.17 08:24:20 INFO - PROCESS | 1656 | Values: 81.0 59.0 59.0 85.0 63.0 58.0 57.0 57.0 82.0 57.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.00 stddev:11.27 (14.6%) stddev-sans-first:11.65 08:24:20 INFO - PROCESS | 1656 | Values: 84.0 69.0 93.0 70.0 68.0 68.0 91.0 67.0 67.0 90.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:1.52 (1.8%) stddev-sans-first:1.62 08:24:20 INFO - PROCESS | 1656 | Values: 86.0 84.0 87.0 86.0 86.0 85.0 89.0 85.0 88.0 85.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.50 stddev:0.88 (0.9%) stddev-sans-first:0.87 08:24:20 INFO - PROCESS | 1656 | Values: 94.0 93.0 92.0 94.0 92.0 93.0 93.0 94.0 92.0 94.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.36 08:24:20 INFO - PROCESS | 1656 | Values: 87.0 85.0 87.0 87.0 84.0 84.0 85.0 83.0 84.0 85.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:54.20 Median:55.00 stddev:2.15 (3.9%) stddev-sans-first:2.26 08:24:20 INFO - PROCESS | 1656 | Values: 55.0 53.0 51.0 50.0 55.0 56.0 56.0 55.0 56.0 55.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.50 stddev:3.33 (4.8%) stddev-sans-first:3.26 08:24:20 INFO - PROCESS | 1656 | Values: 66.0 70.0 78.0 71.0 69.0 67.0 69.0 68.0 68.0 71.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:8.54 (9.9%) stddev-sans-first:8.93 08:24:20 INFO - PROCESS | 1656 | Values: 84.0 81.0 82.0 91.0 92.0 82.0 85.0 87.0 87.0 110.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:134.50 stddev:5.74 (4.3%) stddev-sans-first:6.06 08:24:20 INFO - PROCESS | 1656 | Values: 134.0 133.0 135.0 134.0 134.0 132.0 130.0 151.0 136.0 135.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:159.00 stddev:5.38 (3.4%) stddev-sans-first:5.70 08:24:20 INFO - PROCESS | 1656 | Values: 159.0 159.0 159.0 159.0 157.0 175.0 161.0 158.0 157.0 157.0 08:24:20 INFO - PROCESS | 1656 | 08:24:20 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:74.00 stddev:8.10 (10.9%) stddev-sans-first:8.29 08:24:20 INFO - PROCESS | 1656 | Values: 65.0 65.0 69.0 79.0 81.0 80.0 81.0 62.0 63.0 66.0 08:24:20 INFO - PROCESS | 1656 | -------- Summary: end -------- 08:24:20 INFO - PROCESS | 1656 | 08:24:21 INFO - TEST-INFO | 1656: exit 0 08:24:21 INFO - TEST-OK | kraken | took 57356ms 08:24:21 INFO - SUITE-END | took 1172s 08:24:21 INFO - Completed test suite (00:19:32) 08:24:21 INFO - javascript benchmark 08:24:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3491.0923159978406, 3491.4064609016464, 3514.191735900743, 3534.0, 3562.7506074574776, 5602.747876345564, 5817.854553636156, 5885.4997325227405, 5905.143754155651, 5919.467247947684, 4969.428515720684, 5944.405559444053, 5962.04607262838, 5965.2245208122995, 5967.313758917726, 5273.525382715565, 5297.258383826248, 5355.169948657965, 5374.167004114349, 5375.951689420564, 5237.764300606463, 5242.030224408478, 5249.1338929076655, 5406.378266499344, 5418.2685337479525, 5296.1261391870485, 5318.441563635821, 5331.813386531472, 5336.893262134755, 5338.492843179892, 5333.333333333353, 5340.225667278223, 5397.7571009304675, 5398.91901621476, 5402.945970540283, 5186.636935414523, 5258.737063146866, 5294.444083371268, 5332.626716129873, 5349.037173308803, 5095.847124586231, 5784.248047753807, 5799.652020878761, 5831.446012628836, 5842.094475356326, 6228.937710622927, 6259.843503912393, 6271.937280627181, 6287.622742635456, 6301.905471417932, 5965.910511342333, 6292.150559674431, 6304.621722696653, 6309.905351419732, 6325.9051114233325, 5774.2782152230975, 5828.475437210672, 5922.526197904157, 5945.40545945402, 5999.730012149464, 6354.332795056545, 6366.936330636727, 6375.330590287953, 6383.489320854414, 6397.872042559123, 6297.118403423525, 6312.0, 6319.0, 6319.9368006320265, 6332.620042797447, 5261.394939581921, 5438.374586922476, 6193.969030154911, 6197.1324014637985, 6278.0, 6224.502039836802, 6290.150829637941, 6291.370862913764, 6299.6850157491945, 6309.148264984168, 6258.937410625836, 6284.4344009039405, 6299.496040316763, 6311.652859092794, 6314.9684251579365, 5002.974985125051, 5061.645684802103, 5095.337606111182, 5105.591552675777, 5141.331626888481, 3618.457231415309, 4628.236341003764, 4630.027694184192, 4670.626349892001, 4676.906461870812, 5899.380565040609, 5957.672328021914, 5987.0, 5987.161797348374, 5991.340952495222, 6136.7948077883175, 6174.660393678301, 6178.289496707936, 6269.937300626935, 6286.308506064329, 5009.499050094962, 5945.554083443759, 5988.580799344091, 5988.6706231157705, 6027.60820546663, 5559.527440167551, 5581.49766521015, 5594.272744543184, 5596.076647353222, 5609.775608975595, 6316.084167795736, 6340.904886426615, 6447.967760161263, 6530.608163510205, 6544.018397240452, 6206.410391012847, 6241.251049874044, 6263.279722831932, 6308.463780578702, 6311.368863113652, 6492.902606460812, 6509.837254068497, 6510.544261901621, 6510.902336464862, 6539.182602174728, 6159.260888693386, 6280.937190628218, 6323.747050117944, 6337.366263373626, 6369.490440764635, 6184.072389141485, 6209.503239740719, 6246.094316324198, 6294.0558916162945, 6302.747890084345, 6291.748330066746, 6297.992321228581, 6305.274893387135, 6313.494920406265, 6315.494760419064, 6260.718267677874, 6304.243490780952, 6315.652639104894, 6316.589421687576, 6323.588966717149, 5899.085641725539, 6030.39696030411, 6065.0, 6096.177016102947, 6111.174991376285, 6167.784127555694, 6194.318624951162, 6222.968885155546, 6245.437910588069, 6252.9370007098, 5365.65123267002, 5796.333421656564, 5939.198208241832, 6040.0, 6094.177286066324], "value": 5794.330718923467, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [490.21076067531266, 504.8687341291263, 509.98767446618456, 546.3334731627414, 566.9143590025102, 32483.67516324836, 43023.56976430239, 44191.67424977256, 44422.111557768825, 46631.53368466314, 45676.77161614187, 45803.54196458034, 45844.77077614616, 45878.0, 45908.77045614767, 8942.329325300596, 9898.802023959517, 10125.544350504208, 10268.845967310497, 10277.33197342174, 9436.575354109082, 9674.032596740304, 12299.754004919896, 12546.81179782304, 12571.811422828665, 12482.563110291141, 12592.622221333375, 12597.307148106851, 12606.747865042693, 12612.68468288291, 12504.249745015282, 12566.623001309885, 12612.495500180028, 12617.684557886034, 12618.495260189673, 12404.19372740769, 12475.563355282522, 12484.0, 12496.187747796364, 12501.437435315433, 43118.353224701656, 43390.783046084565, 43469.34795978063, 43495.34756978648, 43599.78200109011, 3418.8119653419053, 3565.8751943681846, 3734.2158146789207, 3834.983729311735, 4115.135821477494, 30745.077647670605, 31468.0, 31532.211694707585, 31786.523202151988, 34194.65805341965, 3246.8376581170846, 3280.6391296957318, 3466.94799578004, 3474.4788281757687, 3496.17839807645, 514389.0, 521245.0, 523157.0, 524820.0, 525136.0, 65821.0, 66101.0, 66128.33871661319, 66216.0, 66260.33739662541, 60746.0, 69458.30541694518, 69526.30473695198, 69702.30297696959, 69981.65009174921, 17750.0, 18014.2794288227, 18027.2789088435, 18048.819511804977, 18085.00532470727, 12721.936390318175, 12999.285039322738, 13913.026088173932, 13999.16005039701, 14011.299435028208, 16077.839221607868, 17935.641287174443, 17953.551161220814, 18141.183646735928, 18669.253229870654, 7362.668679909417, 7402.962985185148, 7446.7021319146625, 7495.625218739041, 7496.437767167485, 896.4621227263721, 997.9151772099308, 1003.5433877585826, 1033.235405799703, 1118.0775859915439, 31639.84180079131, 31846.0, 31848.681513185034, 31859.68140318567, 32681.346373072407, 1084.6095405653957, 1104.0, 1110.4614262083044, 1122.354646078508, 1183.0, 13491.460341586422, 15411.92116551853, 16162.676746465006, 16172.110533920511, 16216.0, 700816.0, 706183.0, 707044.0, 708121.0, 708912.0, 61521.692391537756, 61651.458713531625, 61690.0, 61857.38142618516, 61932.69033654893, 1236.505397840871, 1293.9158954667917, 1310.8033794930645, 1352.1076089780697, 1473.256005717106, 30820.458977051505, 32645.836770815993, 32726.34547308993, 32731.509027364133, 33347.166320842174, 44675.77662111669, 52736.68158296073, 53226.73386633042, 53513.732431337594, 53516.73241633767, 581427.0, 585458.0, 586084.0, 588565.0, 882299.0, 24321.39196520101, 27135.0, 27180.456390872467, 27573.75918083731, 28263.0, 48886.75556622194, 48983.26525102055, 49181.75409122931, 49565.50434495609, 49610.50389496059, 39457.0, 40654.79672601618, 41818.37272440855, 41923.501857212184, 42223.0, 39998.80000599979, 40323.0, 40560.59439405568, 41285.1742965145, 41598.37602436027, 39781.0, 40271.39592906168, 40845.59154408418, 40950.77147685574, 41001.179976400905, 33432.33135337231, 35880.10299742423, 35981.0, 36044.0, 36436.27127457489, 20432.69350959707, 26654.333641659112, 26769.33076673099, 26939.191824245303, 27071.72928270692], "value": 21451.88549806791, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.40310905659993, 379.87654012445955, 386.94582758413827, 391.6572998626202, 406.1937054945932, 19796.208151673934, 21849.126034958583, 22503.762293073873, 22764.43088922776, 22795.886020569873, 18346.174422151, 21617.56764864702, 21677.024533895972, 21757.564848703056, 21760.891195544, 5855.268091488575, 6305.0542418637115, 6357.332480089593, 6362.713677884506, 6373.203349581302, 4492.640588752892, 4570.200214962385, 4577.198990176722, 6282.591631543958, 6285.245770507546, 4638.141943740402, 7039.929600704004, 7047.506674532785, 7055.294470552929, 7058.082449281586, 5869.501092407172, 6140.048292514667, 6197.5351848611535, 7043.190033146177, 7048.929510704878, 6090.23872015998, 6095.664738439384, 6096.237970253718, 6104.96947515264, 6108.083787431877, 13018.674533136747, 13772.311384430739, 13986.720265594631, 14118.71762564743, 14131.78802317966, 2265.399669087693, 2309.3187509684685, 2373.133806160756, 2415.3961509622595, 2503.236512863576, 10285.794284114276, 10407.06336429725, 10408.011238932366, 10462.738431539196, 10642.893571064345, 1628.5765700917727, 1918.8368988635982, 2007.1770574064562, 2031.8882461464614, 2067.297118979539, 95650.0, 115020.0, 116427.417862911, 128031.71968280291, 129442.99999999905, 11299.830502542469, 11574.942125289488, 11711.941440292743, 11747.706307342385, 11754.588589399329, 15129.697406051817, 15131.621709457351, 15134.848651513345, 15150.469733559272, 15176.089434633957, 8907.331950103768, 9025.548722563846, 9054.320925930582, 9084.8637270441, 9157.221636160868, 7725.806854828562, 9152.31357648179, 9198.126178013077, 9257.768555786159, 9437.009114043063, 4608.216603177468, 4637.420322459692, 4664.230401983703, 4668.696534725232, 4725.5983241424865, 1895.2040143139914, 1937.9709304360447, 1939.1952339779116, 1943.9902800485906, 1944.387517931847, 361.74294327212726, 394.25682588321223, 703.9753608623673, 722.6206241723032, 912.9041450647719, 10296.40405737097, 11156.832647510293, 11288.0969522438, 11362.48868800906, 11387.0, 424.73241857630114, 428.38954489851835, 435.45133132252954, 435.6775985770507, 440.58364845220956, 5611.6071874969175, 5719.370869204384, 5747.3103227612955, 5833.941660583425, 5843.18195452637, 545272.0, 650666.0, 652893.0, 657946.0, 672893.0, 145675.0, 146228.0, 147607.60170503845, 149853.25073374782, 151026.0, 414.92738770715005, 416.18635567466134, 427.09455953379035, 432.21768598836206, 441.21684010880944, 11519.732829388928, 11535.76928461443, 11588.594399195988, 11629.76740465203, 12013.939930300643, 49290.0, 57202.0, 57236.71381643065, 57527.7123614396, 58692.532686683175, 77802.61098694471, 81727.18272817196, 82567.5871620638, 83814.0, 85073.72389414288, 7274.781756547312, 7624.351930086005, 8319.168083191633, 8397.832043358976, 8534.359923005675, 12875.227486350848, 13620.795688064489, 13715.913919368462, 13734.244616546186, 14060.578182654537, 10469.790604188025, 11638.76722465529, 11892.086438822544, 11987.700307492383, 12037.879621203676, 10361.911999240272, 11152.776944461228, 11412.0, 11691.356975366436, 11726.530938762355, 11852.348120853436, 11854.288742675468, 12000.219985700902, 12015.459304331502, 12039.03687704964, 7713.537187768752, 7727.652255648397, 7815.92184078152, 7848.546639478611, 7853.764387068397, 11205.943970280096, 11705.180637355303, 11719.238249513754, 12072.75854482923, 12089.0], "value": 8766.647664084978, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1599.1604407685963, 1601.0313760175093, 1819.0, 1946.2604210400045, 1953.9413817585478, 8934.55327233639, 9492.477913714743, 9494.335396522229, 9494.620215191384, 9500.049995000505, 8337.791555211123, 8581.098984606604, 8918.108189181079, 9169.083091690827, 9194.632214711404, 2410.5781488239577, 2441.7192022917325, 2442.1452491627965, 2443.3402981195068, 2444.7433019532873, 2414.95170096598, 2433.1848830641757, 2450.926472205828, 2451.534208500379, 2458.21337172105, 2428.2836563213896, 2434.2453839309783, 2442.792362649168, 2454.5827209374447, 2455.312512496495, 2398.6761787158857, 2404.0504000919627, 2409.7590240975937, 2411.7588241175918, 2426.7573242675767, 2405.819563532742, 2406.3984003999, 2425.611902095656, 2425.854448733082, 2434.7686969737847, 9262.212711919496, 9301.162895339385, 9374.484403357812, 9374.90625093747, 9438.575264113131, 4542.432195975503, 5685.943140568583, 5698.116791897262, 5699.857503562403, 5704.2299289595785, 3572.1782086390276, 3686.5207523021836, 3750.9624903750887, 3750.981245093757, 3761.699064074895, 1006.0693858181153, 1027.1628622672572, 1034.7413146713322, 1037.6368271105127, 1046.3251202974116, 10628.787424251472, 12536.185147965352, 12561.246325220516, 12568.434420451102, 12590.433430495557, 4804.663673542818, 4845.442774080955, 4881.8771682513225, 4990.8752281193265, 5016.272640467112, 10636.095931845724, 10640.840387394195, 10641.73395665099, 10657.946710266398, 10681.519331630096, 5612.410696876769, 5619.831405057855, 5625.156226566048, 5630.352509461464, 5632.070708333079, 4611.031683346468, 4611.193041217841, 4929.309896614477, 5105.0, 5116.0, 3683.557973043198, 3904.882853514399, 4078.592140785957, 4085.1829634073306, 4179.477565304337, 1122.629532254354, 1315.9736805264033, 1322.623052430072, 1329.6409969308427, 1339.1028011232497, 916.5142474488532, 933.9486328252011, 949.857521371786, 952.5856252530172, 994.9005099489993, 5976.312724036791, 5982.46157845796, 6018.428249316308, 6237.875242495215, 6242.937570624326, 443.1579998003754, 445.7793392270847, 451.7063908459462, 456.5548590124602, 461.7160446325553, 3727.254549090193, 3867.9226415471535, 4050.86575758788, 4087.5708050654252, 4099.8975025624, 11054.392008439612, 11583.884161158448, 11618.128640352008, 11619.6514104577, 11623.53505859773, 9853.359531630422, 11530.423478826026, 11536.480858361394, 11546.884531154581, 11554.942225288987, 8661.350398720122, 8680.522571258514, 8686.087960764155, 8712.346574006975, 8714.172153645393, 5818.214541036906, 6014.849628759316, 6035.245594300713, 6194.9778286582205, 6217.906731398942, 10378.948105259426, 10487.423191724529, 10489.580416783549, 10489.947550262199, 10622.0, 10844.728881777703, 10923.0, 10934.726631834268, 10946.397948112612, 10988.670339889815, 7764.378849691898, 7825.726099586487, 7888.053433588007, 7907.644156012878, 7943.126256111707, 8904.73285801427, 8995.775105622412, 8999.415038022507, 9006.63973441055, 9008.234300084567, 7874.960625196837, 7929.801754955942, 8081.676732930617, 8085.919140808516, 8101.675932962851, 7754.185810490043, 7792.805179870548, 7798.844023119619, 7830.725924592612, 7906.683732650629, 7251.456140789356, 7268.927310726825, 7339.1926888043345, 7352.558846469229, 7352.852942941218, 4897.240927656219, 4911.459739428588, 5035.29505869186, 5066.113430149635, 5165.793368265227, 5065.758874231777, 5072.087024335655, 5110.3356563646485, 5266.710330931835, 5286.682799032071], "value": 4692.771899103018, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.27734131437836, 310.0898861840498, 311.69765327632194, 315.93681263747254, 320.89410494536804, 5410.486003829635, 5570.86072848179, 5583.05088135017, 5590.357108932474, 5590.888182236358, 4913.894373765901, 5385.623006389555, 5437.945620543794, 5467.343918729748, 5511.366192887819, 3929.3713005919058, 4082.611672171783, 4092.6930480213955, 4098.52866920305, 4124.237016152021, 3794.392897136459, 4110.671146308288, 4125.443065186191, 4172.749635021908, 4179.373094035888, 3508.982455087734, 4053.6149065838845, 4082.5100987881347, 4100.958990410102, 4121.402396652484, 3998.7000974926996, 4109.116539943911, 4140.323169116483, 4148.43996060534, 4148.854790082363, 3596.29872174926, 3599.604043555233, 3605.1888325126897, 3609.512715783388, 3616.4575313703153, 5315.229291752674, 5333.213373519876, 5339.919901201485, 5372.328458942632, 5373.677579345252, 4672.509386514401, 4776.379070720784, 4808.374911261549, 4854.393200849894, 4867.853964381075, 5088.872778180576, 5724.8282551523525, 5776.855578610526, 5796.62321949072, 5798.681072541009, 3353.6478669739813, 3832.0419895026243, 4028.4964379452567, 4047.797610119482, 4050.6961977851483, 5347.25138480613, 5916.7337469813965, 6007.759689612454, 6145.324014358417, 6162.691865406757, 4056.9857535616097, 4065.2682517147196, 4079.571644977294, 4082.3876418537457, 4087.8773636790943, 4139.544650088488, 4149.33610622299, 4152.0485371875175, 4156.251874662529, 4172.4784401949755, 4048.7975601219823, 4125.958740412618, 4788.808447662054, 4789.904201915942, 4799.568038876448, 5836.795712150054, 5838.102616649606, 5843.444872737083, 5878.8836019033115, 5879.235699359056, 1180.7992641251008, 1197.4252358867793, 1337.2110454831695, 1356.7150898311465, 1375.5460697969645, 786.7443080998584, 823.6993497373415, 837.5812093953024, 846.4159729786428, 847.4745657692271, 4663.463701674283, 5286.735663216824, 5408.8377348679605, 5532.5297349724915, 5569.27599412082, 5162.6902385856965, 5374.731263436813, 5695.515881150066, 5723.427657234243, 5995.760169593167, 4587.816487340469, 4695.366125573004, 4936.506349365035, 5183.611229157828, 5309.41596424393, 2385.2605692235115, 2774.916752497428, 2984.9552256716165, 3130.4052230076213, 3132.7023932726356, 5212.296339994053, 5552.861178470571, 5872.823815285548, 5924.837434336522, 6215.34738852423, 5144.971005798855, 5531.059719847635, 5706.857328566736, 5759.8560035999435, 6031.758729650853, 4936.925946110883, 5199.0, 5581.609287349927, 6170.413810687977, 6197.721102550396, 5256.658317209369, 5570.749316280696, 5921.970390148194, 5929.258842644669, 5932.851678708067, 4947.455779864284, 5048.242763585492, 5343.679379237258, 5742.741576629145, 5782.624129431573, 5465.398806131402, 6180.598261113013, 6193.38066193377, 6198.566100372931, 6241.4084408477365, 3355.3624811285777, 3724.646158614927, 3755.779371704262, 3795.0132965428634, 3966.305896468049, 5991.502124468882, 6009.399060093956, 6012.076135636729, 6014.879702406015, 6033.87932241344, 4939.9259011114145, 5095.694258344512, 5826.70866456684, 5842.0, 5870.442307980735, 5029.497050294941, 5069.986002799381, 5823.7379317929945, 5847.590668653153, 5884.9705751470965, 4799.856004319876, 5722.914156287742, 5728.705994053353, 5737.426257374396, 5737.79095048401, 4831.492693267297, 5095.082885080721, 5741.425857414225, 5769.221155144001, 5776.220210271727, 5775.595708300379, 5776.140810298929, 5786.528083150244, 5802.564807639359, 5820.447057529528], "value": 4186.658772751578, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [610.8167549735078, 728.0462594001855, 792.1484404265416, 819.614781052905, 856.4347530629785, 16427.671446571076, 17043.914780426112, 17072.317107315692, 17073.658526829473, 17097.57256068599, 15170.0, 15267.541973740805, 15276.770848437282, 15283.0, 15293.158876261801, 715.8926161075841, 732.5604637217654, 735.8197241675797, 737.5464089584921, 737.7307282841778, 745.0686641697878, 891.7859713668738, 906.5693795447175, 913.3743385780729, 913.5569248914271, 961.0197598449578, 977.4575110813496, 980.7204946590223, 980.9313348065639, 982.29274922056, 972.2950860626025, 974.181687382595, 974.1914211204684, 976.0727309056354, 976.2190247801731, 722.3354513847273, 722.8734971379987, 723.0419693905544, 723.8009547374462, 723.9022731931227, 15436.228188590638, 15485.612859678486, 15488.922555387151, 15489.225538723018, 15546.300416481285, 13608.319584020759, 13656.453741850313, 13791.138196343565, 13911.513097041656, 13931.164130152223, 13408.664783380396, 13587.796183057262, 13842.861571384257, 13864.237466939314, 13963.162210267315, 4639.814407423699, 4733.905321893543, 4755.310479980418, 4769.475357710684, 4906.632002599819, 122599.0, 123706.0, 124502.0, 124861.37569312187, 129809.0, 11147.665570032912, 11611.767764644828, 11723.648290551297, 11758.294502329887, 11995.760084798256, 21813.709560495918, 21975.560488790456, 21983.560328793334, 22073.779262207492, 22153.66769498459, 8259.669613215525, 8312.709055183039, 8338.207870252316, 8345.833083338299, 8550.828983420297, 4514.977425112854, 4546.386237857913, 4678.836240731558, 4719.985203181263, 4828.420589529279, 3554.662307080823, 3663.2124093320062, 3667.853285868589, 3671.5594128704724, 3678.889633311005, 640.6412409050853, 649.2112083818183, 687.9965600171967, 688.4629988608893, 688.7245101959256, 565.4995329133664, 575.5481946671842, 578.2338401617873, 603.4448307557058, 694.6630884021246, 8835.293176545862, 9285.767855803659, 9453.810923781486, 9721.854172187423, 9911.950440247752, 562.9915551266735, 576.3688760806909, 587.8589138606703, 634.0995785983914, 655.452696998012, 3723.9813800931365, 4865.172920603506, 4926.310316555685, 4975.427825800007, 4980.327655766498, 131543.0, 143573.0, 145214.0, 145245.0, 150835.24582377236, 103308.0, 120165.39917300358, 123792.0, 126328.0, 126730.0, 78116.21883781203, 98464.01535984692, 103043.0, 103119.48440257901, 106605.0, 9305.86041209396, 9449.43303401798, 9481.810363792823, 9488.430694158373, 9497.905020949702, 55677.88644227174, 56756.43243567512, 57301.140482891955, 58342.0, 60253.39746602478, 83520.0, 85146.57426712826, 86661.0, 89975.0, 90587.54706226691, 12244.816327755269, 13207.405666745211, 13393.66515837112, 13478.73042539124, 13691.726165476834, 12838.68486637374, 15530.922345388653, 15982.760258595898, 16673.5831604206, 16892.493225203263, 14322.212278324792, 14850.40598376053, 14923.104613723212, 15567.688646227238, 15665.0, 12313.507459701512, 14019.859801401855, 14048.157110573398, 14860.479883204036, 14913.478028268959, 13762.93118534441, 14371.784423233868, 14540.054896431699, 14688.41246350134, 14755.409783608964, 11520.88479115198, 11666.650000499998, 11767.764644706887, 11846.052315814542, 12796.744065118459, 12013.399330033288, 12076.879231207575, 12162.087843411957, 12182.867748679211, 12243.142979991315], "value": 8066.359153602643, "unit": "score"}], "name": "dromaeo_css", "value": 7462.5471576761465, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 111.0, 112.0, 114.0, 113.0, 113.0, 112.0, 112.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 109.0, 103.0, 131.0, 115.0, 102.0, 107.0, 105.0, 134.0, 106.0], "value": 114.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 183.0, 181.0, 181.0, 182.0, 182.0, 183.0, 183.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 85.0, 63.0, 58.0, 57.0, 57.0, 82.0, 57.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 69.0, 93.0, 70.0, 68.0, 68.0, 91.0, 67.0, 67.0, 90.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 87.0, 86.0, 86.0, 85.0, 89.0, 85.0, 88.0, 85.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 92.0, 94.0, 92.0, 93.0, 93.0, 94.0, 92.0, 94.0], "value": 93.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 87.0, 84.0, 84.0, 85.0, 83.0, 84.0, 85.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 51.0, 50.0, 55.0, 56.0, 56.0, 55.0, 56.0, 55.0], "value": 54.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 70.0, 78.0, 71.0, 69.0, 67.0, 69.0, 68.0, 68.0, 71.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 82.0, 91.0, 92.0, 82.0, 85.0, 87.0, 87.0, 110.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 133.0, 135.0, 134.0, 134.0, 132.0, 130.0, 151.0, 136.0, 135.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 159.0, 159.0, 157.0, 175.0, 161.0, 158.0, 157.0, 157.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 69.0, 79.0, 81.0, 80.0, 81.0, 62.0, 63.0, 66.0], "value": 71.1, "unit": "score"}], "name": "kraken", "value": 1395.4, "alertThreshold": 2.0}]} 08:24:21 INFO - Return code: 0 08:24:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:24:21 INFO - # TBPL SUCCESS # 08:24:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:24:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:24:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:24:21 INFO - 2016-11-18 08:24:21.941 screenresolution[1660:10021] starting screenresolution argv=screenresolution get 08:24:21 INFO - 2016-11-18 08:24:21.944 screenresolution[1660:10021] Display 0: 1600x1200x32@60 08:24:21 INFO - 2016-11-18 08:24:21.949 screenresolution[1661:10024] starting screenresolution argv=screenresolution list 08:24:21 INFO - Available Modes on Display 0 08:24:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:24:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:24:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:24:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:24:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:24:22 INFO - Intel Iris: 08:24:22 INFO - Chipset Model: Intel Iris 08:24:22 INFO - Type: GPU 08:24:22 INFO - Bus: Built-In 08:24:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:24:22 INFO - Vendor: Intel (0x8086) 08:24:22 INFO - Device ID: 0x0a2e 08:24:22 INFO - Revision ID: 0x0009 08:24:22 INFO - Displays: 08:24:22 INFO - Display: 08:24:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:24:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:24:22 INFO - Display Serial Number: 1600x1200 60 08:24:22 INFO - Main Display: Yes 08:24:22 INFO - Mirror: Off 08:24:22 INFO - Online: Yes 08:24:22 INFO - Rotation: Supported 08:24:22 INFO - Return code: 0 08:24:22 INFO - Running post-action listener: _resource_record_post_action 08:24:22 INFO - [mozharness: 2016-11-18 16:24:22.186255Z] Finished run-tests step (success) 08:24:22 INFO - Running post-run listener: _resource_record_post_run 08:24:22 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 36746240; Write bytes: 492623872; Read time: 380; Write time: 1582 08:24:22 INFO - TinderboxPrint: CPU usage
53.5% 08:24:22 INFO - TinderboxPrint: I/O read bytes / time
36,746,240 / 380 08:24:22 INFO - TinderboxPrint: I/O write bytes / time
492,623,872 / 1,582 08:24:22 INFO - TinderboxPrint: CPU idle
2,223.1 (46.5%) 08:24:22 INFO - TinderboxPrint: CPU system
961.9 (20.1%) 08:24:22 INFO - TinderboxPrint: CPU user
1,596.6 (33.4%) 08:24:22 INFO - TinderboxPrint: Swap in / out
231,923,712 / 0 08:24:22 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 192340480; Write bytes: 185823232; Read time: 17633; Write time: 331 08:24:22 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 34698240; Write bytes: 295516160; Read time: 357; Write time: 1218 08:24:22 INFO - Running post-run listener: _upload_blobber_files 08:24:22 INFO - Blob upload gear active. 08:24:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:24:22 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 08:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:24:23 INFO - (blobuploader) - INFO - Open directory for files ... 08:24:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:24:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:24:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:24 INFO - (blobuploader) - INFO - Done attempting. 08:24:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:24:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:24:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:25 INFO - (blobuploader) - INFO - Done attempting. 08:24:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:24:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:24:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:24:27 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:24:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:24:27 INFO - (blobuploader) - INFO - Done attempting. 08:24:27 INFO - (blobuploader) - INFO - Iteration through files over. 08:24:27 INFO - Return code: 0 08:24:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:24:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:24:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b98fdb4a556fb2eee30e9451825b98a3a4f04a109b06b473f64024c1bdc1838aa2c0ceff5b593fef5b50853de1aff2ac5264792c56659edfb71e0288aa2b3b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0b19f29029a8bfc7e23c63a3216e34a99b1225b0e681ed418d949c8d953a8ec0807a6c09206667121d3b906241f82af1a36cda8569edaa5c6585f4d3970132d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f6473a0710b7a025be0e1266ae6616bd0550c2c67e5e4675df74c039ff1f6f677eb74072e1c4e6e6fbbcb52db8b04a4dd719c90fd0201b00d63df057c8b162f"} 08:24:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:24:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:24:27 INFO - Contents: 08:24:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b98fdb4a556fb2eee30e9451825b98a3a4f04a109b06b473f64024c1bdc1838aa2c0ceff5b593fef5b50853de1aff2ac5264792c56659edfb71e0288aa2b3b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0b19f29029a8bfc7e23c63a3216e34a99b1225b0e681ed418d949c8d953a8ec0807a6c09206667121d3b906241f82af1a36cda8569edaa5c6585f4d3970132d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f6473a0710b7a025be0e1266ae6616bd0550c2c67e5e4675df74c039ff1f6f677eb74072e1c4e6e6fbbcb52db8b04a4dd719c90fd0201b00d63df057c8b162f"} 08:24:27 INFO - Running post-run listener: copy_logs_to_upload_dir 08:24:27 INFO - Copying logs to upload dir... 08:24:27 INFO - mkdir: /builds/slave/test/build/upload/logs 08:24:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.420332 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-11-18 08:24:27.640477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:27.644670) ========= 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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b98fdb4a556fb2eee30e9451825b98a3a4f04a109b06b473f64024c1bdc1838aa2c0ceff5b593fef5b50853de1aff2ac5264792c56659edfb71e0288aa2b3b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0b19f29029a8bfc7e23c63a3216e34a99b1225b0e681ed418d949c8d953a8ec0807a6c09206667121d3b906241f82af1a36cda8569edaa5c6585f4d3970132d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f6473a0710b7a025be0e1266ae6616bd0550c2c67e5e4675df74c039ff1f6f677eb74072e1c4e6e6fbbcb52db8b04a4dd719c90fd0201b00d63df057c8b162f"} build_url:https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011164 build_url: 'https://queue.taskcluster.net/v1/task/FmRmLTisR-qnEO4mwOEHDg/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6b98fdb4a556fb2eee30e9451825b98a3a4f04a109b06b473f64024c1bdc1838aa2c0ceff5b593fef5b50853de1aff2ac5264792c56659edfb71e0288aa2b3b9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d0b19f29029a8bfc7e23c63a3216e34a99b1225b0e681ed418d949c8d953a8ec0807a6c09206667121d3b906241f82af1a36cda8569edaa5c6585f4d3970132d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f6473a0710b7a025be0e1266ae6616bd0550c2c67e5e4675df74c039ff1f6f677eb74072e1c4e6e6fbbcb52db8b04a4dd719c90fd0201b00d63df057c8b162f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:27.686677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:27.687170) ========= 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.2bKzzOr9Eh/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.KSwPLFxer6/Listeners TMPDIR=/var/folders/5n/sn2p23ks3csg46__d68h6j6m00000w/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.005284 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 08:24:27.736032) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:24:27.739458) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 08:24:27.739863) ========= ========= Total master_lag: 0.21 =========