builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1487351128.61 results: success (0) buildid: 20170217080019 builduid: 54903267ba964a92a0a2af9607542772 revision: 2af97db52557c07ca1dc692bb5406ccafbb704e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.607869) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.608328) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.608602) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.634007) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.634385) ========= 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.71hEb1gwd1/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.imGMGbHmrt/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-17 09:05:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.97M=0.001s 2017-02-17 09:05:28 (7.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142451 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.800848) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.801159) ========= 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.71hEb1gwd1/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.imGMGbHmrt/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.020887 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:28.849681) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 09:05:28.850043) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2af97db52557c07ca1dc692bb5406ccafbb704e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2af97db52557c07ca1dc692bb5406ccafbb704e5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.71hEb1gwd1/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.imGMGbHmrt/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-17 09:05:28,936 truncating revision to first 12 chars 2017-02-17 09:05:28,936 Setting DEBUG logging. 2017-02-17 09:05:28,936 attempt 1/10 2017-02-17 09:05:28,936 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2af97db52557?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 09:05:29,831 unpacking tar archive at: mozilla-aurora-2af97db52557/testing/mozharness/ program finished with exit code 0 elapsedTime=1.168866 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 09:05:30.042857) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:30.043181) ========= script_repo_revision: 2af97db52557c07ca1dc692bb5406ccafbb704e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:30.043570) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:30.043900) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:30.064259) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-17 09:05:30.064642) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.71hEb1gwd1/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.imGMGbHmrt/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:05:30 INFO - MultiFileLogger online at 20170217 09:05:30 in /builds/slave/test 09:05:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:05:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:30 INFO - {'append_to_log': False, 09:05:30 INFO - 'base_work_dir': '/builds/slave/test', 09:05:30 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:05:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:30 INFO - 'branch': 'Mozilla-Aurora', 09:05:30 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:30 INFO - 'config_files': ('talos/mac_config.py',), 09:05:30 INFO - 'default_actions': ('clobber', 09:05:30 INFO - 'read-buildbot-config', 09:05:30 INFO - 'download-and-extract', 09:05:30 INFO - 'populate-webroot', 09:05:30 INFO - 'create-virtualenv', 09:05:30 INFO - 'install', 09:05:30 INFO - 'run-tests'), 09:05:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:30 INFO - 'download_minidump_stackwalk': True, 09:05:30 INFO - 'download_symbols': 'ondemand', 09:05:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:30 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:30 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:30 INFO - 'installer_path': 'installer.exe', 09:05:30 INFO - 'log_level': 'info', 09:05:30 INFO - 'log_name': 'talos', 09:05:30 INFO - 'log_to_console': True, 09:05:30 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:05:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:05:30 INFO - 'opt_config_files': (), 09:05:30 INFO - 'pip_index': False, 09:05:30 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:05:30 INFO - 'cmd': ('bash', 09:05:30 INFO - '-c', 09:05:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:05:30 INFO - 'enabled': True, 09:05:30 INFO - 'halt_on_failure': False, 09:05:30 INFO - 'name': 'check_screen_resolution'},), 09:05:30 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:05:30 INFO - 'cmd': ('bash', 09:05:30 INFO - '-c', 09:05:30 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:05:30 INFO - 'enabled': True, 09:05:30 INFO - 'halt_on_failure': False, 09:05:30 INFO - 'name': 'check_screen_resolution'},), 09:05:30 INFO - 'run_cmd_checks_enabled': True, 09:05:30 INFO - 'sps_profile': False, 09:05:30 INFO - 'sps_profile_interval': 0, 09:05:30 INFO - 'suite': 'dromaeojs', 09:05:30 INFO - 'system_bits': '32', 09:05:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:30 INFO - 'title': 't-yosemite-r7-0029', 09:05:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:30 INFO - 'use_talos_json': True, 09:05:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:30 INFO - 'work_dir': 'build'} 09:05:30 INFO - [mozharness: 2017-02-17 17:05:30.277165Z] Running clobber step. 09:05:30 INFO - Running pre-action listener: _resource_record_pre_action 09:05:30 INFO - Running main action method: clobber 09:05:30 INFO - rmtree: /builds/slave/test/build 09:05:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:32 INFO - Running post-action listener: _resource_record_post_action 09:05:32 INFO - [mozharness: 2017-02-17 17:05:32.237442Z] Finished clobber step (success) 09:05:32 INFO - [mozharness: 2017-02-17 17:05:32.237615Z] Running read-buildbot-config step. 09:05:32 INFO - Running pre-action listener: _resource_record_pre_action 09:05:32 INFO - Running main action method: read_buildbot_config 09:05:32 INFO - Using buildbot properties: 09:05:32 INFO - { 09:05:32 INFO - "project": "", 09:05:32 INFO - "product": "firefox", 09:05:32 INFO - "script_repo_revision": "production", 09:05:32 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:05:32 INFO - "repository": "", 09:05:32 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:05:32 INFO - "buildid": "20170217080019", 09:05:32 INFO - "pgo_build": "False", 09:05:32 INFO - "basedir": "/builds/slave/test", 09:05:32 INFO - "buildnumber": 31, 09:05:32 INFO - "slavename": "t-yosemite-r7-0029", 09:05:32 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 09:05:32 INFO - "platform": "yosemite_r7", 09:05:32 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:05:32 INFO - "branch": "mozilla-aurora", 09:05:32 INFO - "repo_path": "releases/mozilla-aurora", 09:05:32 INFO - "revision": "2af97db52557c07ca1dc692bb5406ccafbb704e5", 09:05:32 INFO - "stage_platform": "macosx64", 09:05:32 INFO - "builduid": "54903267ba964a92a0a2af9607542772", 09:05:32 INFO - "slavebuilddir": "test" 09:05:32 INFO - } 09:05:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:05:32 INFO - Running post-action listener: _resource_record_post_action 09:05:32 INFO - [mozharness: 2017-02-17 17:05:32.241086Z] Finished read-buildbot-config step (success) 09:05:32 INFO - [mozharness: 2017-02-17 17:05:32.241175Z] Running download-and-extract step. 09:05:32 INFO - Running pre-action listener: _resource_record_pre_action 09:05:32 INFO - Running main action method: download_and_extract 09:05:32 INFO - mkdir: /builds/slave/test/build/tests 09:05:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:32 INFO - trying https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:05:32 INFO - Downloading https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:05:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:05:32 INFO - Downloaded 1199 bytes. 09:05:32 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:05:32 INFO - Using the following test package requirements: 09:05:32 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:05:32 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:05:32 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:05:32 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'jsshell-mac.zip'], 09:05:32 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:05:32 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:05:32 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:05:32 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:05:32 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:05:32 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:05:32 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:05:32 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:05:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:05:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:05:32 INFO - Fetch https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:05:33 INFO - Expected file size: 16358451 09:05:33 INFO - Obtained file size: 16358451 09:05:40 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:05:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:05:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:05:40 INFO - Fetch https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:05:41 INFO - Expected file size: 16358451 09:05:41 INFO - Obtained file size: 16358451 09:05:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:05:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:05:47 INFO - Fetch https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:05:49 INFO - Expected file size: 14403485 09:05:49 INFO - Obtained file size: 14403485 09:05: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')]} 09:05:49 INFO - trying https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:05:49 INFO - Downloading https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:05:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:05:51 INFO - Downloaded 73950172 bytes. 09:05:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:05:51 INFO - mkdir: /builds/slave/test/properties 09:05:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:51 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:51 INFO - Contents: 09:05:51 INFO - build_url:https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:05:52 INFO - Running post-action listener: _resource_record_post_action 09:05:52 INFO - Running post-action listener: set_extra_try_arguments 09:05:52 INFO - [mozharness: 2017-02-17 17:05:52.553449Z] Finished download-and-extract step (success) 09:05:52 INFO - [mozharness: 2017-02-17 17:05:52.553578Z] Running populate-webroot step. 09:05:52 INFO - Running pre-action listener: _resource_record_pre_action 09:05:52 INFO - Running main action method: populate_webroot 09:05:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:52 INFO - '--tppagecycles', 09:05:52 INFO - '7'], 09:05:52 INFO - 'tests': ['tsvgm']}}, 09:05:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:05:52 INFO - 'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:05:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:05:52 INFO - 'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['damp', 'tps']}, 09:05:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:05:52 INFO - 'tests': ['damp', 'tps']}, 09:05:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['dromaeo_dom']}, 09:05:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['basic_compositor_video']}, 09:05:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['a11yr', 09:05:52 INFO - 'ts_paint', 09:05:52 INFO - 'tpaint', 09:05:52 INFO - 'sessionrestore', 09:05:52 INFO - 'sessionrestore_no_auto_restore', 09:05:52 INFO - 'tabpaint']}, 09:05:52 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:52 INFO - 'ts_paint', 09:05:52 INFO - 'tpaint', 09:05:52 INFO - 'sessionrestore', 09:05:52 INFO - 'sessionrestore_no_auto_restore', 09:05:52 INFO - 'tabpaint']}, 09:05:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:52 INFO - 'ts_paint', 09:05:52 INFO - 'tpaint', 09:05:52 INFO - 'sessionrestore', 09:05:52 INFO - 'sessionrestore_no_auto_restore', 09:05:52 INFO - 'tabpaint']}, 09:05:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:52 INFO - 'ts_paint', 09:05:52 INFO - 'tpaint', 09:05:52 INFO - 'sessionrestore', 09:05:52 INFO - 'sessionrestore_no_auto_restore', 09:05:52 INFO - 'tabpaint']}, 09:05:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['a11yr', 09:05:52 INFO - 'ts_paint', 09:05:52 INFO - 'tpaint', 09:05:52 INFO - 'sessionrestore', 09:05:52 INFO - 'sessionrestore_no_auto_restore', 09:05:52 INFO - 'tabpaint']}, 09:05:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['a11yr', 09:05:52 INFO - 'ts_paint', 09:05:52 INFO - 'tpaint', 09:05:52 INFO - 'sessionrestore', 09:05:52 INFO - 'sessionrestore_no_auto_restore', 09:05:52 INFO - 'tabpaint']}, 09:05:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['tsvgx', 09:05:52 INFO - 'tsvgr_opacity', 09:05:52 INFO - 'tart', 09:05:52 INFO - 'tscrollx', 09:05:52 INFO - 'cart', 09:05:52 INFO - 'tsvg_static']}, 09:05:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:52 INFO - 'tsvgr_opacity', 09:05:52 INFO - 'tart', 09:05:52 INFO - 'tscrollx', 09:05:52 INFO - 'cart', 09:05:52 INFO - 'tsvg_static']}, 09:05:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:05:52 INFO - 'talos_options': ['--disable-e10s'], 09:05:52 INFO - 'tests': ['tp5o']}, 09:05:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:05:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:05:52 INFO - 'talos_options': ['--disable-e10s', 09:05:52 INFO - '--xperf_path', 09:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:52 INFO - 'tests': ['tp5n']}, 09:05:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:05:52 INFO - 'talos_options': ['--xperf_path', 09:05:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:52 INFO - 'tests': ['tp5n']}}, 09:05:52 INFO - 'talos.zip': {'path': '', 09:05:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:52 INFO - Running post-action listener: _resource_record_post_action 09:05:52 INFO - [mozharness: 2017-02-17 17:05:52.572388Z] Finished populate-webroot step (success) 09:05:52 INFO - [mozharness: 2017-02-17 17:05:52.572518Z] Running create-virtualenv step. 09:05:52 INFO - Running pre-action listener: _resource_record_pre_action 09:05:52 INFO - Running main action method: create_virtualenv 09:05:52 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:52 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:05:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:52 INFO - Using real prefix '/tools/python27' 09:05:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:53 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:56 INFO - Installing pip.................done. 09:05:56 INFO - Return code: 0 09:05:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:05:56 INFO - Reading from file tmpfile_stdout 09:05:56 INFO - Output received: 09:05:56 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:05:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:56 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:05:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:05:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:56 INFO - 'HOME': '/Users/cltbld', 09:05:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:56 INFO - 'LOGNAME': 'cltbld', 09:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:56 INFO - 'MOZ_NO_REMOTE': '1', 09:05:56 INFO - 'NO_EM_RESTART': '1', 09:05:56 INFO - 'PAGER': '/bin/cat', 09:05:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:56 INFO - 'PWD': '/builds/slave/test', 09:05:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:56 INFO - 'SHELL': '/bin/bash', 09:05:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:05:56 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:05:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:56 INFO - 'USER': 'cltbld', 09:05:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:56 INFO - 'XPC_FLAGS': '0x0', 09:05:56 INFO - 'XPC_SERVICE_NAME': '0', 09:05:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:05:56 INFO - Cleaning up... 09:05:56 INFO - Return code: 0 09:05:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:56 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:05:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:05:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:05:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:05:56 INFO - 'HOME': '/Users/cltbld', 09:05:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:05:56 INFO - 'LOGNAME': 'cltbld', 09:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:56 INFO - 'MOZ_NO_REMOTE': '1', 09:05:56 INFO - 'NO_EM_RESTART': '1', 09:05:56 INFO - 'PAGER': '/bin/cat', 09:05:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:56 INFO - 'PWD': '/builds/slave/test', 09:05:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:05:56 INFO - 'SHELL': '/bin/bash', 09:05:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:05:56 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:05:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:05:56 INFO - 'USER': 'cltbld', 09:05:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:05:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:56 INFO - 'XPC_FLAGS': '0x0', 09:05:56 INFO - 'XPC_SERVICE_NAME': '0', 09:05:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:05:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:57 INFO - Downloading/unpacking psutil>=3.1.1 09:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:06:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:00 INFO - Installing collected packages: psutil 09:06:00 INFO - Running setup.py install for psutil 09:06:00 INFO - building 'psutil._psutil_osx' extension 09:06:00 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:06:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:06:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:06:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:06:01 INFO - building 'psutil._psutil_posix' extension 09:06:01 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:06:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:06:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:06:01 INFO - ^ 09:06:01 INFO - 1 warning generated. 09:06:01 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:06:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:06:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:06:01 INFO - Successfully installed psutil 09:06:01 INFO - Cleaning up... 09:06:01 INFO - Return code: 0 09:06:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:06:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:06:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:01 INFO - 'HOME': '/Users/cltbld', 09:06:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:01 INFO - 'LOGNAME': 'cltbld', 09:06:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:01 INFO - 'MOZ_NO_REMOTE': '1', 09:06:01 INFO - 'NO_EM_RESTART': '1', 09:06:01 INFO - 'PAGER': '/bin/cat', 09:06:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:01 INFO - 'PWD': '/builds/slave/test', 09:06:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:01 INFO - 'SHELL': '/bin/bash', 09:06:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:01 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:01 INFO - 'USER': 'cltbld', 09:06:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:01 INFO - 'XPC_FLAGS': '0x0', 09:06:01 INFO - 'XPC_SERVICE_NAME': '0', 09:06:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:06:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:06:04 INFO - Installing collected packages: mozsystemmonitor 09:06:04 INFO - Running setup.py install for mozsystemmonitor 09:06:04 INFO - Successfully installed mozsystemmonitor 09:06:04 INFO - Cleaning up... 09:06:04 INFO - Return code: 0 09:06:04 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:06:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 09:06:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:04 INFO - 'HOME': '/Users/cltbld', 09:06:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:04 INFO - 'LOGNAME': 'cltbld', 09:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:04 INFO - 'MOZ_NO_REMOTE': '1', 09:06:04 INFO - 'NO_EM_RESTART': '1', 09:06:04 INFO - 'PAGER': '/bin/cat', 09:06:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:04 INFO - 'PWD': '/builds/slave/test', 09:06:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:04 INFO - 'SHELL': '/bin/bash', 09:06:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:04 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:04 INFO - 'USER': 'cltbld', 09:06:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:04 INFO - 'XPC_FLAGS': '0x0', 09:06:04 INFO - 'XPC_SERVICE_NAME': '0', 09:06:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:05 INFO - Downloading/unpacking jsonschema==2.5.1 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:06:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:08 INFO - Downloading functools32-3.2.3-2.tar.gz 09:06:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:06:08 INFO - warning: no files found matching '*.txt' 09:06:08 INFO - no previously-included directories found matching 'build' 09:06:08 INFO - no previously-included directories found matching 'dist' 09:06:08 INFO - no previously-included directories found matching '.git*' 09:06:08 INFO - Installing collected packages: jsonschema, functools32 09:06:08 INFO - Running setup.py install for functools32 09:06:08 INFO - warning: no files found matching '*.txt' 09:06:08 INFO - no previously-included directories found matching 'build' 09:06:08 INFO - no previously-included directories found matching 'dist' 09:06:08 INFO - no previously-included directories found matching '.git*' 09:06:08 INFO - Successfully installed jsonschema functools32 09:06:08 INFO - Cleaning up... 09:06:08 INFO - Return code: 0 09:06:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:08 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:08 INFO - 'HOME': '/Users/cltbld', 09:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:08 INFO - 'LOGNAME': 'cltbld', 09:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:08 INFO - 'MOZ_NO_REMOTE': '1', 09:06:08 INFO - 'NO_EM_RESTART': '1', 09:06:08 INFO - 'PAGER': '/bin/cat', 09:06:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:08 INFO - 'PWD': '/builds/slave/test', 09:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:08 INFO - 'SHELL': '/bin/bash', 09:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:08 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:08 INFO - 'USER': 'cltbld', 09:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:08 INFO - 'XPC_FLAGS': '0x0', 09:06:08 INFO - 'XPC_SERVICE_NAME': '0', 09:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:06:08 INFO - Cleaning up... 09:06:08 INFO - Return code: 0 09:06:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:08 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:06:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:08 INFO - 'HOME': '/Users/cltbld', 09:06:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:08 INFO - 'LOGNAME': 'cltbld', 09:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:08 INFO - 'MOZ_NO_REMOTE': '1', 09:06:08 INFO - 'NO_EM_RESTART': '1', 09:06:08 INFO - 'PAGER': '/bin/cat', 09:06:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:08 INFO - 'PWD': '/builds/slave/test', 09:06:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:08 INFO - 'SHELL': '/bin/bash', 09:06:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:08 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:08 INFO - 'USER': 'cltbld', 09:06:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:08 INFO - 'XPC_FLAGS': '0x0', 09:06:08 INFO - 'XPC_SERVICE_NAME': '0', 09:06:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:08 INFO - Downloading/unpacking blobuploader==1.2.4 09:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:06:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:06:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:06:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:12 INFO - Downloading docopt-0.6.1.tar.gz 09:06:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:06:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:06:12 INFO - Running setup.py install for blobuploader 09:06:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:06:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:06:13 INFO - Running setup.py install for requests 09:06:13 INFO - Running setup.py install for docopt 09:06:13 INFO - Successfully installed blobuploader requests docopt 09:06:13 INFO - Cleaning up... 09:06:13 INFO - Return code: 0 09:06:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:13 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:06:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:13 INFO - 'HOME': '/Users/cltbld', 09:06:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:13 INFO - 'LOGNAME': 'cltbld', 09:06:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:13 INFO - 'MOZ_NO_REMOTE': '1', 09:06:13 INFO - 'NO_EM_RESTART': '1', 09:06:13 INFO - 'PAGER': '/bin/cat', 09:06:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:13 INFO - 'PWD': '/builds/slave/test', 09:06:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:13 INFO - 'SHELL': '/bin/bash', 09:06:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:13 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:13 INFO - 'USER': 'cltbld', 09:06:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:13 INFO - 'XPC_FLAGS': '0x0', 09:06:13 INFO - 'XPC_SERVICE_NAME': '0', 09:06:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VVJh7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-TMD2n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-C21MTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Z0Lc4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zOFboD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-SkYwPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Ya3zAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:14 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zCgF5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-A4Q4Mn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-EgFWOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-c_Xn36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-dX9Gqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-IByUwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-xadpcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-eDDLWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-sgggyW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:15 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-yERZMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:06:15 INFO - Running setup.py install for manifestparser 09:06:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:06:16 INFO - Running setup.py install for mozcrash 09:06:16 INFO - Running setup.py install for mozdebug 09:06:16 INFO - Running setup.py install for mozdevice 09:06:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:06:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:06:16 INFO - Running setup.py install for mozfile 09:06:16 INFO - Running setup.py install for mozhttpd 09:06:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:06:16 INFO - Running setup.py install for mozinfo 09:06:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Running setup.py install for mozInstall 09:06:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Running setup.py install for mozleak 09:06:17 INFO - Running setup.py install for mozlog 09:06:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Running setup.py install for moznetwork 09:06:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Running setup.py install for mozprocess 09:06:17 INFO - Running setup.py install for mozprofile 09:06:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:06:17 INFO - Running setup.py install for mozrunner 09:06:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:06:18 INFO - Running setup.py install for mozscreenshot 09:06:18 INFO - Running setup.py install for moztest 09:06:18 INFO - Running setup.py install for mozversion 09:06:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:06:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:06:18 INFO - Cleaning up... 09:06:18 INFO - Return code: 0 09:06:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:18 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:06:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:18 INFO - 'HOME': '/Users/cltbld', 09:06:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:18 INFO - 'LOGNAME': 'cltbld', 09:06:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:18 INFO - 'MOZ_NO_REMOTE': '1', 09:06:18 INFO - 'NO_EM_RESTART': '1', 09:06:18 INFO - 'PAGER': '/bin/cat', 09:06:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:18 INFO - 'PWD': '/builds/slave/test', 09:06:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:18 INFO - 'SHELL': '/bin/bash', 09:06:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:18 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:18 INFO - 'USER': 'cltbld', 09:06:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:18 INFO - 'XPC_FLAGS': '0x0', 09:06:18 INFO - 'XPC_SERVICE_NAME': '0', 09:06:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:06:18 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ov79MB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-92xGKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-88Crb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nM8JR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-5ydmMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-ePn95_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-2dL1WX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-MRgRFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-7IswZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-VNvp9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:06:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:06:19 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-JwFIUG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:06:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XhHpJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:06:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-B3b8u9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:06:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-n7jSiN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-nNGoKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:06:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-SnfcZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:06:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:06:20 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-PHIKas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:06:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:06:23 INFO - Downloading blessings-1.6.tar.gz 09:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:06:23 INFO - Installing collected packages: blessings 09:06:23 INFO - Running setup.py install for blessings 09:06:23 INFO - Successfully installed blessings 09:06:23 INFO - Cleaning up... 09:06:23 INFO - Return code: 0 09:06:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:06:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:24 INFO - Reading from file tmpfile_stdout 09:06:24 INFO - Current package versions: 09:06:24 INFO - blessings == 1.6 09:06:24 INFO - blobuploader == 1.2.4 09:06:24 INFO - docopt == 0.6.1 09:06:24 INFO - functools32 == 3.2.3-2 09:06:24 INFO - jsonschema == 2.5.1 09:06:24 INFO - manifestparser == 1.1 09:06:24 INFO - mozInstall == 1.12 09:06:24 INFO - mozcrash == 1.0 09:06:24 INFO - mozdebug == 0.1 09:06:24 INFO - mozdevice == 0.49 09:06:24 INFO - mozfile == 1.2 09:06:24 INFO - mozhttpd == 0.7 09:06:24 INFO - mozinfo == 0.9 09:06:24 INFO - mozleak == 0.1 09:06:24 INFO - mozlog == 3.4 09:06:24 INFO - moznetwork == 0.27 09:06:24 INFO - mozprocess == 0.24 09:06:24 INFO - mozprofile == 0.28 09:06:24 INFO - mozrunner == 6.13 09:06:24 INFO - mozscreenshot == 0.1 09:06:24 INFO - mozsystemmonitor == 0.3 09:06:24 INFO - moztest == 0.8 09:06:24 INFO - mozversion == 1.4 09:06:24 INFO - psutil == 3.1.1 09:06:24 INFO - requests == 1.2.3 09:06:24 INFO - wsgiref == 0.1.2 09:06:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:24 INFO - 'HOME': '/Users/cltbld', 09:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:24 INFO - 'LOGNAME': 'cltbld', 09:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:24 INFO - 'MOZ_NO_REMOTE': '1', 09:06:24 INFO - 'NO_EM_RESTART': '1', 09:06:24 INFO - 'PAGER': '/bin/cat', 09:06:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:24 INFO - 'PWD': '/builds/slave/test', 09:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:24 INFO - 'SHELL': '/bin/bash', 09:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:24 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:24 INFO - 'USER': 'cltbld', 09:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:24 INFO - 'XPC_FLAGS': '0x0', 09:06:24 INFO - 'XPC_SERVICE_NAME': '0', 09:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:06:24 INFO - Cleaning up... 09:06:24 INFO - Return code: 0 09:06:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:06:24 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 0x109599b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10959c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb029497340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, '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.71hEb1gwd1/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.imGMGbHmrt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:24 INFO - 'HOME': '/Users/cltbld', 09:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:24 INFO - 'LOGNAME': 'cltbld', 09:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:24 INFO - 'MOZ_NO_REMOTE': '1', 09:06:24 INFO - 'NO_EM_RESTART': '1', 09:06:24 INFO - 'PAGER': '/bin/cat', 09:06:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:24 INFO - 'PWD': '/builds/slave/test', 09:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:24 INFO - 'SHELL': '/bin/bash', 09:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:24 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:24 INFO - 'USER': 'cltbld', 09:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:24 INFO - 'XPC_FLAGS': '0x0', 09:06:24 INFO - 'XPC_SERVICE_NAME': '0', 09:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:06:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:06:24 INFO - Cleaning up... 09:06:24 INFO - Return code: 0 09:06:24 INFO - Running post-action listener: _resource_record_post_action 09:06:24 INFO - Running post-action listener: _start_resource_monitoring 09:06:24 INFO - Starting resource monitoring. 09:06:24 INFO - [mozharness: 2017-02-17 17:06:24.615605Z] Finished create-virtualenv step (success) 09:06:24 INFO - [mozharness: 2017-02-17 17:06:24.616693Z] Running install step. 09:06:24 INFO - Running pre-action listener: _resource_record_pre_action 09:06:24 INFO - Running main action method: install 09:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:06:24 INFO - Reading from file tmpfile_stdout 09:06:24 INFO - Detecting whether we're running mozinstall >=1.0... 09:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:06:24 INFO - Reading from file tmpfile_stdout 09:06:24 INFO - Output received: 09:06:24 INFO - Usage: mozinstall [options] installer 09:06:24 INFO - Options: 09:06:24 INFO - -h, --help show this help message and exit 09:06:24 INFO - -d DEST, --destination=DEST 09:06:24 INFO - Directory to install application into. [default: 09:06:24 INFO - "/builds/slave/test"] 09:06:24 INFO - --app=APP Application being installed. [default: firefox] 09:06:24 INFO - mkdir: /builds/slave/test/build/application 09:06:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:06:44 INFO - Reading from file tmpfile_stdout 09:06:44 INFO - Output received: 09:06:44 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:06:44 INFO - Running post-action listener: _resource_record_post_action 09:06:44 INFO - [mozharness: 2017-02-17 17:06:44.982906Z] Finished install step (success) 09:06:44 INFO - [mozharness: 2017-02-17 17:06:44.983043Z] Running run-tests step. 09:06:44 INFO - Running pre-action listener: _resource_record_pre_action 09:06:44 INFO - Running main action method: run_tests 09:06:44 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:06:44 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:06:44 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:06:44 INFO - 2017-02-17 09:06:44.997 screenresolution[4041:50398] starting screenresolution argv=screenresolution get 09:06:45 INFO - 2017-02-17 09:06:45.000 screenresolution[4041:50398] Display 0: 1600x1200x32@60 09:06:45 INFO - 2017-02-17 09:06:45.006 screenresolution[4042:50400] starting screenresolution argv=screenresolution list 09:06:45 INFO - Available Modes on Display 0 09:06:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:06:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:06:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:06:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:06:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:06:45 INFO - Intel Iris: 09:06:45 INFO - Chipset Model: Intel Iris 09:06:45 INFO - Type: GPU 09:06:45 INFO - Bus: Built-In 09:06:45 INFO - VRAM (Dynamic, Max): 1536 MB 09:06:45 INFO - Vendor: Intel (0x8086) 09:06:45 INFO - Device ID: 0x0a2e 09:06:45 INFO - Revision ID: 0x0009 09:06:45 INFO - Displays: 09:06:45 INFO - Display: 09:06:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:06:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:06:45 INFO - Display Serial Number: 1600x1200 60 09:06:45 INFO - Main Display: Yes 09:06:45 INFO - Mirror: Off 09:06:45 INFO - Online: Yes 09:06:45 INFO - Rotation: Supported 09:06:45 INFO - Return code: 0 09:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:06:45 INFO - Python 2.7.3 09:06:45 INFO - Return code: 0 09:06:45 INFO - grabbing minidump binary from tooltool 09:06:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:06:45 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 0x109377d30>, '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 0x10929edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10936cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:06:45 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:06:45 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:06:45 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:06:45 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:06:45 INFO - Return code: 0 09:06:45 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:06:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:06:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:06:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:06:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:06:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:06:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:06:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.71hEb1gwd1/Render', 09:06:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:06:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:06:45 INFO - 'HOME': '/Users/cltbld', 09:06:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:06:45 INFO - 'LOGNAME': 'cltbld', 09:06:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:06:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:06:45 INFO - 'MOZ_NO_REMOTE': '1', 09:06:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:06:45 INFO - 'NO_EM_RESTART': '1', 09:06:45 INFO - 'PAGER': '/bin/cat', 09:06:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:06:45 INFO - 'PWD': '/builds/slave/test', 09:06:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:06:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:06:45 INFO - 'SHELL': '/bin/bash', 09:06:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.imGMGbHmrt/Listeners', 09:06:45 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 09:06:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:06:45 INFO - 'USER': 'cltbld', 09:06:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:06:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:06:45 INFO - 'XPC_FLAGS': '0x0', 09:06:45 INFO - 'XPC_SERVICE_NAME': '0', 09:06:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:06:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:06:45 INFO - mozversion application_buildid: 20170217080019 09:06:45 INFO - mozversion application_changeset: 2af97db52557c07ca1dc692bb5406ccafbb704e5 09:06:45 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:06:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:06:45 INFO - mozversion application_name: Firefox 09:06:45 INFO - mozversion application_remotingname: firefox-dev 09:06:45 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:06:45 INFO - mozversion application_vendor: Mozilla 09:06:45 INFO - mozversion application_version: 53.0a2 09:06:45 INFO - mozversion platform_buildid: 20170217080019 09:06:45 INFO - mozversion platform_changeset: 2af97db52557c07ca1dc692bb5406ccafbb704e5 09:06:45 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:06:45 INFO - mozversion platform_version: 53.0a2 09:06:45 INFO - using testdate: 1487351205 09:06:45 INFO - actual date: 1487351205 09:06:45 INFO - starting webserver on 'localhost:52766' 09:06:45 INFO - SUITE-START | Running 2 tests 09:06:45 INFO - TEST-START | dromaeo_css 09:06:45 INFO - operating with platform_type : mac_ 09:06:45 INFO - Initialising browser for dromaeo_css test... 09:06:45 INFO - TEST-INFO | started process 4052 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpFIQWHI/profile http://localhost:52766/getInfo.html) 09:06:47 INFO - PROCESS | 4052 | __metrics Screen width/height:1600/1200 09:06:47 INFO - PROCESS | 4052 | colorDepth:24 09:06:47 INFO - PROCESS | 4052 | Browser inner width/height: 1024/689 09:06:47 INFO - PROCESS | 4052 | __metrics 09:06:47 INFO - PROCESS | 4052 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:06:47 INFO - PROCESS | 4052 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:48 INFO - TEST-INFO | 4052: exit 0 09:06:48 INFO - Browser initialized. 09:06:48 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:48 INFO - TEST-INFO | started process 4054 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpFIQWHI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:07:00 INFO - PROCESS | 4054 | RSS: Main: 213032960 09:07:00 INFO - PROCESS | 4054 | 09:10:05 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:52766/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52766/tests/dromaeo/cssquery-ext.html) 09:10:07 INFO - PROCESS | 4054 | RSS: Main: 347914240 09:10:07 INFO - PROCESS | 4054 | 09:11:50 INFO - PROCESS | 4054 | ************************* 09:11:50 INFO - PROCESS | 4054 | A coding exception was thrown and uncaught in a Task. 09:11:50 INFO - PROCESS | 4054 | 09:11:50 ERROR - PROCESS | 4054 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:11:50 INFO - PROCESS | 4054 | Full stack: 09:11:50 INFO - PROCESS | 4054 | ************************* 09:13:09 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:52766/tests/dromaeo/cssquery-ext.html (next: http://localhost:52766/tests/dromaeo/cssquery-jquery.html) 09:13:10 INFO - PROCESS | 4054 | RSS: Main: 362295296 09:13:10 INFO - PROCESS | 4054 | 09:16:13 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:52766/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52766/tests/dromaeo/cssquery-mootools.html) 09:16:13 INFO - PROCESS | 4054 | RSS: Main: 322129920 09:16:13 INFO - PROCESS | 4054 | 09:19:15 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:52766/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52766/tests/dromaeo/cssquery-prototype.html) 09:19:16 INFO - PROCESS | 4054 | RSS: Main: 323645440 09:19:16 INFO - PROCESS | 4054 | 09:22:20 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:52766/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52766/tests/dromaeo/cssquery-yui.html) 09:22:20 INFO - PROCESS | 4054 | RSS: Main: 316047360 09:22:20 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | Cycle 1(1): loaded http://localhost:52766/tests/dromaeo/cssquery-yui.html (next: http://localhost:52766/tests/dromaeo/cssquery-dojo.html) 09:25:24 INFO - PROCESS | 4054 | RSS: Main: 465932288 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | __start_tp_report 09:25:24 INFO - PROCESS | 4054 | _x_x_mozilla_page_load 09:25:24 INFO - PROCESS | 4054 | _x_x_mozilla_page_load_details 09:25:24 INFO - PROCESS | 4054 | |i|pagename|runs| 09:25:24 INFO - PROCESS | 4054 | |0;dojo.html;3286.2113092857708;3286.342731453709;3294.3576002679474;3318.900432987008;3352.580927384077;5603.495685388314;5620.606557540974;5636.4927156555905;5639.351474580424;5652.236948012017;5659.462351076641;5705.087186050222;5738.483536481715;5752.511036561887;5753.971230143843;5199.610029247802;5216.8174113906025;5236.607254455912;5239.318888544484;5297.841064768063;5137.614678899079;5138.6146039047035;5269.394019687727;5291.100512912814;5324.227986941891;5185.144451165572;5200.5059519345605;5217.139172036609;5245.10833158364;5274.604404669646;5237.947620523803;5268.446813084609;5282.947170528284;5295.947040529603;5298.708571028592;5146.459621739701;5207.869803254911;5230.843074707765;5237.580993520509;5276.4459731728;5554.888902221974;5579.581531385163;5592.273004509429;5603.831885043455;5644.435556444364;6213.906791398133;6238.376162383771;6256.436920677115;6257.530685198628;6262.530310226751;5699.658020518741;6235.064740288947;6242.313345532033;6246.406591373812;6250.6874656267455;5584.329880414376;5598.1322894951345;5656.2929633795775;5856.853578660525;5932.881342373172;6207.96896015517;6223.471004964538;6244.250689917239;6281.089242059876;6304.211973503312;6148.077788331697;6157.876842463125;6180.721867515973;6184.8763024739255;6212.347703491068;6133.98789199786;6163.19878415812;6205.565610407228;6238.500919926395;6256.812295631138;6139.631622102688;6149.954507733696;6168.568200226031;6175.814725558241;6176.382361763787;6236.844078897973;6248.28144763349;6252.062190671345;6253.312135665074;6256.655883926337;4975.626827987915;4982.402111746614;5004.824831130893;5021.548060674557;5039.7228152451235;4388.5830846069575;4402.097569998143;4402.163588918095;4427.75647339393;4496.3255511673515;4916.754162291871;5814.302283725895;5880.059190529495;5882.852928676817;5889.558283128783;6143;6155.753769849156;6167.044108163242;6168.629882207082;6247.96876015617;5737.5983681141915;5754.654720716687;5804.187413762077;5834.854128646818;5866.472017518358;5270.314859068297;5311.28297679816;5419.078756611386;5422.864428389243;5429.728513574306;6115.635867915819;6212.81361559154;6246.125542424155;6255.624662520081;6268.6552239625435;6226.5641405101205;6233.750649974132;6237.688115594111;6255.437010669061;6259.874802504016;6271.341509141657;6293.842653933688;6303.49572034227;6303.810885673437;6304.401081897213;6043.063325184604;6043.3050199227655;6066.757329706762;6068.51451883857;6156.384361563987;6166.537509686881;6169.074638804036;6169.81490555284;6182.845428864314;6191.288001879661;5920.200772895604;6052.788152414644;6068.6358818471035;6072.210612620331;6087.117367981529;5958.6424814511265;6016.338202797601;6052.66710330936;6062.333143354139;6071.787487438095;5907.556933229939;5963.582549221513;5985.072313791369;6030.246219222598;6032.638041717335;6114.296855861633;6118.969405152946;6149.692515374303;6152.538559607958;6154.292256390572;5698.0598201296325;5808.041673123887;5969;6000.21997140369;6013.909791353046 09:25:24 INFO - PROCESS | 4054 | |1;ext.html;486.2099088980408;487.31532197262834;496.29278278453194;505.5929976369024;538.9893948845914;30596.54105188421;40141.59858401415;42377.364339534855;42531.14937701244;44251;43189.7840510797;43534.564654353526;43551.56448435515;43589.12821743571;43608.78195609018;8412.579371031454;8598.269147122503;9179.816403671939;9434.386764860297;9442.961274259826;11256.943715281412;11518.136139789507;11574.016208622277;11737.002354799852;11737.765244695102;11449.25579837312;11456.369899655516;11562.248453850514;11576.974029544837;11590.188686791886;11466.484008219608;11498.885011149865;11515.481803318871;11516.596919107875;11528.596499122574;11216.2709423888;11326.490307936163;11427.600033998853;11432.885671143265;11444.027257683107;40604.59395406038;40868.79565602153;40913;40921.1815763686;40925.59074409248;3910.6480416762342;3953.367461206193;3967.563568007517;3990.4812374391145;4015.8393664253394;29196.854015729998;29227.853860730775;30991;30996.53505197424;31376.843115784275;3047.344820863525;3095.195249235215;3104.099811054791;3192.393445245396;3214.586059843058;385225.0738746288;454750;455294;456221;457005;61706;61829.690851545456;62006;62143;62151.067733984026;65548.34451655518;65665.34334656688;65678.34321656723;65836.34163658398;65845;16555.17224138788;16616.418425355296;16814.57963550921;16818.411355602497;16825;11648.068154547616;12028.63914082579;12046.819297710541;12908.096433249582;12987.155834870704;19117.216331790853;21327.46681332979;22122.778772212394;22706;22732.65901011486;8445.282151017233;8624.266937310273;8704.695335663222;8714.738557843275;8734.56327183651;865.2904618213131;870.8693695945659;876.3602570123845;887.2680038967877;913.7715571107224;30910.69089309078;30982.22544436362;31083;31286.374272514422;31682.683173168436;1070.4166229404993;1078.827387617993;1085.2837127495973;1096.7861267053008;1210.4734440518403;13906.791398129037;15897.841021589868;15969.201539922957;16131.032138071754;16191.204321385627;612669;613790;618549;619643;620220;50739;54765.63085922884;58350.7082464585;61129.08306375408;61959.69020154871;1437.0443654969329;1448.9565313040625;1475.5425817996456;1481.4962912609765;1482.1922052481423;27993.44013119767;30104;30224.24439388945;30703.925362613096;30965;50420;50740.49259507358;50849.49150508447;50865.98268034545;50904.74547627238;517962;519346;521184;521358;522185.5016524342;35104;43772;44250.33624495571;45325.546744532134;45406.77296613496;39414;47595.28607070966;47908.04183916372;48105.75947120242;49261;29133.56299655549;35852.28295434129;37237.95191264506;39302.6069739299;40730;38790.80604596959;38911.832645020695;40119.79940100398;40268.79865600653;40588.594114058484;35928.64071359357;36659.26681466409;36738.89783306505;37964.62035379611;38080;29014.428324766577;29523;32293.838530807196;32799.344013119124;32962.67037329596;23895;24240.51518969646;24551.897873701993;24616.384590385383;24691.259262221443 09:25:24 INFO - PROCESS | 4054 | |2;jquery.html;370.2188382512899;387.113510061958;389.4528187896006;399.51059951559336;423.74575254847093;14774.755016797422;14991.850081499182;17862.374816881413;20186.59626807463;20698;20859.478513037182;21540.784592154072;21629.45926351842;21949.122035118577;22683.886580567076;5899.852503687399;6439.903401448982;6665.833354166136;6743.561668491532;6779.7966061018005;5795.623284486516;6640.402363787258;6671.232808227068;6691.966540167292;6694.364035416652;4465.5311192324825;5208.635395522315;7684.9615751921165;7744.341730952876;7828.295453409192;7513.2111128331835;7589.544627322323;7747.8450430991625;7762.30139287464;7815.179406162328;7558.811029724301;7561.848763024709;7563.470557061008;7563.886541701879;7575.810604734926;25289.494210115878;25616.487670246675;25648.61527077095;25856.353591160183;26300.73699263002;2925.0895359117812;2928.809627374214;2937.2363185571903;2941.3381989052505;2953.291210109558;16303.673926521522;16853;16916.83083169165;16971.57571060721;17852.642947140983;1990.6317331293612;2048.467398476392;2049.9795002050087;2050.149188086942;2075.730155079845;140594.15801057644;152573.47426525815;160010.19994900067;161268;167110;17109.743353849703;22669.17913319902;23348;23467.647985280233;24421.511569768507;42299.30802767855;42394.364084538756;43379.78310108429;43508.12983740371;43609.34585981213;8439.789005274917;8575.442596231225;8893.199612034949;8949.194572488377;8969;7479.027726395642;8603.956980215184;8687.472771198803;8747.387682862265;8974.41666291689;4868.561829435368;4878.829240976549;4889.242167464049;4901.3383193268455;4961.975190124026;2000.899955002244;2033.387097579603;2048.1602542957316;2054.3528788431595;2057.1051592557287;864.3906046237388;938.7653086728318;969.5443141723379;976.2434113561904;1011.6863772230632;20357.389278321672;21704.891475542838;21730;21878;22197.778022219893;973.8880028796638;984.3601658921758;994.3089552760762;999.5207093501658;1010.3382284603597;10167.288289819642;10594.226490046512;10605.681829545127;11134.443277836075;11207.327560346404;497511;508796;575400;728618;742812;116728.41635791937;138553;140302;147317;154298;878.7100256915203;1002.8144793213279;1060.8992145746142;1061.1987949098382;1061.543536279392;19211.711824322367;20632.852628899196;20823.375298741063;20946.895265523573;20955.057022434332;48631.756841216986;57442;57531;59426;60242;82406.17593823984;84997.15002849893;85981;86418.56790716006;86826.56586717025;8172.305354044735;8268.669253230044;8385.916140838757;8688.478691278544;8854.645814167361;8635.654573816977;8903.465792052497;9038.638454461749;9259.907400926175;9281.953590232006;7767.689292428239;7887.940293437456;7941.00737407824;8206.63070161856;8450.408471406943;7683.500572462772;7875.684972601031;8165.979252593425;8319.168083191633;8356.373272004503;7710.8843367350655;7902.24928631779;8212.3430125591;8241.95879020601;8693.782655433664;10368.170546356425;12135.271883687006;13153.93423032917;13232.603021909357;13583;11482.770344592895;11667.883321166679;11737.237079589799;11823.99496042846;12090.466075221791 09:25:24 INFO - PROCESS | 4054 | |3;mootools.html;1442.5888621742806;1452.6005348529154;1454.2219912346895;1473.7199932012916;1474.2997076388717;7932.841343173133;8273.793155171124;8296.419250652456;8306.54314012729;8317.708880189195;7288.453365997545;7536.208698086704;7545.886811697829;7854.450188486809;8084.959575202116;2283.942901427465;2324.941876453085;2332.0322066342446;2332.6617640442128;2335.1243283768586;2316.131450705985;2353.6940197774265;2355.4464700795384;2361.055577768898;2362.350353652742;2288.8054515366216;2296.230762694491;2319.536092781442;2319.5476882008015;2320.2807129789735;1968.3307675390292;2276.7609401012905;2289.8969546370454;2292.461271601189;2299.3331933739196;2102.2852230241638;2206;2276.430892276931;2289.4505318723554;2349.7415284318713;8121.512709237465;8176;8176.01887773471;8202.220789025034;8215.014198296183;4960.553550180465;5132.178851383798;5141.640085194038;5147.433782283946;5150.61370397218;3301.9174520636934;3458.723302135823;3490.3193877193958;3501.859925602973;3515.2617950230483;1150.8273758936143;1173.2198088271289;1197.700574856286;1248.7440074784738;1260.7793636113643;10463.895361046369;10552.314099583502;10590.41752703601;10611.893881061167;10625.946870265676;4400.75795831226;4590.495045544987;4677.883052923704;4698.95301046992;4701.459332176843;9221.031791661779;9221.53892305382;9240.8613870792;9251.537423128817;9254.814903701888;5156.716380599103;5160.819371321985;5164.1995490699;5169.7932082717025;5170.1986192140275;4638.512956139624;4640.141573808856;4688.624910007191;4729.810807567659;4776.164171270014;3889.2999260133447;3930.6855451563806;3962.900927476836;4007.218592374459;4027.489691365738;1280.0847394113255;1281.2312612432465;1281.858995510493;1297.9870201297865;1301.5249433956537;748.745426554963;783.5964478293683;887.7824932891483;897.6140259688266;902.9864552031725;5323.760430780624;5447.408794755829;5533.557315414757;5603.243562119062;5705.429457054344;977.4135518688872;980.9901900980899;1006.8389057750725;1015.2994433840627;1026.5175367577226;3689.5572531296416;3768.9057773555883;3769.473363287873;3784.129650180474;3913.941290880639;9496.24030077606;9794.853077203848;9806.65676701312;9834;9837.508124593742;8824.647014119491;8988.235999939947;9557.330986830993;9804.411735295906;9808;7667.156612772591;7818.8827167592535;7834.843303134019;7835.490693105044;7847.372210223169;5328.227407026037;5413.9729301353245;5419.945800541944;5506.779728810803;5615.298087739033;8895.199432051146;8898.955505222433;8923.241524470233;9201;9221.723348299562;7132.857342853217;8385.496870187564;9162.496062716347;9284.767880803034;9297.814043719223;7035.226125126334;7194.784156475314;7205.991161237326;7208.56748595086;7212.783616491513;7509.9249007509225;7624.771256862303;7700.576468294297;7715.537067775951;7730.420218483749;6971.51199416036;6972.965135174291;6985.685644145924;7010.158780946319;7092.397146242627;6865.725370985105;6905.413039891666;6952.409045231212;7002.1947476040905;7015.158181018311;6249.7187626557825;6298.685065746786;6360.268569114611;6362.522810789117;6365.522585806176;4737.739424331695;4820.132376172322;4914.189158788759;4926.507349265188;5065.974670126626;4870.4155501340065;4931.334269873521;4953.72754498506;4973.278874563096;5006.123928312458 09:25:24 INFO - PROCESS | 4054 | |4;prototype.html;279.7091025333653;280.65286624203816;350.83861423745077;360.42332268370603;366.19985332049475;4931.055155875303;4965.368354771972;5005.549500544946;5115.360579927509;5169.379674439063;4275.337322714984;4836.685615434994;5154.896902061956;5171.844844654666;5187.7924883004725;3326.717229035523;3908.882733517999;3951.834208908379;3967.8809635710977;3981.6615587674937;3126;3440.4839274108836;3892.9221415571815;3920.313945059603;3994.981279773668;3939.487866577341;3967.8016099194924;3974.8410063597566;3998.1603863188766;4026.2752704513177;3360.9495857562033;3456.6197718250974;3630.5280313559333;3994.7802870842092;3996.620321069494;3241.303119829248;3340.3152353767664;3385.851158422666;3439.0370696205105;3440.1571614954496;4777.655641051278;4905.283150897193;4991.2263599141825;5020.723860187688;5125.051865404912;3931.4889064421727;4441.777911104464;4476.664250181249;4480.395146655193;4490.29368839842;4501.23479008566;4538.183127037132;4563.813408513777;5264.210368444726;5485.9725701371635;2978.255436140965;3397.9296521595866;3559.199180184464;3674.9081272968124;3747.569029561608;5070.974645126787;5172.043172013189;5333.893322133575;5644.463775941279;5704.372519022904;3405.4891766235264;3558.8967420099852;3648.7263455240964;3888.2223555289056;3900.297946369624;3439.7420193485086;3834.7315687902137;3849.6508038007114;3884.3979183226643;3890.7549584132807;3487.773294735834;3681.9933136440704;4279.572042795696;4391.858116889632;4427.667924905645;5420.268263784417;5429.945700542944;5433.565314774809;5449.863753406196;5547.084731019337;1101.4492753623188;1229.9262044277373;1243.7512497500536;1244.9564265250672;1249.28790589365;721.570665454054;737.8044818123202;799.2726618776885;834.8372067446911;836;4457.128006237388;4727.692699974491;4756.904861902743;4810.518948105161;4929.654924155347;4747.95252047482;4802.759862006886;5133.230015497706;5190.169572868398;5261.263423120766;4571.839985600554;4587.931181032287;4772.809087636456;4789.832355867528;4796.752844260448;2537.949241015206;2754.4299749142797;2755.4489102179646;2771.7388588192325;2813.6904940456534;5023.623228257895;5087.338645976073;5451.863703407446;5457.890842183214;5604.943950560524;4971.898183998216;5050.646454748133;5066.645334826527;5405.594580406485;5480.232482596343;4732.881677958078;4873.439554451284;5157.896842063138;5241.043012525519;5372.919406208832;4635.817866444035;5081.8475445736685;5230.22172461365;5256.342957130359;5259.55293800016;4973.602111830973;5169.983706354449;5204.115300399017;5261.842894263411;5320.627556071038;4544.386507821402;5407.026735187704;5425.872550439796;5429.104197807317;5516.310461192351;3570.1610121621916;3571.285742851492;3581.8925432237074;3611.223586928823;3622.855085796644;4896.755162241802;4997.425296090996;5112.590992720648;5190.2229997346885;5281.366236051698;5230.424653288212;5337.919931201112;5362.444890981572;5364.578386727442;5486.561075113901;4825.855224343275;5275.762590683506;5469.781208751764;5473.397926228032;5491.835244942658;4589.511970902206;5000.549950504472;5059.293278096201;5368;5393.514583687487;4439.733615983051;4882.36529251195;5367.543758780391;5428.592855535771;5488.807891723771;4650.418857588436;5326.9200961984825;5397.356784170591;5426.945730542644;5435.972820135874 09:25:24 INFO - PROCESS | 4054 | |5;yui.html;698.1970733656292;719.8740220461418;765.3953376832303;810.8986376702912;820.3847114664001;14799.038062525942;15607.921960390182;15665.921670391632;15675.529734107995;15701.84298157018;14167.574972750808;14293.49972750954;14305.92847035766;14461.20463374514;14487.927560362183;663.8207683925338;686.9828254293658;832.4173078844802;846.6232526525667;851.5657014922373;829.2246749289403;860.5869182792263;863.5164307987516;864.576357584782;867.5315329721942;889.9065598112202;909.4452384045727;909.8089401225751;910.3763921713614;910.6858133943812;882.2104216725994;899.6491368366375;903.7514683462035;904.8280826642916;905.8278927003914;514.6860415146757;531.3623651618035;655.4625207329991;672.2168673495372;672.559473544829;14657.853421465863;15164.469243576423;15187.772183417257;15195.164265965368;15231.466898658493;13367.86632133676;13385.464581416732;13472.25902575358;13527.797083043763;13563.186208827403;11844.709313572332;12040.397980101048;12166.695832604168;12468.875311246862;12900;4192.832286708528;4343.717658352197;4366.19225443294;4378.036831896978;4502;104988.475057625;115640.42179789131;116482;116940;117250;10191.286609937233;10678.412687302272;10788;11007.944960275147;11230.775384492264;21666.458338541663;21971.121155153614;22028.229011984502;22139.55720885573;22188.445288867584;7553.1313898901235;7635.618219089023;7642.159362470124;7666.080070391477;7673.577953212627;4062.207869465485;4084.223997440477;4191.97904010478;4236.068065025689;4304.82780688769;3422.3839708852147;3532.2582257726167;3532.434810430319;3540.539729835105;3541.858325666996;622.9595076320024;634.2072409488139;645.2192846655505;653.7646447278976;659.350539718377;622.9252489701265;626.426819460198;633.7845132654919;652.709544252803;677.5223467455432;8470.49177049379;10485.213608979357;10587.523561439753;10988.780224395467;11169.553217871195;550.7383992603561;572.6228420648347;579.6290374160541;580.6342004537115;721.4012369733109;4781.091592597395;4944.728039957837;4959.900801984012;4960.528749768766;4967.652264341461;100108;102202.46696299562;102213;102372.48813755883;106191;88002;89786.10213897777;89968.99999999869;90133.54933225292;91979.0802091984;62079.68960155261;79340.01649958681;79493;80874.59562702148;81176;9254.074592540961;9364.250859931326;9390.765230869283;9436.245100392089;9452.338336316392;40300.99999999883;49592.256116157565;49813.75465613389;50113.74943125261;51107.488925111764;56287.592810180075;60474.395256046875;66121.67756644936;66258;67378.32621673917;9383.343165978316;11041.613543525938;11188.272762270752;11819.763604728028;11883.16817822744;11944.343061131722;12282.14025018276;12316.630501084981;12459.111073492719;12612.369381530703;11246.325220486797;11297.604583839526;11762.58830940913;12090;12115.333656648969;11521.53913843437;11620;11621.709457263298;11849.585264515701;12361.320127393079;12793.552225672056;13056.543020994599;13273.084440090004;14225.14649121056;14518.419263229353;10272.794544108927;10425.704720587992;10604.363738175734;10977.560897564008;11314.377709226072;9173.633054677739;11028.393438360967;11192.65054927638;11368.204225704121;11400.201985860911 09:25:24 INFO - PROCESS | 4054 | __end_tp_report 09:25:24 INFO - PROCESS | 4054 | __start_cc_report 09:25:24 INFO - PROCESS | 4054 | _x_x_mozilla_cycle_collect,1538 09:25:24 INFO - PROCESS | 4054 | __end_cc_report 09:25:24 INFO - PROCESS | 4054 | __startTimestamp1487352324533__endTimestamp 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | ------- Summary: start ------- 09:25:24 INFO - PROCESS | 4054 | Number of tests: 6 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | [#0] dojo.html Cycles:165 Average:5731.69 Median:5969.00 stddev:632.27 (10.6%) stddev-sans-first:604.40 09:25:24 INFO - PROCESS | 4054 | Values: 3286.2 3286.3 3294.4 3318.9 3352.6 5603.5 5620.6 5636.5 5639.4 5652.2 5659.5 5705.1 5738.5 5752.5 5754.0 5199.6 5216.8 5236.6 5239.3 5297.8 5137.6 5138.6 5269.4 5291.1 5324.2 5185.1 5200.5 5217.1 5245.1 5274.6 5237.9 5268.4 5282.9 5295.9 5298.7 5146.5 5207.9 5230.8 5237.6 5276.4 5554.9 5579.6 5592.3 5603.8 5644.4 6213.9 6238.4 6256.4 6257.5 6262.5 5699.7 6235.1 6242.3 6246.4 6250.7 5584.3 5598.1 5656.3 5856.9 5932.9 6208.0 6223.5 6244.3 6281.1 6304.2 6148.1 6157.9 6180.7 6184.9 6212.3 6134.0 6163.2 6205.6 6238.5 6256.8 6139.6 6150.0 6168.6 6175.8 6176.4 6236.8 6248.3 6252.1 6253.3 6256.7 4975.6 4982.4 5004.8 5021.5 5039.7 4388.6 4402.1 4402.2 4427.8 4496.3 4916.8 5814.3 5880.1 5882.9 5889.6 6143.0 6155.8 6167.0 6168.6 6248.0 5737.6 5754.7 5804.2 5834.9 5866.5 5270.3 5311.3 5419.1 5422.9 5429.7 6115.6 6212.8 6246.1 6255.6 6268.7 6226.6 6233.8 6237.7 6255.4 6259.9 6271.3 6293.8 6303.5 6303.8 6304.4 6043.1 6043.3 6066.8 6068.5 6156.4 6166.5 6169.1 6169.8 6182.8 6191.3 5920.2 6052.8 6068.6 6072.2 6087.1 5958.6 6016.3 6052.7 6062.3 6071.8 5907.6 5963.6 5985.1 6030.2 6032.6 6114.3 6119.0 6149.7 6152.5 6154.3 5698.1 5808.0 5969.0 6000.2 6013.9 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | [#1] ext.html Cycles:180 Average:67498.14 Median:212007.94 stddev:141534.94 (66.8%) stddev-sans-first:141842.56 09:25:24 INFO - PROCESS | 4054 | Values: 486.2 487.3 496.3 505.6 539.0 30596.5 40141.6 42377.4 42531.1 44251.0 43189.8 43534.6 43551.6 43589.1 43608.8 8412.6 8598.3 9179.8 9434.4 9443.0 11256.9 11518.1 11574.0 11737.0 11737.8 11449.3 11456.4 11562.2 11577.0 11590.2 11466.5 11498.9 11515.5 11516.6 11528.6 11216.3 11326.5 11427.6 11432.9 11444.0 40604.6 40868.8 40913.0 40921.2 40925.6 3910.6 3953.4 3967.6 3990.5 4015.8 29196.9 29227.9 30991.0 30996.5 31376.8 3047.3 3095.2 3104.1 3192.4 3214.6 385225.1 454750.0 455294.0 456221.0 457005.0 61706.0 61829.7 62006.0 62143.0 62151.1 65548.3 65665.3 65678.3 65836.3 65845.0 16555.2 16616.4 16814.6 16818.4 16825.0 11648.1 12028.6 12046.8 12908.1 12987.2 19117.2 21327.5 22122.8 22706.0 22732.7 8445.3 8624.3 8704.7 8714.7 8734.6 865.3 870.9 876.4 887.3 913.8 30910.7 30982.2 31083.0 31286.4 31682.7 1070.4 1078.8 1085.3 1096.8 1210.5 13906.8 15897.8 15969.2 16131.0 16191.2 612669.0 613790.0 618549.0 619643.0 620220.0 50739.0 54765.6 58350.7 61129.1 61959.7 1437.0 1449.0 1475.5 1481.5 1482.2 27993.4 30104.0 30224.2 30703.9 30965.0 50420.0 50740.5 50849.5 50866.0 50904.7 517962.0 519346.0 521184.0 521358.0 522185.5 35104.0 43772.0 44250.3 45325.5 45406.8 39414.0 47595.3 47908.0 48105.8 49261.0 29133.6 35852.3 37238.0 39302.6 40730.0 38790.8 38911.8 40119.8 40268.8 40588.6 35928.6 36659.3 36738.9 37964.6 38080.0 29014.4 29523.0 32293.8 32799.3 32962.7 23895.0 24240.5 24551.9 24616.4 24691.3 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | [#2] jquery.html Cycles:180 Average:38388.84 Median:24037.44 stddev:104612.48 (435.2%) stddev-sans-first:104867.00 09:25:24 INFO - PROCESS | 4054 | Values: 370.2 387.1 389.5 399.5 423.7 14774.8 14991.9 17862.4 20186.6 20698.0 20859.5 21540.8 21629.5 21949.1 22683.9 5899.9 6439.9 6665.8 6743.6 6779.8 5795.6 6640.4 6671.2 6692.0 6694.4 4465.5 5208.6 7685.0 7744.3 7828.3 7513.2 7589.5 7747.8 7762.3 7815.2 7558.8 7561.8 7563.5 7563.9 7575.8 25289.5 25616.5 25648.6 25856.4 26300.7 2925.1 2928.8 2937.2 2941.3 2953.3 16303.7 16853.0 16916.8 16971.6 17852.6 1990.6 2048.5 2050.0 2050.1 2075.7 140594.2 152573.5 160010.2 161268.0 167110.0 17109.7 22669.2 23348.0 23467.6 24421.5 42299.3 42394.4 43379.8 43508.1 43609.3 8439.8 8575.4 8893.2 8949.2 8969.0 7479.0 8604.0 8687.5 8747.4 8974.4 4868.6 4878.8 4889.2 4901.3 4962.0 2000.9 2033.4 2048.2 2054.4 2057.1 864.4 938.8 969.5 976.2 1011.7 20357.4 21704.9 21730.0 21878.0 22197.8 973.9 984.4 994.3 999.5 1010.3 10167.3 10594.2 10605.7 11134.4 11207.3 497511.0 508796.0 575400.0 728618.0 742812.0 116728.4 138553.0 140302.0 147317.0 154298.0 878.7 1002.8 1060.9 1061.2 1061.5 19211.7 20632.9 20823.4 20946.9 20955.1 48631.8 57442.0 57531.0 59426.0 60242.0 82406.2 84997.2 85981.0 86418.6 86826.6 8172.3 8268.7 8385.9 8688.5 8854.6 8635.7 8903.5 9038.6 9259.9 9282.0 7767.7 7887.9 7941.0 8206.6 8450.4 7683.5 7875.7 8166.0 8319.2 8356.4 7710.9 7902.2 8212.3 8242.0 8693.8 10368.2 12135.3 13153.9 13232.6 13583.0 11482.8 11667.9 11737.2 11824.0 12090.5 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | [#3] mootools.html Cycles:180 Average:5346.27 Median:5167.00 stddev:2848.53 (55.1%) stddev-sans-first:2841.41 09:25:24 INFO - PROCESS | 4054 | Values: 1442.6 1452.6 1454.2 1473.7 1474.3 7932.8 8273.8 8296.4 8306.5 8317.7 7288.5 7536.2 7545.9 7854.5 8085.0 2283.9 2324.9 2332.0 2332.7 2335.1 2316.1 2353.7 2355.4 2361.1 2362.4 2288.8 2296.2 2319.5 2319.5 2320.3 1968.3 2276.8 2289.9 2292.5 2299.3 2102.3 2206.0 2276.4 2289.5 2349.7 8121.5 8176.0 8176.0 8202.2 8215.0 4960.6 5132.2 5141.6 5147.4 5150.6 3301.9 3458.7 3490.3 3501.9 3515.3 1150.8 1173.2 1197.7 1248.7 1260.8 10463.9 10552.3 10590.4 10611.9 10625.9 4400.8 4590.5 4677.9 4699.0 4701.5 9221.0 9221.5 9240.9 9251.5 9254.8 5156.7 5160.8 5164.2 5169.8 5170.2 4638.5 4640.1 4688.6 4729.8 4776.2 3889.3 3930.7 3962.9 4007.2 4027.5 1280.1 1281.2 1281.9 1298.0 1301.5 748.7 783.6 887.8 897.6 903.0 5323.8 5447.4 5533.6 5603.2 5705.4 977.4 981.0 1006.8 1015.3 1026.5 3689.6 3768.9 3769.5 3784.1 3913.9 9496.2 9794.9 9806.7 9834.0 9837.5 8824.6 8988.2 9557.3 9804.4 9808.0 7667.2 7818.9 7834.8 7835.5 7847.4 5328.2 5414.0 5419.9 5506.8 5615.3 8895.2 8899.0 8923.2 9201.0 9221.7 7132.9 8385.5 9162.5 9284.8 9297.8 7035.2 7194.8 7206.0 7208.6 7212.8 7509.9 7624.8 7700.6 7715.5 7730.4 6971.5 6973.0 6985.7 7010.2 7092.4 6865.7 6905.4 6952.4 7002.2 7015.2 6249.7 6298.7 6360.3 6362.5 6365.5 4737.7 4820.1 4914.2 4926.5 5066.0 4870.4 4931.3 4953.7 4973.3 5006.1 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | [#4] prototype.html Cycles:180 Average:4277.54 Median:4806.64 stddev:1301.83 (27.1%) stddev-sans-first:1270.43 09:25:24 INFO - PROCESS | 4054 | Values: 279.7 280.7 350.8 360.4 366.2 4931.1 4965.4 5005.5 5115.4 5169.4 4275.3 4836.7 5154.9 5171.8 5187.8 3326.7 3908.9 3951.8 3967.9 3981.7 3126.0 3440.5 3892.9 3920.3 3995.0 3939.5 3967.8 3974.8 3998.2 4026.3 3360.9 3456.6 3630.5 3994.8 3996.6 3241.3 3340.3 3385.9 3439.0 3440.2 4777.7 4905.3 4991.2 5020.7 5125.1 3931.5 4441.8 4476.7 4480.4 4490.3 4501.2 4538.2 4563.8 5264.2 5486.0 2978.3 3397.9 3559.2 3674.9 3747.6 5071.0 5172.0 5333.9 5644.5 5704.4 3405.5 3558.9 3648.7 3888.2 3900.3 3439.7 3834.7 3849.7 3884.4 3890.8 3487.8 3682.0 4279.6 4391.9 4427.7 5420.3 5429.9 5433.6 5449.9 5547.1 1101.4 1229.9 1243.8 1245.0 1249.3 721.6 737.8 799.3 834.8 836.0 4457.1 4727.7 4756.9 4810.5 4929.7 4748.0 4802.8 5133.2 5190.2 5261.3 4571.8 4587.9 4772.8 4789.8 4796.8 2537.9 2754.4 2755.4 2771.7 2813.7 5023.6 5087.3 5451.9 5457.9 5604.9 4971.9 5050.6 5066.6 5405.6 5480.2 4732.9 4873.4 5157.9 5241.0 5372.9 4635.8 5081.8 5230.2 5256.3 5259.6 4973.6 5170.0 5204.1 5261.8 5320.6 4544.4 5407.0 5425.9 5429.1 5516.3 3570.2 3571.3 3581.9 3611.2 3622.9 4896.8 4997.4 5112.6 5190.2 5281.4 5230.4 5337.9 5362.4 5364.6 5486.6 4825.9 5275.8 5469.8 5473.4 5491.8 4589.5 5000.5 5059.3 5368.0 5393.5 4439.7 4882.4 5367.5 5428.6 5488.8 4650.4 5326.9 5397.4 5426.9 5436.0 09:25:24 INFO - PROCESS | 4054 | 09:25:24 INFO - PROCESS | 4054 | [#5] yui.html Cycles:180 Average:20316.91 Median:4192.41 stddev:29915.46 (713.6%) stddev-sans-first:29963.11 09:25:24 INFO - PROCESS | 4054 | Values: 698.2 719.9 765.4 810.9 820.4 14799.0 15607.9 15665.9 15675.5 15701.8 14167.6 14293.5 14305.9 14461.2 14487.9 663.8 687.0 832.4 846.6 851.6 829.2 860.6 863.5 864.6 867.5 889.9 909.4 909.8 910.4 910.7 882.2 899.6 903.8 904.8 905.8 514.7 531.4 655.5 672.2 672.6 14657.9 15164.5 15187.8 15195.2 15231.5 13367.9 13385.5 13472.3 13527.8 13563.2 11844.7 12040.4 12166.7 12468.9 12900.0 4192.8 4343.7 4366.2 4378.0 4502.0 104988.5 115640.4 116482.0 116940.0 117250.0 10191.3 10678.4 10788.0 11007.9 11230.8 21666.5 21971.1 22028.2 22139.6 22188.4 7553.1 7635.6 7642.2 7666.1 7673.6 4062.2 4084.2 4192.0 4236.1 4304.8 3422.4 3532.3 3532.4 3540.5 3541.9 623.0 634.2 645.2 653.8 659.4 622.9 626.4 633.8 652.7 677.5 8470.5 10485.2 10587.5 10988.8 11169.6 550.7 572.6 579.6 580.6 721.4 4781.1 4944.7 4959.9 4960.5 4967.7 100108.0 102202.5 102213.0 102372.5 106191.0 88002.0 89786.1 89969.0 90133.5 91979.1 62079.7 79340.0 79493.0 80874.6 81176.0 9254.1 9364.3 9390.8 9436.2 9452.3 40301.0 49592.3 49813.8 50113.7 51107.5 56287.6 60474.4 66121.7 66258.0 67378.3 9383.3 11041.6 11188.3 11819.8 11883.2 11944.3 12282.1 12316.6 12459.1 12612.4 11246.3 11297.6 11762.6 12090.0 12115.3 11521.5 11620.0 11621.7 11849.6 12361.3 12793.6 13056.5 13273.1 14225.1 14518.4 10272.8 10425.7 10604.4 10977.6 11314.4 9173.6 11028.4 11192.7 11368.2 11400.2 09:25:24 INFO - PROCESS | 4054 | -------- Summary: end -------- 09:25:24 INFO - PROCESS | 4054 | 09:25:25 INFO - TEST-INFO | 4054: exit 0 09:25:25 INFO - TEST-OK | dromaeo_css | took 1119610ms 09:25:25 INFO - TEST-START | kraken 09:25:25 INFO - operating with platform_type : mac_ 09:25:25 INFO - Initialising browser for kraken test... 09:25:25 INFO - TEST-INFO | started process 4059 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpnI3BaT/profile http://localhost:52766/getInfo.html) 09:25:27 INFO - PROCESS | 4059 | __metrics Screen width/height:1600/1200 09:25:27 INFO - PROCESS | 4059 | colorDepth:24 09:25:27 INFO - PROCESS | 4059 | Browser inner width/height: 1024/689 09:25:27 INFO - PROCESS | 4059 | __metrics 09:25:27 INFO - PROCESS | 4059 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:25:27 INFO - PROCESS | 4059 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:28 INFO - TEST-INFO | 4059: exit 0 09:25:28 INFO - Browser initialized. 09:25:28 INFO - Running cycle 1/1 for kraken test... 09:25:28 INFO - TEST-INFO | started process 4060 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpnI3BaT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:40 INFO - PROCESS | 4060 | RSS: Main: 213688320 09:25:40 INFO - PROCESS | 4060 | 09:25:43 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52766/tests/kraken/driver.html?testName=audio-beat-detection) 09:25:44 INFO - PROCESS | 4060 | RSS: Main: 266743808 09:25:44 INFO - PROCESS | 4060 | 09:25:46 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52766/tests/kraken/driver.html?testName=audio-dft) 09:25:47 INFO - PROCESS | 4060 | RSS: Main: 276496384 09:25:47 INFO - PROCESS | 4060 | 09:25:50 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52766/tests/kraken/driver.html?testName=audio-fft) 09:25:51 INFO - PROCESS | 4060 | RSS: Main: 373710848 09:25:51 INFO - PROCESS | 4060 | 09:25:53 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52766/tests/kraken/driver.html?testName=audio-oscillator) 09:25:53 INFO - PROCESS | 4060 | RSS: Main: 276336640 09:25:53 INFO - PROCESS | 4060 | 09:25:55 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52766/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:56 INFO - PROCESS | 4060 | RSS: Main: 278982656 09:25:56 INFO - PROCESS | 4060 | 09:25:59 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52766/tests/kraken/driver.html?testName=imaging-darkroom) 09:26:00 INFO - PROCESS | 4060 | RSS: Main: 318341120 09:26:00 INFO - PROCESS | 4060 | 09:26:02 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52766/tests/kraken/driver.html?testName=imaging-desaturate) 09:26:03 INFO - PROCESS | 4060 | RSS: Main: 318963712 09:26:03 INFO - PROCESS | 4060 | 09:26:06 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52766/tests/kraken/driver.html?testName=json-parse-financial) 09:26:06 INFO - PROCESS | 4060 | RSS: Main: 318619648 09:26:06 INFO - PROCESS | 4060 | 09:26:08 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52766/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:26:09 INFO - PROCESS | 4060 | RSS: Main: 295555072 09:26:09 INFO - PROCESS | 4060 | 09:26:11 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:26:11 INFO - PROCESS | 4060 | RSS: Main: 299200512 09:26:11 INFO - PROCESS | 4060 | 09:26:13 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:26:14 INFO - PROCESS | 4060 | RSS: Main: 300212224 09:26:14 INFO - PROCESS | 4060 | 09:26:17 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:26:18 INFO - PROCESS | 4060 | RSS: Main: 318742528 09:26:18 INFO - PROCESS | 4060 | 09:26:21 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:26:21 INFO - PROCESS | 4060 | RSS: Main: 312762368 09:26:21 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | Cycle 1(1): loaded http://localhost:52766/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52766/tests/kraken/driver.html?testName=ai-astar) 09:26:23 INFO - PROCESS | 4060 | RSS: Main: 357163008 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | __start_tp_report 09:26:23 INFO - PROCESS | 4060 | _x_x_mozilla_page_load 09:26:23 INFO - PROCESS | 4060 | _x_x_mozilla_page_load_details 09:26:23 INFO - PROCESS | 4060 | |i|pagename|runs| 09:26:23 INFO - PROCESS | 4060 | |0;ai-astar;115;115;114;114;115;125;167;151;114;114 09:26:23 INFO - PROCESS | 4060 | |1;audio-beat-detection;142;109;108;144;111;111;96;119;156;141 09:26:23 INFO - PROCESS | 4060 | |2;audio-dft;185;184;187;190;186;183;185;186;184;186 09:26:23 INFO - PROCESS | 4060 | |3;audio-fft;82;58;58;88;61;59;58;57;75;58 09:26:23 INFO - PROCESS | 4060 | |4;audio-oscillator;88;70;88;70;68;69;82;68;72;99 09:26:23 INFO - PROCESS | 4060 | |5;imaging-gaussian-blur;90;87;89;86;89;85;89;88;89;86 09:26:23 INFO - PROCESS | 4060 | |6;imaging-darkroom;95;94;95;96;94;95;94;95;94;93 09:26:23 INFO - PROCESS | 4060 | |7;imaging-desaturate;85;86;86;86;85;85;87;88;84;85 09:26:23 INFO - PROCESS | 4060 | |8;json-parse-financial;55;53;52;53;54;58;56;56;54;56 09:26:23 INFO - PROCESS | 4060 | |9;json-stringify-tinderbox;71;78;80;76;71;70;73;71;71;72 09:26:23 INFO - PROCESS | 4060 | |10;stanford-crypto-aes;84;83;87;87;82;86;84;82;84;83 09:26:23 INFO - PROCESS | 4060 | |11;stanford-crypto-ccm;140;140;138;137;138;139;142;141;186;154 09:26:23 INFO - PROCESS | 4060 | |12;stanford-crypto-pbkdf2;167;170;167;181;215;159;162;171;167;165 09:26:23 INFO - PROCESS | 4060 | |13;stanford-crypto-sha256-iterative;65;65;66;64;66;65;66;65;63;64 09:26:23 INFO - PROCESS | 4060 | __end_tp_report 09:26:23 INFO - PROCESS | 4060 | __start_cc_report 09:26:23 INFO - PROCESS | 4060 | _x_x_mozilla_cycle_collect,2157 09:26:23 INFO - PROCESS | 4060 | __end_cc_report 09:26:23 INFO - PROCESS | 4060 | __startTimestamp1487352383717__endTimestamp 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | ------- Summary: start ------- 09:26:23 INFO - PROCESS | 4060 | Number of tests: 14 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#0] ai-astar Cycles:10 Average:124.40 Median:115.00 stddev:18.92 (16.4%) stddev-sans-first:19.76 09:26:23 INFO - PROCESS | 4060 | Values: 115.0 115.0 114.0 114.0 115.0 125.0 167.0 151.0 114.0 114.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#1] audio-beat-detection Cycles:10 Average:123.70 Median:141.50 stddev:20.18 (14.3%) stddev-sans-first:20.29 09:26:23 INFO - PROCESS | 4060 | Values: 142.0 109.0 108.0 144.0 111.0 111.0 96.0 119.0 156.0 141.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#2] audio-dft Cycles:10 Average:185.60 Median:186.00 stddev:1.96 (1.1%) stddev-sans-first:2.06 09:26:23 INFO - PROCESS | 4060 | Values: 185.0 184.0 187.0 190.0 186.0 183.0 185.0 186.0 184.0 186.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#3] audio-fft Cycles:10 Average:65.40 Median:60.00 stddev:11.68 (19.5%) stddev-sans-first:10.74 09:26:23 INFO - PROCESS | 4060 | Values: 82.0 58.0 58.0 88.0 61.0 59.0 58.0 57.0 75.0 58.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:77.00 stddev:11.05 (14.3%) stddev-sans-first:11.03 09:26:23 INFO - PROCESS | 4060 | Values: 88.0 70.0 88.0 70.0 68.0 69.0 82.0 68.0 72.0 99.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:89.00 stddev:1.69 (1.9%) stddev-sans-first:1.59 09:26:23 INFO - PROCESS | 4060 | Values: 90.0 87.0 89.0 86.0 89.0 85.0 89.0 88.0 89.0 86.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#6] imaging-darkroom Cycles:10 Average:94.50 Median:95.00 stddev:0.85 (0.9%) stddev-sans-first:0.88 09:26:23 INFO - PROCESS | 4060 | Values: 95.0 94.0 95.0 96.0 94.0 95.0 94.0 95.0 94.0 93.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.16 (1.3%) stddev-sans-first:1.20 09:26:23 INFO - PROCESS | 4060 | Values: 85.0 86.0 86.0 86.0 85.0 85.0 87.0 88.0 84.0 85.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#8] json-parse-financial Cycles:10 Average:54.70 Median:55.50 stddev:1.83 (3.3%) stddev-sans-first:1.94 09:26:23 INFO - PROCESS | 4060 | Values: 55.0 53.0 52.0 53.0 54.0 58.0 56.0 56.0 54.0 56.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#9] json-stringify-tinderbox Cycles:10 Average:73.30 Median:72.50 stddev:3.47 (4.8%) stddev-sans-first:3.57 09:26:23 INFO - PROCESS | 4060 | Values: 71.0 78.0 80.0 76.0 71.0 70.0 73.0 71.0 71.0 72.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:1.87 (2.2%) stddev-sans-first:1.99 09:26:23 INFO - PROCESS | 4060 | Values: 84.0 83.0 87.0 87.0 82.0 86.0 84.0 82.0 84.0 83.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#11] stanford-crypto-ccm Cycles:10 Average:145.50 Median:140.50 stddev:15.03 (10.7%) stddev-sans-first:15.81 09:26:23 INFO - PROCESS | 4060 | Values: 140.0 140.0 138.0 137.0 138.0 139.0 142.0 141.0 186.0 154.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.40 Median:168.50 stddev:16.08 (9.5%) stddev-sans-first:16.93 09:26:23 INFO - PROCESS | 4060 | Values: 167.0 170.0 167.0 181.0 215.0 159.0 162.0 171.0 167.0 165.0 09:26:23 INFO - PROCESS | 4060 | 09:26:23 INFO - PROCESS | 4060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 09:26:23 INFO - PROCESS | 4060 | Values: 65.0 65.0 66.0 64.0 66.0 65.0 66.0 65.0 63.0 64.0 09:26:23 INFO - PROCESS | 4060 | -------- Summary: end -------- 09:26:23 INFO - PROCESS | 4060 | 09:26:24 INFO - TEST-INFO | 4060: exit 0 09:26:24 INFO - TEST-OK | kraken | took 59448ms 09:26:24 INFO - SUITE-END | took 1179s 09:26:24 INFO - Completed test suite (00:19:39) 09:26:24 INFO - javascript benchmark 09:26:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3286.2113092857708, 3286.342731453709, 3294.3576002679474, 3318.900432987008, 3352.580927384077, 5603.495685388314, 5620.606557540974, 5636.4927156555905, 5639.351474580424, 5652.236948012017, 5659.462351076641, 5705.087186050222, 5738.483536481715, 5752.511036561887, 5753.971230143843, 5199.610029247802, 5216.8174113906025, 5236.607254455912, 5239.318888544484, 5297.841064768063, 5137.614678899079, 5138.6146039047035, 5269.394019687727, 5291.100512912814, 5324.227986941891, 5185.144451165572, 5200.5059519345605, 5217.139172036609, 5245.10833158364, 5274.604404669646, 5237.947620523803, 5268.446813084609, 5282.947170528284, 5295.947040529603, 5298.708571028592, 5146.459621739701, 5207.869803254911, 5230.843074707765, 5237.580993520509, 5276.4459731728, 5554.888902221974, 5579.581531385163, 5592.273004509429, 5603.831885043455, 5644.435556444364, 6213.906791398133, 6238.376162383771, 6256.436920677115, 6257.530685198628, 6262.530310226751, 5699.658020518741, 6235.064740288947, 6242.313345532033, 6246.406591373812, 6250.6874656267455, 5584.329880414376, 5598.1322894951345, 5656.2929633795775, 5856.853578660525, 5932.881342373172, 6207.96896015517, 6223.471004964538, 6244.250689917239, 6281.089242059876, 6304.211973503312, 6148.077788331697, 6157.876842463125, 6180.721867515973, 6184.8763024739255, 6212.347703491068, 6133.98789199786, 6163.19878415812, 6205.565610407228, 6238.500919926395, 6256.812295631138, 6139.631622102688, 6149.954507733696, 6168.568200226031, 6175.814725558241, 6176.382361763787, 6236.844078897973, 6248.28144763349, 6252.062190671345, 6253.312135665074, 6256.655883926337, 4975.626827987915, 4982.402111746614, 5004.824831130893, 5021.548060674557, 5039.7228152451235, 4388.5830846069575, 4402.097569998143, 4402.163588918095, 4427.75647339393, 4496.3255511673515, 4916.754162291871, 5814.302283725895, 5880.059190529495, 5882.852928676817, 5889.558283128783, 6143.0, 6155.753769849156, 6167.044108163242, 6168.629882207082, 6247.96876015617, 5737.5983681141915, 5754.654720716687, 5804.187413762077, 5834.854128646818, 5866.472017518358, 5270.314859068297, 5311.28297679816, 5419.078756611386, 5422.864428389243, 5429.728513574306, 6115.635867915819, 6212.81361559154, 6246.125542424155, 6255.624662520081, 6268.6552239625435, 6226.5641405101205, 6233.750649974132, 6237.688115594111, 6255.437010669061, 6259.874802504016, 6271.341509141657, 6293.842653933688, 6303.49572034227, 6303.810885673437, 6304.401081897213, 6043.063325184604, 6043.3050199227655, 6066.757329706762, 6068.51451883857, 6156.384361563987, 6166.537509686881, 6169.074638804036, 6169.81490555284, 6182.845428864314, 6191.288001879661, 5920.200772895604, 6052.788152414644, 6068.6358818471035, 6072.210612620331, 6087.117367981529, 5958.6424814511265, 6016.338202797601, 6052.66710330936, 6062.333143354139, 6071.787487438095, 5907.556933229939, 5963.582549221513, 5985.072313791369, 6030.246219222598, 6032.638041717335, 6114.296855861633, 6118.969405152946, 6149.692515374303, 6152.538559607958, 6154.292256390572, 5698.0598201296325, 5808.041673123887, 5969.0, 6000.21997140369, 6013.909791353046], "value": 5690.66853165297, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [486.2099088980408, 487.31532197262834, 496.29278278453194, 505.5929976369024, 538.9893948845914, 30596.54105188421, 40141.59858401415, 42377.364339534855, 42531.14937701244, 44251.0, 43189.7840510797, 43534.564654353526, 43551.56448435515, 43589.12821743571, 43608.78195609018, 8412.579371031454, 8598.269147122503, 9179.816403671939, 9434.386764860297, 9442.961274259826, 11256.943715281412, 11518.136139789507, 11574.016208622277, 11737.002354799852, 11737.765244695102, 11449.25579837312, 11456.369899655516, 11562.248453850514, 11576.974029544837, 11590.188686791886, 11466.484008219608, 11498.885011149865, 11515.481803318871, 11516.596919107875, 11528.596499122574, 11216.2709423888, 11326.490307936163, 11427.600033998853, 11432.885671143265, 11444.027257683107, 40604.59395406038, 40868.79565602153, 40913.0, 40921.1815763686, 40925.59074409248, 3910.6480416762342, 3953.367461206193, 3967.563568007517, 3990.4812374391145, 4015.8393664253394, 29196.854015729998, 29227.853860730775, 30991.0, 30996.53505197424, 31376.843115784275, 3047.344820863525, 3095.195249235215, 3104.099811054791, 3192.393445245396, 3214.586059843058, 385225.0738746288, 454750.0, 455294.0, 456221.0, 457005.0, 61706.0, 61829.690851545456, 62006.0, 62143.0, 62151.067733984026, 65548.34451655518, 65665.34334656688, 65678.34321656723, 65836.34163658398, 65845.0, 16555.17224138788, 16616.418425355296, 16814.57963550921, 16818.411355602497, 16825.0, 11648.068154547616, 12028.63914082579, 12046.819297710541, 12908.096433249582, 12987.155834870704, 19117.216331790853, 21327.46681332979, 22122.778772212394, 22706.0, 22732.65901011486, 8445.282151017233, 8624.266937310273, 8704.695335663222, 8714.738557843275, 8734.56327183651, 865.2904618213131, 870.8693695945659, 876.3602570123845, 887.2680038967877, 913.7715571107224, 30910.69089309078, 30982.22544436362, 31083.0, 31286.374272514422, 31682.683173168436, 1070.4166229404993, 1078.827387617993, 1085.2837127495973, 1096.7861267053008, 1210.4734440518403, 13906.791398129037, 15897.841021589868, 15969.201539922957, 16131.032138071754, 16191.204321385627, 612669.0, 613790.0, 618549.0, 619643.0, 620220.0, 50739.0, 54765.63085922884, 58350.7082464585, 61129.08306375408, 61959.69020154871, 1437.0443654969329, 1448.9565313040625, 1475.5425817996456, 1481.4962912609765, 1482.1922052481423, 27993.44013119767, 30104.0, 30224.24439388945, 30703.925362613096, 30965.0, 50420.0, 50740.49259507358, 50849.49150508447, 50865.98268034545, 50904.74547627238, 517962.0, 519346.0, 521184.0, 521358.0, 522185.5016524342, 35104.0, 43772.0, 44250.33624495571, 45325.546744532134, 45406.77296613496, 39414.0, 47595.28607070966, 47908.04183916372, 48105.75947120242, 49261.0, 29133.56299655549, 35852.28295434129, 37237.95191264506, 39302.6069739299, 40730.0, 38790.80604596959, 38911.832645020695, 40119.79940100398, 40268.79865600653, 40588.594114058484, 35928.64071359357, 36659.26681466409, 36738.89783306505, 37964.62035379611, 38080.0, 29014.428324766577, 29523.0, 32293.838530807196, 32799.344013119124, 32962.67037329596, 23895.0, 24240.51518969646, 24551.897873701993, 24616.384590385383, 24691.259262221443], "value": 20695.459566516252, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.2188382512899, 387.113510061958, 389.4528187896006, 399.51059951559336, 423.74575254847093, 14774.755016797422, 14991.850081499182, 17862.374816881413, 20186.59626807463, 20698.0, 20859.478513037182, 21540.784592154072, 21629.45926351842, 21949.122035118577, 22683.886580567076, 5899.852503687399, 6439.903401448982, 6665.833354166136, 6743.561668491532, 6779.7966061018005, 5795.623284486516, 6640.402363787258, 6671.232808227068, 6691.966540167292, 6694.364035416652, 4465.5311192324825, 5208.635395522315, 7684.9615751921165, 7744.341730952876, 7828.295453409192, 7513.2111128331835, 7589.544627322323, 7747.8450430991625, 7762.30139287464, 7815.179406162328, 7558.811029724301, 7561.848763024709, 7563.470557061008, 7563.886541701879, 7575.810604734926, 25289.494210115878, 25616.487670246675, 25648.61527077095, 25856.353591160183, 26300.73699263002, 2925.0895359117812, 2928.809627374214, 2937.2363185571903, 2941.3381989052505, 2953.291210109558, 16303.673926521522, 16853.0, 16916.83083169165, 16971.57571060721, 17852.642947140983, 1990.6317331293612, 2048.467398476392, 2049.9795002050087, 2050.149188086942, 2075.730155079845, 140594.15801057644, 152573.47426525815, 160010.19994900067, 161268.0, 167110.0, 17109.743353849703, 22669.17913319902, 23348.0, 23467.647985280233, 24421.511569768507, 42299.30802767855, 42394.364084538756, 43379.78310108429, 43508.12983740371, 43609.34585981213, 8439.789005274917, 8575.442596231225, 8893.199612034949, 8949.194572488377, 8969.0, 7479.027726395642, 8603.956980215184, 8687.472771198803, 8747.387682862265, 8974.41666291689, 4868.561829435368, 4878.829240976549, 4889.242167464049, 4901.3383193268455, 4961.975190124026, 2000.899955002244, 2033.387097579603, 2048.1602542957316, 2054.3528788431595, 2057.1051592557287, 864.3906046237388, 938.7653086728318, 969.5443141723379, 976.2434113561904, 1011.6863772230632, 20357.389278321672, 21704.891475542838, 21730.0, 21878.0, 22197.778022219893, 973.8880028796638, 984.3601658921758, 994.3089552760762, 999.5207093501658, 1010.3382284603597, 10167.288289819642, 10594.226490046512, 10605.681829545127, 11134.443277836075, 11207.327560346404, 497511.0, 508796.0, 575400.0, 728618.0, 742812.0, 116728.41635791937, 138553.0, 140302.0, 147317.0, 154298.0, 878.7100256915203, 1002.8144793213279, 1060.8992145746142, 1061.1987949098382, 1061.543536279392, 19211.711824322367, 20632.852628899196, 20823.375298741063, 20946.895265523573, 20955.057022434332, 48631.756841216986, 57442.0, 57531.0, 59426.0, 60242.0, 82406.17593823984, 84997.15002849893, 85981.0, 86418.56790716006, 86826.56586717025, 8172.305354044735, 8268.669253230044, 8385.916140838757, 8688.478691278544, 8854.645814167361, 8635.654573816977, 8903.465792052497, 9038.638454461749, 9259.907400926175, 9281.953590232006, 7767.689292428239, 7887.940293437456, 7941.00737407824, 8206.63070161856, 8450.408471406943, 7683.500572462772, 7875.684972601031, 8165.979252593425, 8319.168083191633, 8356.373272004503, 7710.8843367350655, 7902.24928631779, 8212.3430125591, 8241.95879020601, 8693.782655433664, 10368.170546356425, 12135.271883687006, 13153.93423032917, 13232.603021909357, 13583.0, 11482.770344592895, 11667.883321166679, 11737.237079589799, 11823.99496042846, 12090.466075221791], "value": 10595.862946170264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.5888621742806, 1452.6005348529154, 1454.2219912346895, 1473.7199932012916, 1474.2997076388717, 7932.841343173133, 8273.793155171124, 8296.419250652456, 8306.54314012729, 8317.708880189195, 7288.453365997545, 7536.208698086704, 7545.886811697829, 7854.450188486809, 8084.959575202116, 2283.942901427465, 2324.941876453085, 2332.0322066342446, 2332.6617640442128, 2335.1243283768586, 2316.131450705985, 2353.6940197774265, 2355.4464700795384, 2361.055577768898, 2362.350353652742, 2288.8054515366216, 2296.230762694491, 2319.536092781442, 2319.5476882008015, 2320.2807129789735, 1968.3307675390292, 2276.7609401012905, 2289.8969546370454, 2292.461271601189, 2299.3331933739196, 2102.2852230241638, 2206.0, 2276.430892276931, 2289.4505318723554, 2349.7415284318713, 8121.512709237465, 8176.0, 8176.01887773471, 8202.220789025034, 8215.014198296183, 4960.553550180465, 5132.178851383798, 5141.640085194038, 5147.433782283946, 5150.61370397218, 3301.9174520636934, 3458.723302135823, 3490.3193877193958, 3501.859925602973, 3515.2617950230483, 1150.8273758936143, 1173.2198088271289, 1197.700574856286, 1248.7440074784738, 1260.7793636113643, 10463.895361046369, 10552.314099583502, 10590.41752703601, 10611.893881061167, 10625.946870265676, 4400.75795831226, 4590.495045544987, 4677.883052923704, 4698.95301046992, 4701.459332176843, 9221.031791661779, 9221.53892305382, 9240.8613870792, 9251.537423128817, 9254.814903701888, 5156.716380599103, 5160.819371321985, 5164.1995490699, 5169.7932082717025, 5170.1986192140275, 4638.512956139624, 4640.141573808856, 4688.624910007191, 4729.810807567659, 4776.164171270014, 3889.2999260133447, 3930.6855451563806, 3962.900927476836, 4007.218592374459, 4027.489691365738, 1280.0847394113255, 1281.2312612432465, 1281.858995510493, 1297.9870201297865, 1301.5249433956537, 748.745426554963, 783.5964478293683, 887.7824932891483, 897.6140259688266, 902.9864552031725, 5323.760430780624, 5447.408794755829, 5533.557315414757, 5603.243562119062, 5705.429457054344, 977.4135518688872, 980.9901900980899, 1006.8389057750725, 1015.2994433840627, 1026.5175367577226, 3689.5572531296416, 3768.9057773555883, 3769.473363287873, 3784.129650180474, 3913.941290880639, 9496.24030077606, 9794.853077203848, 9806.65676701312, 9834.0, 9837.508124593742, 8824.647014119491, 8988.235999939947, 9557.330986830993, 9804.411735295906, 9808.0, 7667.156612772591, 7818.8827167592535, 7834.843303134019, 7835.490693105044, 7847.372210223169, 5328.227407026037, 5413.9729301353245, 5419.945800541944, 5506.779728810803, 5615.298087739033, 8895.199432051146, 8898.955505222433, 8923.241524470233, 9201.0, 9221.723348299562, 7132.857342853217, 8385.496870187564, 9162.496062716347, 9284.767880803034, 9297.814043719223, 7035.226125126334, 7194.784156475314, 7205.991161237326, 7208.56748595086, 7212.783616491513, 7509.9249007509225, 7624.771256862303, 7700.576468294297, 7715.537067775951, 7730.420218483749, 6971.51199416036, 6972.965135174291, 6985.685644145924, 7010.158780946319, 7092.397146242627, 6865.725370985105, 6905.413039891666, 6952.409045231212, 7002.1947476040905, 7015.158181018311, 6249.7187626557825, 6298.685065746786, 6360.268569114611, 6362.522810789117, 6365.522585806176, 4737.739424331695, 4820.132376172322, 4914.189158788759, 4926.507349265188, 5065.974670126626, 4870.4155501340065, 4931.334269873521, 4953.72754498506, 4973.278874563096, 5006.123928312458], "value": 4380.2610063674365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.7091025333653, 280.65286624203816, 350.83861423745077, 360.42332268370603, 366.19985332049475, 4931.055155875303, 4965.368354771972, 5005.549500544946, 5115.360579927509, 5169.379674439063, 4275.337322714984, 4836.685615434994, 5154.896902061956, 5171.844844654666, 5187.7924883004725, 3326.717229035523, 3908.882733517999, 3951.834208908379, 3967.8809635710977, 3981.6615587674937, 3126.0, 3440.4839274108836, 3892.9221415571815, 3920.313945059603, 3994.981279773668, 3939.487866577341, 3967.8016099194924, 3974.8410063597566, 3998.1603863188766, 4026.2752704513177, 3360.9495857562033, 3456.6197718250974, 3630.5280313559333, 3994.7802870842092, 3996.620321069494, 3241.303119829248, 3340.3152353767664, 3385.851158422666, 3439.0370696205105, 3440.1571614954496, 4777.655641051278, 4905.283150897193, 4991.2263599141825, 5020.723860187688, 5125.051865404912, 3931.4889064421727, 4441.777911104464, 4476.664250181249, 4480.395146655193, 4490.29368839842, 4501.23479008566, 4538.183127037132, 4563.813408513777, 5264.210368444726, 5485.9725701371635, 2978.255436140965, 3397.9296521595866, 3559.199180184464, 3674.9081272968124, 3747.569029561608, 5070.974645126787, 5172.043172013189, 5333.893322133575, 5644.463775941279, 5704.372519022904, 3405.4891766235264, 3558.8967420099852, 3648.7263455240964, 3888.2223555289056, 3900.297946369624, 3439.7420193485086, 3834.7315687902137, 3849.6508038007114, 3884.3979183226643, 3890.7549584132807, 3487.773294735834, 3681.9933136440704, 4279.572042795696, 4391.858116889632, 4427.667924905645, 5420.268263784417, 5429.945700542944, 5433.565314774809, 5449.863753406196, 5547.084731019337, 1101.4492753623188, 1229.9262044277373, 1243.7512497500536, 1244.9564265250672, 1249.28790589365, 721.570665454054, 737.8044818123202, 799.2726618776885, 834.8372067446911, 836.0, 4457.128006237388, 4727.692699974491, 4756.904861902743, 4810.518948105161, 4929.654924155347, 4747.95252047482, 4802.759862006886, 5133.230015497706, 5190.169572868398, 5261.263423120766, 4571.839985600554, 4587.931181032287, 4772.809087636456, 4789.832355867528, 4796.752844260448, 2537.949241015206, 2754.4299749142797, 2755.4489102179646, 2771.7388588192325, 2813.6904940456534, 5023.623228257895, 5087.338645976073, 5451.863703407446, 5457.890842183214, 5604.943950560524, 4971.898183998216, 5050.646454748133, 5066.645334826527, 5405.594580406485, 5480.232482596343, 4732.881677958078, 4873.439554451284, 5157.896842063138, 5241.043012525519, 5372.919406208832, 4635.817866444035, 5081.8475445736685, 5230.22172461365, 5256.342957130359, 5259.55293800016, 4973.602111830973, 5169.983706354449, 5204.115300399017, 5261.842894263411, 5320.627556071038, 4544.386507821402, 5407.026735187704, 5425.872550439796, 5429.104197807317, 5516.310461192351, 3570.1610121621916, 3571.285742851492, 3581.8925432237074, 3611.223586928823, 3622.855085796644, 4896.755162241802, 4997.425296090996, 5112.590992720648, 5190.2229997346885, 5281.366236051698, 5230.424653288212, 5337.919931201112, 5362.444890981572, 5364.578386727442, 5486.561075113901, 4825.855224343275, 5275.762590683506, 5469.781208751764, 5473.397926228032, 5491.835244942658, 4589.511970902206, 5000.549950504472, 5059.293278096201, 5368.0, 5393.514583687487, 4439.733615983051, 4882.36529251195, 5367.543758780391, 5428.592855535771, 5488.807891723771, 4650.418857588436, 5326.9200961984825, 5397.356784170591, 5426.945730542644, 5435.972820135874], "value": 3866.5240949099107, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [698.1970733656292, 719.8740220461418, 765.3953376832303, 810.8986376702912, 820.3847114664001, 14799.038062525942, 15607.921960390182, 15665.921670391632, 15675.529734107995, 15701.84298157018, 14167.574972750808, 14293.49972750954, 14305.92847035766, 14461.20463374514, 14487.927560362183, 663.8207683925338, 686.9828254293658, 832.4173078844802, 846.6232526525667, 851.5657014922373, 829.2246749289403, 860.5869182792263, 863.5164307987516, 864.576357584782, 867.5315329721942, 889.9065598112202, 909.4452384045727, 909.8089401225751, 910.3763921713614, 910.6858133943812, 882.2104216725994, 899.6491368366375, 903.7514683462035, 904.8280826642916, 905.8278927003914, 514.6860415146757, 531.3623651618035, 655.4625207329991, 672.2168673495372, 672.559473544829, 14657.853421465863, 15164.469243576423, 15187.772183417257, 15195.164265965368, 15231.466898658493, 13367.86632133676, 13385.464581416732, 13472.25902575358, 13527.797083043763, 13563.186208827403, 11844.709313572332, 12040.397980101048, 12166.695832604168, 12468.875311246862, 12900.0, 4192.832286708528, 4343.717658352197, 4366.19225443294, 4378.036831896978, 4502.0, 104988.475057625, 115640.42179789131, 116482.0, 116940.0, 117250.0, 10191.286609937233, 10678.412687302272, 10788.0, 11007.944960275147, 11230.775384492264, 21666.458338541663, 21971.121155153614, 22028.229011984502, 22139.55720885573, 22188.445288867584, 7553.1313898901235, 7635.618219089023, 7642.159362470124, 7666.080070391477, 7673.577953212627, 4062.207869465485, 4084.223997440477, 4191.97904010478, 4236.068065025689, 4304.82780688769, 3422.3839708852147, 3532.2582257726167, 3532.434810430319, 3540.539729835105, 3541.858325666996, 622.9595076320024, 634.2072409488139, 645.2192846655505, 653.7646447278976, 659.350539718377, 622.9252489701265, 626.426819460198, 633.7845132654919, 652.709544252803, 677.5223467455432, 8470.49177049379, 10485.213608979357, 10587.523561439753, 10988.780224395467, 11169.553217871195, 550.7383992603561, 572.6228420648347, 579.6290374160541, 580.6342004537115, 721.4012369733109, 4781.091592597395, 4944.728039957837, 4959.900801984012, 4960.528749768766, 4967.652264341461, 100108.0, 102202.46696299562, 102213.0, 102372.48813755883, 106191.0, 88002.0, 89786.10213897777, 89968.99999999869, 90133.54933225292, 91979.0802091984, 62079.68960155261, 79340.01649958681, 79493.0, 80874.59562702148, 81176.0, 9254.074592540961, 9364.250859931326, 9390.765230869283, 9436.245100392089, 9452.338336316392, 40300.99999999883, 49592.256116157565, 49813.75465613389, 50113.74943125261, 51107.488925111764, 56287.592810180075, 60474.395256046875, 66121.67756644936, 66258.0, 67378.32621673917, 9383.343165978316, 11041.613543525938, 11188.272762270752, 11819.763604728028, 11883.16817822744, 11944.343061131722, 12282.14025018276, 12316.630501084981, 12459.111073492719, 12612.369381530703, 11246.325220486797, 11297.604583839526, 11762.58830940913, 12090.0, 12115.333656648969, 11521.53913843437, 11620.0, 11621.709457263298, 11849.585264515701, 12361.320127393079, 12793.552225672056, 13056.543020994599, 13273.084440090004, 14225.14649121056, 14518.419263229353, 10272.794544108927, 10425.704720587992, 10604.363738175734, 10977.560897564008, 11314.377709226072, 9173.633054677739, 11028.393438360967, 11192.65054927638, 11368.204225704121, 11400.201985860911], "value": 7333.357165916202, "unit": "score"}], "name": "dromaeo_css", "value": 7329.234434365203, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 114.0, 115.0, 125.0, 167.0, 151.0, 114.0, 114.0], "value": 124.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 144.0, 111.0, 111.0, 96.0, 119.0, 156.0, 141.0], "value": 123.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 187.0, 190.0, 186.0, 183.0, 185.0, 186.0, 184.0, 186.0], "value": 185.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 58.0, 88.0, 61.0, 59.0, 58.0, 57.0, 75.0, 58.0], "value": 65.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 88.0, 70.0, 68.0, 69.0, 82.0, 68.0, 72.0, 99.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 89.0, 86.0, 89.0, 85.0, 89.0, 88.0, 89.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 96.0, 94.0, 95.0, 94.0, 95.0, 94.0, 93.0], "value": 94.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 85.0, 85.0, 87.0, 88.0, 84.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 54.0, 58.0, 56.0, 56.0, 54.0, 56.0], "value": 54.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 78.0, 80.0, 76.0, 71.0, 70.0, 73.0, 71.0, 71.0, 72.0], "value": 73.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 87.0, 87.0, 82.0, 86.0, 84.0, 82.0, 84.0, 83.0], "value": 84.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 138.0, 137.0, 138.0, 139.0, 142.0, 141.0, 186.0, 154.0], "value": 145.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 167.0, 181.0, 215.0, 159.0, 162.0, 171.0, 167.0, 165.0], "value": 172.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 64.0, 66.0, 65.0, 66.0, 65.0, 63.0, 64.0], "value": 64.9, "unit": "score"}], "name": "kraken", "value": 1439.5000000000002, "alertThreshold": 2.0}]} 09:26:24 INFO - Return code: 0 09:26:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:26:25 ERROR - # TBPL SUCCESS # 09:26:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:26:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:26:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:26:25 INFO - 2017-02-17 09:26:25.031 screenresolution[4064:52544] starting screenresolution argv=screenresolution get 09:26:25 INFO - 2017-02-17 09:26:25.034 screenresolution[4064:52544] Display 0: 1600x1200x32@60 09:26:25 INFO - 2017-02-17 09:26:25.040 screenresolution[4065:52547] starting screenresolution argv=screenresolution list 09:26:25 INFO - Available Modes on Display 0 09:26:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:26:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:26:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:26:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:26:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:26:25 INFO - Intel Iris: 09:26:25 INFO - Chipset Model: Intel Iris 09:26:25 INFO - Type: GPU 09:26:25 INFO - Bus: Built-In 09:26:25 INFO - VRAM (Dynamic, Max): 1536 MB 09:26:25 INFO - Vendor: Intel (0x8086) 09:26:25 INFO - Device ID: 0x0a2e 09:26:25 INFO - Revision ID: 0x0009 09:26:25 INFO - Displays: 09:26:25 INFO - Display: 09:26:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:26:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:26:25 INFO - Display Serial Number: 1600x1200 60 09:26:25 INFO - Main Display: Yes 09:26:25 INFO - Mirror: Off 09:26:25 INFO - Online: Yes 09:26:25 INFO - Rotation: Supported 09:26:25 INFO - Return code: 0 09:26:25 INFO - Running post-action listener: _resource_record_post_action 09:26:25 INFO - [mozharness: 2017-02-17 17:26:25.277986Z] Finished run-tests step (success) 09:26:25 INFO - Running post-run listener: _resource_record_post_run 09:26:25 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 720896; Write bytes: 507195392; Read time: 11; Write time: 1828 09:26:25 INFO - TinderboxPrint: CPU usage
53.7% 09:26:25 INFO - TinderboxPrint: I/O read bytes / time
720,896 / 11 09:26:25 INFO - TinderboxPrint: I/O write bytes / time
507,195,392 / 1,828 09:26:25 INFO - TinderboxPrint: CPU idle
2,224.9 (46.3%) 09:26:25 INFO - TinderboxPrint: CPU system
957.0 (19.9%) 09:26:25 INFO - TinderboxPrint: CPU user
1,619.8 (33.7%) 09:26:25 INFO - TinderboxPrint: Swap in / out
207,757,312 / 0 09:26:25 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205304320; Write bytes: 198926336; Read time: 15740; Write time: 377 09:26:25 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 720896; Write bytes: 297250816; Read time: 11; Write time: 1413 09:26:25 INFO - Running post-run listener: _upload_blobber_files 09:26:25 INFO - Blob upload gear active. 09:26:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:26:25 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:26:26 INFO - (blobuploader) - INFO - Open directory for files ... 09:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:26:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:26 INFO - (blobuploader) - INFO - Done attempting. 09:26:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:26:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:26:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:27 INFO - (blobuploader) - INFO - Done attempting. 09:26:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:26:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:28 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:26:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:28 INFO - (blobuploader) - INFO - Done attempting. 09:26:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:26:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:26:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:26:31 INFO - (blobuploader) - INFO - Done attempting. 09:26:31 INFO - (blobuploader) - INFO - Iteration through files over. 09:26:31 INFO - Return code: 0 09:26:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:26:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:26:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67431ffc913ebbc01e4073c8159498af43f2b55e2d95c00d36e33ac3475eee436b5f1ee63f9782d287c9c2065ec25f16a1d970616801098f2f5ec06e3dca7195", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ff11a305526ce609bf8a77fa299686453c05e593ea5ff83d4453e53b4e509525ca2248aa1dc67cab25f990a788e6cc812a98449a6478d9d61fc1f545ec772d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/307c3a2d453522d080a374290fbfbb9033716db67d45c436ceda69a2d4ac7528ee5d14672d1483281f005c88d1b17390920cfca62d73f2a76925aabe02b70566", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f061389eeaf26691374a24e12c040d205fd7e31020fbf3699759bc4d177c21d0853e4d499d7bc3af2af7e8278dcf7b5f0e8dc5fb5380a3098b80bf2c3d5d91c4"} 09:26:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:26:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:26:31 INFO - Contents: 09:26:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67431ffc913ebbc01e4073c8159498af43f2b55e2d95c00d36e33ac3475eee436b5f1ee63f9782d287c9c2065ec25f16a1d970616801098f2f5ec06e3dca7195", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ff11a305526ce609bf8a77fa299686453c05e593ea5ff83d4453e53b4e509525ca2248aa1dc67cab25f990a788e6cc812a98449a6478d9d61fc1f545ec772d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/307c3a2d453522d080a374290fbfbb9033716db67d45c436ceda69a2d4ac7528ee5d14672d1483281f005c88d1b17390920cfca62d73f2a76925aabe02b70566", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f061389eeaf26691374a24e12c040d205fd7e31020fbf3699759bc4d177c21d0853e4d499d7bc3af2af7e8278dcf7b5f0e8dc5fb5380a3098b80bf2c3d5d91c4"} 09:26:31 INFO - Running post-run listener: copy_logs_to_upload_dir 09:26:31 INFO - Copying logs to upload dir... 09:26:31 INFO - mkdir: /builds/slave/test/build/upload/logs 09:26:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.081539 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-02-17 09:26:31.185439) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 09:26:31.189142) ========= 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.71hEb1gwd1/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.imGMGbHmrt/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67431ffc913ebbc01e4073c8159498af43f2b55e2d95c00d36e33ac3475eee436b5f1ee63f9782d287c9c2065ec25f16a1d970616801098f2f5ec06e3dca7195", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ff11a305526ce609bf8a77fa299686453c05e593ea5ff83d4453e53b4e509525ca2248aa1dc67cab25f990a788e6cc812a98449a6478d9d61fc1f545ec772d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/307c3a2d453522d080a374290fbfbb9033716db67d45c436ceda69a2d4ac7528ee5d14672d1483281f005c88d1b17390920cfca62d73f2a76925aabe02b70566", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f061389eeaf26691374a24e12c040d205fd7e31020fbf3699759bc4d177c21d0853e4d499d7bc3af2af7e8278dcf7b5f0e8dc5fb5380a3098b80bf2c3d5d91c4"} build_url:https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011582 build_url: 'https://queue.taskcluster.net/v1/task/aRFiQWEHSPCKegbgJyYThw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/67431ffc913ebbc01e4073c8159498af43f2b55e2d95c00d36e33ac3475eee436b5f1ee63f9782d287c9c2065ec25f16a1d970616801098f2f5ec06e3dca7195", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/45ff11a305526ce609bf8a77fa299686453c05e593ea5ff83d4453e53b4e509525ca2248aa1dc67cab25f990a788e6cc812a98449a6478d9d61fc1f545ec772d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/307c3a2d453522d080a374290fbfbb9033716db67d45c436ceda69a2d4ac7528ee5d14672d1483281f005c88d1b17390920cfca62d73f2a76925aabe02b70566", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f061389eeaf26691374a24e12c040d205fd7e31020fbf3699759bc4d177c21d0853e4d499d7bc3af2af7e8278dcf7b5f0e8dc5fb5380a3098b80bf2c3d5d91c4"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 09:26:31.225031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:26:31.225426) ========= 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.71hEb1gwd1/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.imGMGbHmrt/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.005333 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:26:31.274482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 09:26:31.274846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 09:26:31.275169) ========= ========= Total master_lag: 0.18 =========